{"level":"warn","ts":"2026-02-10T21:20:53.162591Z","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-10T21:20:53.162685Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-10T21:20:53.164937Z","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-10T21:20:53.164962Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-10T21:20:53.164986Z","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-10T21:20:53.168469Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-02-10T21:20:53.16862Z","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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-10T21:20:53.17522Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.761994ms"} {"level":"info","ts":"2026-02-10T21:20:53.192394Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-02-10T21:20:53.192454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T21:20:53.192474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-02-10T21:20:53.192488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T21:20:53.192495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-02-10T21:20:53.192528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-02-10T21:20:53.204771Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T21:20:53.207596Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T21:20:53.208773Z","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-10T21:20:53.212969Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T21:20:53.214763Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T21:20:53.215031Z","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-10T21:20:53.215116Z","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-10T21:20:53.215184Z","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-10T21:20:53.215508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-02-10T21:20:53.215644Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-10T21:20:53.22838Z","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-10T21:20:53.229083Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-10T21:20:53.229119Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-10T21:20:53.229737Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T21:20:53.229766Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T21:20:53.993738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T21:20:53.99378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T21:20:53.993807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-02-10T21:20:53.993906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-02-10T21:20:53.993912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-10T21:20:53.99392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-02-10T21:20:53.993983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-10T21:20:53.995934Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:20:53.997331Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T21:20:53.997595Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:20:53.997792Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:20:53.997896Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:20:53.997915Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T21:20:53.997993Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T21:20:54.008539Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-02-10T21:20:54.012588Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T21:20:54.012605Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T21:20:54.031444Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T21:20:57.06935Z","caller":"traceutil/trace.go:171","msg":"trace[208116003] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"212.29876ms","start":"2026-02-10T21:20:56.857022Z","end":"2026-02-10T21:20:57.069321Z","steps":["trace[208116003] 'process raft request' (duration: 119.353842ms)","trace[208116003] 'compare' (duration: 92.798659ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:20:57.467882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.137743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:20:57.468Z","caller":"traceutil/trace.go:171","msg":"trace[343766840] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"311.447699ms","start":"2026-02-10T21:20:57.156533Z","end":"2026-02-10T21:20:57.46798Z","steps":["trace[343766840] 'process raft request' (duration: 71.709731ms)","trace[343766840] 'compare' (duration: 239.002614ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:20:57.468055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:20:57.156519Z","time spent":"311.513489ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":732,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T21:20:57.705907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.55869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:20:57.706166Z","caller":"traceutil/trace.go:171","msg":"trace[203627008] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"234.257878ms","start":"2026-02-10T21:20:57.471885Z","end":"2026-02-10T21:20:57.706142Z","steps":["trace[203627008] 'process raft request' (duration: 115.213822ms)","trace[203627008] 'compare' (duration: 118.429731ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:20:58.433051Z","caller":"traceutil/trace.go:171","msg":"trace[1210578895] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"122.834718ms","start":"2026-02-10T21:20:58.310196Z","end":"2026-02-10T21:20:58.433031Z","steps":["trace[1210578895] 'process raft request' (duration: 122.700769ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:04.546468Z","caller":"traceutil/trace.go:171","msg":"trace[1274544950] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"192.20633ms","start":"2026-02-10T21:21:04.354239Z","end":"2026-02-10T21:21:04.546446Z","steps":["trace[1274544950] 'process raft request' (duration: 192.024921ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:04.552842Z","caller":"traceutil/trace.go:171","msg":"trace[980626878] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"154.15363ms","start":"2026-02-10T21:21:04.398659Z","end":"2026-02-10T21:21:04.552813Z","steps":["trace[980626878] 'read index received' (duration: 149.972557ms)","trace[980626878] 'applied index is now lower than readState.Index' (duration: 4.180293ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:04.553028Z","caller":"traceutil/trace.go:171","msg":"trace[1400007012] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"197.062017ms","start":"2026-02-10T21:21:04.35593Z","end":"2026-02-10T21:21:04.552992Z","steps":["trace[1400007012] 'process raft request' (duration: 196.72463ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.553281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.563357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-10T21:21:04.554016Z","caller":"traceutil/trace.go:171","msg":"trace[350758693] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:355; }","duration":"155.41275ms","start":"2026-02-10T21:21:04.398589Z","end":"2026-02-10T21:21:04.554002Z","steps":["trace[350758693] 'agreement among raft nodes before linearized reading' (duration: 154.575996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.554434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.210078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-10T21:21:04.554571Z","caller":"traceutil/trace.go:171","msg":"trace[616609130] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:355; }","duration":"145.361857ms","start":"2026-02-10T21:21:04.40919Z","end":"2026-02-10T21:21:04.554552Z","steps":["trace[616609130] 'agreement among raft nodes before linearized reading' (duration: 145.152738ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.554709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.529345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"} {"level":"info","ts":"2026-02-10T21:21:04.554952Z","caller":"traceutil/trace.go:171","msg":"trace[1063324348] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:355; }","duration":"145.781404ms","start":"2026-02-10T21:21:04.409158Z","end":"2026-02-10T21:21:04.554939Z","steps":["trace[1063324348] 'agreement among raft nodes before linearized reading' (duration: 145.290947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.555217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.481862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-10T21:21:04.555424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.461514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"info","ts":"2026-02-10T21:21:04.555495Z","caller":"traceutil/trace.go:171","msg":"trace[645818511] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:355; }","duration":"147.527223ms","start":"2026-02-10T21:21:04.40794Z","end":"2026-02-10T21:21:04.555468Z","steps":["trace[645818511] 'agreement among raft nodes before linearized reading' (duration: 147.430094ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:04.555263Z","caller":"traceutil/trace.go:171","msg":"trace[1812707654] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:355; }","duration":"106.581221ms","start":"2026-02-10T21:21:04.448671Z","end":"2026-02-10T21:21:04.555252Z","steps":["trace[1812707654] 'agreement among raft nodes before linearized reading' (duration: 106.499881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.555769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.006493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-10T21:21:04.555849Z","caller":"traceutil/trace.go:171","msg":"trace[52997236] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:355; }","duration":"149.086723ms","start":"2026-02-10T21:21:04.406753Z","end":"2026-02-10T21:21:04.55584Z","steps":["trace[52997236] 'agreement among raft nodes before linearized reading' (duration: 148.984723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.555905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.651348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-10T21:21:04.555948Z","caller":"traceutil/trace.go:171","msg":"trace[2083026085] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:355; }","duration":"146.724918ms","start":"2026-02-10T21:21:04.409212Z","end":"2026-02-10T21:21:04.555937Z","steps":["trace[2083026085] 'agreement among raft nodes before linearized reading' (duration: 146.589979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.556176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.949626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4597"} {"level":"info","ts":"2026-02-10T21:21:04.556238Z","caller":"traceutil/trace.go:171","msg":"trace[694815169] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:355; }","duration":"147.043235ms","start":"2026-02-10T21:21:04.409185Z","end":"2026-02-10T21:21:04.556228Z","steps":["trace[694815169] 'agreement among raft nodes before linearized reading' (duration: 146.957066ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:04.984583Z","caller":"traceutil/trace.go:171","msg":"trace[285939587] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"422.118173ms","start":"2026-02-10T21:21:04.562426Z","end":"2026-02-10T21:21:04.984544Z","steps":["trace[285939587] 'process raft request' (duration: 395.062831ms)","trace[285939587] 'compare' (duration: 26.592866ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:04.98485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.562417Z","time spent":"422.226993ms","remote":"127.0.0.1:37784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T21:21:04.985604Z","caller":"traceutil/trace.go:171","msg":"trace[845530384] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:365; }","duration":"419.506699ms","start":"2026-02-10T21:21:04.566084Z","end":"2026-02-10T21:21:04.985591Z","steps":["trace[845530384] 'read index received' (duration: 391.434093ms)","trace[845530384] 'applied index is now lower than readState.Index' (duration: 28.071876ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:04.98597Z","caller":"traceutil/trace.go:171","msg":"trace[1695055988] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"420.075507ms","start":"2026-02-10T21:21:04.565882Z","end":"2026-02-10T21:21:04.985957Z","steps":["trace[1695055988] 'process raft request' (duration: 419.620489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.986037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.56586Z","time spent":"420.147616ms","remote":"127.0.0.1:37720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T21:21:04.986316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.220975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3841"} {"level":"warn","ts":"2026-02-10T21:21:04.986603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.466424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3841"} {"level":"info","ts":"2026-02-10T21:21:04.986645Z","caller":"traceutil/trace.go:171","msg":"trace[21924560] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"420.514363ms","start":"2026-02-10T21:21:04.56612Z","end":"2026-02-10T21:21:04.986634Z","steps":["trace[21924560] 'agreement among raft nodes before linearized reading' (duration: 420.447353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.987844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.566117Z","time spent":"421.693605ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3864,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-10T21:21:04.988592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.450739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-10T21:21:04.99034Z","caller":"traceutil/trace.go:171","msg":"trace[1782086719] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:358; }","duration":"191.242136ms","start":"2026-02-10T21:21:04.799087Z","end":"2026-02-10T21:21:04.990329Z","steps":["trace[1782086719] 'agreement among raft nodes before linearized reading' (duration: 189.439299ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:04.988788Z","caller":"traceutil/trace.go:171","msg":"trace[9035572] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"422.072883ms","start":"2026-02-10T21:21:04.566684Z","end":"2026-02-10T21:21:04.988757Z","steps":["trace[9035572] 'process raft request' (duration: 418.872883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.990653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.566679Z","time spent":"423.897711ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T21:21:04.989177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.335701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3841"} {"level":"info","ts":"2026-02-10T21:21:04.990977Z","caller":"traceutil/trace.go:171","msg":"trace[1685593023] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"424.146489ms","start":"2026-02-10T21:21:04.566821Z","end":"2026-02-10T21:21:04.990967Z","steps":["trace[1685593023] 'agreement among raft nodes before linearized reading' (duration: 422.319682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.991043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.566813Z","time spent":"424.202929ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3864,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-10T21:21:04.989212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.219335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-10T21:21:04.991355Z","caller":"traceutil/trace.go:171","msg":"trace[1201938845] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:358; }","duration":"242.382621ms","start":"2026-02-10T21:21:04.748963Z","end":"2026-02-10T21:21:04.991346Z","steps":["trace[1201938845] 'agreement among raft nodes before linearized reading' (duration: 240.230405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.989239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.314017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-10T21:21:04.99447Z","caller":"traceutil/trace.go:171","msg":"trace[797194797] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:358; }","duration":"295.539233ms","start":"2026-02-10T21:21:04.698921Z","end":"2026-02-10T21:21:04.99446Z","steps":["trace[797194797] 'agreement among raft nodes before linearized reading' (duration: 290.301487ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.989267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.738237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-10T21:21:04.994726Z","caller":"traceutil/trace.go:171","msg":"trace[1092570438] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:358; }","duration":"346.217201ms","start":"2026-02-10T21:21:04.6485Z","end":"2026-02-10T21:21:04.994717Z","steps":["trace[1092570438] 'agreement among raft nodes before linearized reading' (duration: 340.750177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.994797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.648488Z","time spent":"346.299431ms","remote":"127.0.0.1:37720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-02-10T21:21:04.989294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.796289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-10T21:21:04.995069Z","caller":"traceutil/trace.go:171","msg":"trace[2051410332] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:358; }","duration":"396.593351ms","start":"2026-02-10T21:21:04.598467Z","end":"2026-02-10T21:21:04.995061Z","steps":["trace[2051410332] 'agreement among raft nodes before linearized reading' (duration: 390.810769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.995143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.598424Z","time spent":"396.68605ms","remote":"127.0.0.1:37720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-02-10T21:21:04.986361Z","caller":"traceutil/trace.go:171","msg":"trace[2109766943] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"420.282355ms","start":"2026-02-10T21:21:04.566068Z","end":"2026-02-10T21:21:04.986351Z","steps":["trace[2109766943] 'agreement among raft nodes before linearized reading' (duration: 420.149476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.995642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.566063Z","time spent":"429.555824ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3864,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-10T21:21:04.989328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.175836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3841"} {"level":"warn","ts":"2026-02-10T21:21:04.989352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.211266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3841"} {"level":"info","ts":"2026-02-10T21:21:04.995995Z","caller":"traceutil/trace.go:171","msg":"trace[336065815] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"429.856682ms","start":"2026-02-10T21:21:04.566132Z","end":"2026-02-10T21:21:04.995989Z","steps":["trace[336065815] 'agreement among raft nodes before linearized reading' (duration: 423.205206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:04.996091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.56613Z","time spent":"429.950072ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3864,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-10T21:21:04.995922Z","caller":"traceutil/trace.go:171","msg":"trace[298973331] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:358; }","duration":"429.769713ms","start":"2026-02-10T21:21:04.566143Z","end":"2026-02-10T21:21:04.995913Z","steps":["trace[298973331] 'agreement among raft nodes before linearized reading' (duration: 423.169556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:05.001993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:04.566141Z","time spent":"435.844973ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3864,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-10T21:21:05.608207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.844649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:21:05.608267Z","caller":"traceutil/trace.go:171","msg":"trace[877700913] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"411.261373ms","start":"2026-02-10T21:21:05.196996Z","end":"2026-02-10T21:21:05.608257Z","steps":["trace[877700913] 'read index received' (duration: 275.280165ms)","trace[877700913] 'applied index is now lower than readState.Index' (duration: 135.980518ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:05.608442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.389152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:21:05.608542Z","caller":"traceutil/trace.go:171","msg":"trace[1864352553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"411.541911ms","start":"2026-02-10T21:21:05.196982Z","end":"2026-02-10T21:21:05.608524Z","steps":["trace[1864352553] 'agreement among raft nodes before linearized reading' (duration: 411.354532ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:05.608597Z","caller":"traceutil/trace.go:171","msg":"trace[140109758] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"411.838348ms","start":"2026-02-10T21:21:05.19675Z","end":"2026-02-10T21:21:05.608589Z","steps":["trace[140109758] 'process raft request' (duration: 275.479073ms)","trace[140109758] 'compare' (duration: 135.72515ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:05.608637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:05.19674Z","time spent":"411.879458ms","remote":"127.0.0.1:37966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4019,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:21:05.608687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:05.196976Z","time spent":"411.636529ms","remote":"127.0.0.1:37520","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-10T21:21:11.819153Z","caller":"traceutil/trace.go:171","msg":"trace[2018008317] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:431; }","duration":"164.610163ms","start":"2026-02-10T21:21:11.654519Z","end":"2026-02-10T21:21:11.819129Z","steps":["trace[2018008317] 'read index received' (duration: 164.413004ms)","trace[2018008317] 'applied index is now lower than readState.Index' (duration: 196.309µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:11.819332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.791582ms","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-10T21:21:11.819367Z","caller":"traceutil/trace.go:171","msg":"trace[1940719913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"164.898341ms","start":"2026-02-10T21:21:11.654456Z","end":"2026-02-10T21:21:11.819354Z","steps":["trace[1940719913] 'agreement among raft nodes before linearized reading' (duration: 164.759502ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:11.819713Z","caller":"traceutil/trace.go:171","msg":"trace[919072740] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"608.372845ms","start":"2026-02-10T21:21:11.211329Z","end":"2026-02-10T21:21:11.819702Z","steps":["trace[919072740] 'process raft request' (duration: 607.66389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:11.819791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:11.211315Z","time spent":"608.424615ms","remote":"127.0.0.1:37704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4053,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:21:31.327047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.765067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:21:31.327118Z","caller":"traceutil/trace.go:171","msg":"trace[2126013847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"115.866556ms","start":"2026-02-10T21:21:31.211235Z","end":"2026-02-10T21:21:31.327101Z","steps":["trace[2126013847] 'range keys from in-memory index tree' (duration: 115.537178ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:31.71716Z","caller":"traceutil/trace.go:171","msg":"trace[1375505504] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"379.102149ms","start":"2026-02-10T21:21:31.338041Z","end":"2026-02-10T21:21:31.717143Z","steps":["trace[1375505504] 'process raft request' (duration: 378.988039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:31.717277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:31.338023Z","time spent":"379.187808ms","remote":"127.0.0.1:37704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:21:32.447186Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388285706587318,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T21:21:32.948254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388285706587318,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T21:21:33.208416Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.28608947s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T21:21:33.208839Z","caller":"traceutil/trace.go:171","msg":"trace[2098149484] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"1.262466665s","start":"2026-02-10T21:21:31.946322Z","end":"2026-02-10T21:21:33.208789Z","steps":["trace[2098149484] 'read index received' (duration: 1.262230806s)","trace[2098149484] 'applied index is now lower than readState.Index' (duration: 234.859µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:33.208958Z","caller":"traceutil/trace.go:171","msg":"trace[1564996635] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.286686038s","start":"2026-02-10T21:21:31.922262Z","end":"2026-02-10T21:21:33.208948Z","steps":["trace[1564996635] 'process raft request' (duration: 1.286348878s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:33.209058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:31.922253Z","time spent":"1.286732347s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:21:33.209122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106035493s","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-10T21:21:33.209167Z","caller":"traceutil/trace.go:171","msg":"trace[1622634614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"1.106115111s","start":"2026-02-10T21:21:32.10304Z","end":"2026-02-10T21:21:33.209155Z","steps":["trace[1622634614] 'agreement among raft nodes before linearized reading' (duration: 1.105991382s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:33.20919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:32.103028Z","time spent":"1.106157891s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T21:21:33.209272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.262952073s","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-10T21:21:33.209285Z","caller":"traceutil/trace.go:171","msg":"trace[1795031965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"1.262988723s","start":"2026-02-10T21:21:31.946291Z","end":"2026-02-10T21:21:33.20928Z","steps":["trace[1795031965] 'agreement among raft nodes before linearized reading' (duration: 1.262953123s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:33.209295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:31.946276Z","time spent":"1.263016793s","remote":"127.0.0.1:37774","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-10T21:21:33.209335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.476404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:21:33.209348Z","caller":"traceutil/trace.go:171","msg":"trace[373595685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"997.513704ms","start":"2026-02-10T21:21:32.211831Z","end":"2026-02-10T21:21:33.209344Z","steps":["trace[373595685] 'agreement among raft nodes before linearized reading' (duration: 997.494474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:33.209358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:32.211819Z","time spent":"997.536424ms","remote":"127.0.0.1:37518","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-10T21:21:33.209471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099289979s","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-10T21:21:33.209484Z","caller":"traceutil/trace.go:171","msg":"trace[794821214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"1.099315149s","start":"2026-02-10T21:21:32.110164Z","end":"2026-02-10T21:21:33.209479Z","steps":["trace[794821214] 'agreement among raft nodes before linearized reading' (duration: 1.099278739s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:33.209495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:21:32.110158Z","time spent":"1.099334647s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-10T21:21:35.679052Z","caller":"traceutil/trace.go:171","msg":"trace[1424153028] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"115.358691ms","start":"2026-02-10T21:21:35.563677Z","end":"2026-02-10T21:21:35.679035Z","steps":["trace[1424153028] 'process raft request' (duration: 115.241832ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:35.863413Z","caller":"traceutil/trace.go:171","msg":"trace[54792642] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"107.007124ms","start":"2026-02-10T21:21:35.756385Z","end":"2026-02-10T21:21:35.863392Z","steps":["trace[54792642] 'process raft request' (duration: 102.862346ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.177523Z","caller":"traceutil/trace.go:171","msg":"trace[627683736] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"216.281061ms","start":"2026-02-10T21:21:35.961214Z","end":"2026-02-10T21:21:36.177495Z","steps":["trace[627683736] 'process raft request' (duration: 150.411292ms)","trace[627683736] 'compare' (duration: 65.406962ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:36.177556Z","caller":"traceutil/trace.go:171","msg":"trace[1659838002] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"148.299294ms","start":"2026-02-10T21:21:36.029242Z","end":"2026-02-10T21:21:36.177541Z","steps":["trace[1659838002] 'process raft request' (duration: 148.071495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:36.501038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.531829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:21:36.501109Z","caller":"traceutil/trace.go:171","msg":"trace[516344641] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"236.040139ms","start":"2026-02-10T21:21:36.265051Z","end":"2026-02-10T21:21:36.501092Z","steps":["trace[516344641] 'process raft request' (duration: 98.405721ms)","trace[516344641] 'compare' (duration: 137.476119ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:36.503179Z","caller":"traceutil/trace.go:171","msg":"trace[1952598617] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"182.002869ms","start":"2026-02-10T21:21:36.321154Z","end":"2026-02-10T21:21:36.503157Z","steps":["trace[1952598617] 'read index received' (duration: 42.309481ms)","trace[1952598617] 'applied index is now lower than readState.Index' (duration: 139.692008ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:36.503277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.118818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wvj6t\" ","response":"range_response_count:1 size:17415"} {"level":"info","ts":"2026-02-10T21:21:36.503295Z","caller":"traceutil/trace.go:171","msg":"trace[12043135] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wvj6t; range_end:; response_count:1; response_revision:598; }","duration":"182.163838ms","start":"2026-02-10T21:21:36.321127Z","end":"2026-02-10T21:21:36.503291Z","steps":["trace[12043135] 'agreement among raft nodes before linearized reading' (duration: 182.074429ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.503442Z","caller":"traceutil/trace.go:171","msg":"trace[1065687234] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"236.0893ms","start":"2026-02-10T21:21:36.267348Z","end":"2026-02-10T21:21:36.503437Z","steps":["trace[1065687234] 'process raft request' (duration: 235.598632ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.5035Z","caller":"traceutil/trace.go:171","msg":"trace[1758056776] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"177.516943ms","start":"2026-02-10T21:21:36.325979Z","end":"2026-02-10T21:21:36.503496Z","steps":["trace[1758056776] 'process raft request' (duration: 177.027436ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.503556Z","caller":"traceutil/trace.go:171","msg":"trace[1628548758] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"142.983481ms","start":"2026-02-10T21:21:36.360568Z","end":"2026-02-10T21:21:36.503552Z","steps":["trace[1628548758] 'process raft request' (duration: 142.486104ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.784597Z","caller":"traceutil/trace.go:171","msg":"trace[1195860346] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"237.425983ms","start":"2026-02-10T21:21:36.547153Z","end":"2026-02-10T21:21:36.784579Z","steps":["trace[1195860346] 'process raft request' (duration: 163.708965ms)","trace[1195860346] 'compare' (duration: 73.639429ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:36.854966Z","caller":"traceutil/trace.go:171","msg":"trace[1851381906] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"280.098453ms","start":"2026-02-10T21:21:36.574851Z","end":"2026-02-10T21:21:36.85495Z","steps":["trace[1851381906] 'process raft request' (duration: 280.065433ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.855192Z","caller":"traceutil/trace.go:171","msg":"trace[1863826791] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"284.553219ms","start":"2026-02-10T21:21:36.570633Z","end":"2026-02-10T21:21:36.855187Z","steps":["trace[1863826791] 'process raft request' (duration: 284.190561ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.933362Z","caller":"traceutil/trace.go:171","msg":"trace[570460550] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"146.339343ms","start":"2026-02-10T21:21:36.787Z","end":"2026-02-10T21:21:36.933339Z","steps":["trace[570460550] 'process raft request' (duration: 146.319803ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.933682Z","caller":"traceutil/trace.go:171","msg":"trace[1240960196] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"196.947141ms","start":"2026-02-10T21:21:36.736729Z","end":"2026-02-10T21:21:36.933676Z","steps":["trace[1240960196] 'process raft request' (duration: 196.403594ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:36.933738Z","caller":"traceutil/trace.go:171","msg":"trace[300504835] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"186.720904ms","start":"2026-02-10T21:21:36.747012Z","end":"2026-02-10T21:21:36.933733Z","steps":["trace[300504835] 'process raft request' (duration: 186.285187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:37.433529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.280324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:21:37.43372Z","caller":"traceutil/trace.go:171","msg":"trace[1802141404] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"188.60916ms","start":"2026-02-10T21:21:37.245095Z","end":"2026-02-10T21:21:37.433704Z","steps":["trace[1802141404] 'read index received' (duration: 51.084268ms)","trace[1802141404] 'applied index is now lower than readState.Index' (duration: 137.523962ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:21:37.433785Z","caller":"traceutil/trace.go:171","msg":"trace[440927970] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"193.122237ms","start":"2026-02-10T21:21:37.240654Z","end":"2026-02-10T21:21:37.433776Z","steps":["trace[440927970] 'process raft request' (duration: 192.992638ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:37.433903Z","caller":"traceutil/trace.go:171","msg":"trace[640606733] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"197.871143ms","start":"2026-02-10T21:21:37.235998Z","end":"2026-02-10T21:21:37.433869Z","steps":["trace[640606733] 'process raft request' (duration: 60.169741ms)","trace[640606733] 'compare' (duration: 137.144495ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:21:37.434081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.979428ms","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-10T21:21:37.434112Z","caller":"traceutil/trace.go:171","msg":"trace[625166686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"189.039698ms","start":"2026-02-10T21:21:37.245063Z","end":"2026-02-10T21:21:37.434103Z","steps":["trace[625166686] 'agreement among raft nodes before linearized reading' (duration: 188.919719ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:37.443052Z","caller":"traceutil/trace.go:171","msg":"trace[392886066] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"105.134768ms","start":"2026-02-10T21:21:37.337906Z","end":"2026-02-10T21:21:37.443041Z","steps":["trace[392886066] 'process raft request' (duration: 105.099298ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:37.443288Z","caller":"traceutil/trace.go:171","msg":"trace[494295216] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"107.514027ms","start":"2026-02-10T21:21:37.335767Z","end":"2026-02-10T21:21:37.443281Z","steps":["trace[494295216] 'process raft request' (duration: 107.166729ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:37.443705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.558719ms","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-10T21:21:37.443737Z","caller":"traceutil/trace.go:171","msg":"trace[1393925479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"198.606619ms","start":"2026-02-10T21:21:37.245123Z","end":"2026-02-10T21:21:37.443729Z","steps":["trace[1393925479] 'agreement among raft nodes before linearized reading' (duration: 198.501559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:37.444083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.383772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wvj6t\" ","response":"range_response_count:1 size:17670"} {"level":"info","ts":"2026-02-10T21:21:37.444109Z","caller":"traceutil/trace.go:171","msg":"trace[1698253780] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wvj6t; range_end:; response_count:1; response_revision:621; }","duration":"112.468261ms","start":"2026-02-10T21:21:37.331635Z","end":"2026-02-10T21:21:37.444104Z","steps":["trace[1698253780] 'agreement among raft nodes before linearized reading' (duration: 112.371762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:37.444301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.597771ms","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-10T21:21:37.444325Z","caller":"traceutil/trace.go:171","msg":"trace[2131760754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"180.647431ms","start":"2026-02-10T21:21:37.263672Z","end":"2026-02-10T21:21:37.444319Z","steps":["trace[2131760754] 'agreement among raft nodes before linearized reading' (duration: 180.593202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:21:37.444606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.605714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:21:37.444636Z","caller":"traceutil/trace.go:171","msg":"trace[2073128042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:621; }","duration":"195.633234ms","start":"2026-02-10T21:21:37.248992Z","end":"2026-02-10T21:21:37.444625Z","steps":["trace[2073128042] 'agreement among raft nodes before linearized reading' (duration: 195.567644ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:57.840684Z","caller":"traceutil/trace.go:171","msg":"trace[187851613] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"103.432295ms","start":"2026-02-10T21:21:57.737224Z","end":"2026-02-10T21:21:57.840656Z","steps":["trace[187851613] 'process raft request' (duration: 103.329825ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:21:57.848821Z","caller":"traceutil/trace.go:171","msg":"trace[1927346168] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"107.410295ms","start":"2026-02-10T21:21:57.741247Z","end":"2026-02-10T21:21:57.848657Z","steps":["trace[1927346168] 'process raft request' (duration: 107.311606ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:00.079167Z","caller":"traceutil/trace.go:171","msg":"trace[990690098] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"176.925749ms","start":"2026-02-10T21:21:59.902217Z","end":"2026-02-10T21:22:00.079142Z","steps":["trace[990690098] 'process raft request' (duration: 176.78378ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:00.122696Z","caller":"traceutil/trace.go:171","msg":"trace[1417920696] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"219.313348ms","start":"2026-02-10T21:21:59.903366Z","end":"2026-02-10T21:22:00.122679Z","steps":["trace[1417920696] 'process raft request' (duration: 216.285832ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:11.777072Z","caller":"traceutil/trace.go:171","msg":"trace[1004315015] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:839; }","duration":"131.912889ms","start":"2026-02-10T21:22:11.645136Z","end":"2026-02-10T21:22:11.777049Z","steps":["trace[1004315015] 'read index received' (duration: 131.690109ms)","trace[1004315015] 'applied index is now lower than readState.Index' (duration: 222.06µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:11.77716Z","caller":"traceutil/trace.go:171","msg":"trace[1905983861] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"134.739665ms","start":"2026-02-10T21:22:11.642414Z","end":"2026-02-10T21:22:11.777153Z","steps":["trace[1905983861] 'process raft request' (duration: 134.493187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:11.777359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.262418ms","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-10T21:22:11.777382Z","caller":"traceutil/trace.go:171","msg":"trace[1939753179] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:812; }","duration":"132.314197ms","start":"2026-02-10T21:22:11.64506Z","end":"2026-02-10T21:22:11.777374Z","steps":["trace[1939753179] 'agreement among raft nodes before linearized reading' (duration: 132.199038ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:17.570434Z","caller":"traceutil/trace.go:171","msg":"trace[24078584] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"128.110252ms","start":"2026-02-10T21:22:17.442304Z","end":"2026-02-10T21:22:17.570414Z","steps":["trace[24078584] 'process raft request' (duration: 127.963503ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:40.263783Z","caller":"traceutil/trace.go:171","msg":"trace[2107530735] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"174.23197ms","start":"2026-02-10T21:22:40.089535Z","end":"2026-02-10T21:22:40.263767Z","steps":["trace[2107530735] 'process raft request' (duration: 173.674812ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:49.752191Z","caller":"traceutil/trace.go:171","msg":"trace[1934620825] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"107.495122ms","start":"2026-02-10T21:22:49.644665Z","end":"2026-02-10T21:22:49.75216Z","steps":["trace[1934620825] 'process raft request' (duration: 107.226203ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:50.029948Z","caller":"traceutil/trace.go:171","msg":"trace[1665052786] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"133.095037ms","start":"2026-02-10T21:22:49.896831Z","end":"2026-02-10T21:22:50.029926Z","steps":["trace[1665052786] 'process raft request' (duration: 132.960178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.331346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.791581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-02-10T21:22:50.331491Z","caller":"traceutil/trace.go:171","msg":"trace[94919739] linearizableReadLoop","detail":"{readStateIndex:977; appliedIndex:976; }","duration":"228.551912ms","start":"2026-02-10T21:22:50.102913Z","end":"2026-02-10T21:22:50.331465Z","steps":["trace[94919739] 'read index received' (duration: 24.311042ms)","trace[94919739] 'applied index is now lower than readState.Index' (duration: 204.23899ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:50.331795Z","caller":"traceutil/trace.go:171","msg":"trace[2112166471] transaction","detail":"{read_only:false; number_of_response:1; response_revision:940; }","duration":"298.70041ms","start":"2026-02-10T21:22:50.033081Z","end":"2026-02-10T21:22:50.331781Z","steps":["trace[2112166471] 'process raft request' (duration: 94.157411ms)","trace[2112166471] 'compare' (duration: 202.988225ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:22:50.332214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.305159ms","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-10T21:22:50.332248Z","caller":"traceutil/trace.go:171","msg":"trace[503411190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:940; }","duration":"229.402588ms","start":"2026-02-10T21:22:50.102834Z","end":"2026-02-10T21:22:50.332236Z","steps":["trace[503411190] 'agreement among raft nodes before linearized reading' (duration: 229.197609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.336408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.151135ms","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-10T21:22:50.336443Z","caller":"traceutil/trace.go:171","msg":"trace[847970106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:940; }","duration":"203.213754ms","start":"2026-02-10T21:22:50.133219Z","end":"2026-02-10T21:22:50.336433Z","steps":["trace[847970106] 'agreement among raft nodes before linearized reading' (duration: 203.113635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.336603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.569848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:22:50.336623Z","caller":"traceutil/trace.go:171","msg":"trace[127817483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:940; }","duration":"121.616148ms","start":"2026-02-10T21:22:50.215Z","end":"2026-02-10T21:22:50.336616Z","steps":["trace[127817483] 'agreement among raft nodes before linearized reading' (duration: 121.579268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.337533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.644137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b994b185-3a76-4d7f-909d-e62e92e8adba\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:22:50.337562Z","caller":"traceutil/trace.go:171","msg":"trace[1963240576] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b994b185-3a76-4d7f-909d-e62e92e8adba; range_end:; response_count:0; response_revision:940; }","duration":"191.710727ms","start":"2026-02-10T21:22:50.145843Z","end":"2026-02-10T21:22:50.337554Z","steps":["trace[1963240576] 'agreement among raft nodes before linearized reading' (duration: 191.663567ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.581463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.862915ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:22:50.581706Z","caller":"traceutil/trace.go:171","msg":"trace[480558691] linearizableReadLoop","detail":"{readStateIndex:983; appliedIndex:981; }","duration":"136.498382ms","start":"2026-02-10T21:22:50.445184Z","end":"2026-02-10T21:22:50.581683Z","steps":["trace[480558691] 'read index received' (duration: 20.17528ms)","trace[480558691] 'applied index is now lower than readState.Index' (duration: 116.321632ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:50.581978Z","caller":"traceutil/trace.go:171","msg":"trace[1739401264] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"154.005354ms","start":"2026-02-10T21:22:50.427957Z","end":"2026-02-10T21:22:50.581963Z","steps":["trace[1739401264] 'process raft request' (duration: 37.505032ms)","trace[1739401264] 'compare' (duration: 115.453607ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:50.582198Z","caller":"traceutil/trace.go:171","msg":"trace[1593301716] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"152.349631ms","start":"2026-02-10T21:22:50.429839Z","end":"2026-02-10T21:22:50.582188Z","steps":["trace[1593301716] 'process raft request' (duration: 151.771054ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.583628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.269639ms","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-10T21:22:50.583683Z","caller":"traceutil/trace.go:171","msg":"trace[1400393605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"138.532034ms","start":"2026-02-10T21:22:50.445137Z","end":"2026-02-10T21:22:50.583669Z","steps":["trace[1400393605] 'agreement among raft nodes before linearized reading' (duration: 137.194869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:50.838573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.730169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:22:50.839458Z","caller":"traceutil/trace.go:171","msg":"trace[1355046877] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"247.428847ms","start":"2026-02-10T21:22:50.59201Z","end":"2026-02-10T21:22:50.839438Z","steps":["trace[1355046877] 'process raft request' (duration: 104.745963ms)","trace[1355046877] 'compare' (duration: 141.611889ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:50.83963Z","caller":"traceutil/trace.go:171","msg":"trace[781337005] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"246.501381ms","start":"2026-02-10T21:22:50.593065Z","end":"2026-02-10T21:22:50.839566Z","steps":["trace[781337005] 'process raft request' (duration: 245.881614ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:50.839976Z","caller":"traceutil/trace.go:171","msg":"trace[2017330499] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"245.511376ms","start":"2026-02-10T21:22:50.594451Z","end":"2026-02-10T21:22:50.839963Z","steps":["trace[2017330499] 'process raft request' (duration: 244.55933ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:22:59.133537Z","caller":"traceutil/trace.go:171","msg":"trace[1796100506] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"173.975948ms","start":"2026-02-10T21:22:58.959542Z","end":"2026-02-10T21:22:59.133518Z","steps":["trace[1796100506] 'read index received' (duration: 173.723139ms)","trace[1796100506] 'applied index is now lower than readState.Index' (duration: 251.819µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:22:59.133891Z","caller":"traceutil/trace.go:171","msg":"trace[1259933797] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"182.273881ms","start":"2026-02-10T21:22:58.951604Z","end":"2026-02-10T21:22:59.133878Z","steps":["trace[1259933797] 'process raft request' (duration: 181.717024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:22:59.134679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.082623ms","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-10T21:22:59.134778Z","caller":"traceutil/trace.go:171","msg":"trace[559120639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"175.232861ms","start":"2026-02-10T21:22:58.959527Z","end":"2026-02-10T21:22:59.134759Z","steps":["trace[559120639] 'agreement among raft nodes before linearized reading' (duration: 174.874353ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:00.681052Z","caller":"traceutil/trace.go:171","msg":"trace[1104711435] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1023; }","duration":"189.37194ms","start":"2026-02-10T21:23:00.491663Z","end":"2026-02-10T21:23:00.681035Z","steps":["trace[1104711435] 'read index received' (duration: 189.23543ms)","trace[1104711435] 'applied index is now lower than readState.Index' (duration: 135.87µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:23:00.681209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.527489ms","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-10T21:23:00.681235Z","caller":"traceutil/trace.go:171","msg":"trace[2079794250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"189.594309ms","start":"2026-02-10T21:23:00.491635Z","end":"2026-02-10T21:23:00.681229Z","steps":["trace[2079794250] 'agreement among raft nodes before linearized reading' (duration: 189.467609ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:00.681486Z","caller":"traceutil/trace.go:171","msg":"trace[174477496] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"190.398026ms","start":"2026-02-10T21:23:00.491081Z","end":"2026-02-10T21:23:00.681479Z","steps":["trace[174477496] 'process raft request' (duration: 189.863808ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:02.697061Z","caller":"traceutil/trace.go:171","msg":"trace[289299561] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"223.703138ms","start":"2026-02-10T21:23:02.473348Z","end":"2026-02-10T21:23:02.697051Z","steps":["trace[289299561] 'process raft request' (duration: 223.626138ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:02.712248Z","caller":"traceutil/trace.go:171","msg":"trace[1617782566] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"144.38602ms","start":"2026-02-10T21:23:02.567846Z","end":"2026-02-10T21:23:02.712232Z","steps":["trace[1617782566] 'process raft request' (duration: 144.110911ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:23.223577Z","caller":"traceutil/trace.go:171","msg":"trace[1399340130] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"397.315009ms","start":"2026-02-10T21:23:22.826248Z","end":"2026-02-10T21:23:23.223563Z","steps":["trace[1399340130] 'read index received' (duration: 397.206069ms)","trace[1399340130] 'applied index is now lower than readState.Index' (duration: 108.26µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:23:23.223683Z","caller":"traceutil/trace.go:171","msg":"trace[635247153] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"403.582562ms","start":"2026-02-10T21:23:22.820091Z","end":"2026-02-10T21:23:23.223674Z","steps":["trace[635247153] 'process raft request' (duration: 403.361523ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.223757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.820082Z","time spent":"403.621382ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T21:23:23.223941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.689177ms","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-10T21:23:23.223968Z","caller":"traceutil/trace.go:171","msg":"trace[1871533526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"397.726008ms","start":"2026-02-10T21:23:22.826235Z","end":"2026-02-10T21:23:23.223961Z","steps":["trace[1871533526] 'agreement among raft nodes before linearized reading' (duration: 397.650657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.223985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.826214Z","time spent":"397.767208ms","remote":"127.0.0.1:37774","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-10T21:23:23.224115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.933501ms","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-10T21:23:23.224136Z","caller":"traceutil/trace.go:171","msg":"trace[800186781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1052; }","duration":"396.963591ms","start":"2026-02-10T21:23:22.827168Z","end":"2026-02-10T21:23:23.224131Z","steps":["trace[800186781] 'agreement among raft nodes before linearized reading' (duration: 396.910981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.224153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.827163Z","time spent":"396.986521ms","remote":"127.0.0.1:37774","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-10T21:23:23.224445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.698751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 ","response":"range_response_count:2 size:8877"} {"level":"info","ts":"2026-02-10T21:23:23.224487Z","caller":"traceutil/trace.go:171","msg":"trace[743825793] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:2; response_revision:1052; }","duration":"319.753771ms","start":"2026-02-10T21:23:22.904723Z","end":"2026-02-10T21:23:23.224476Z","steps":["trace[743825793] 'agreement among raft nodes before linearized reading' (duration: 319.601472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.224515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.904717Z","time spent":"319.790411ms","remote":"127.0.0.1:37966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":2,"response size":8900,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-02-10T21:23:23.224689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.667473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-02-10T21:23:23.224724Z","caller":"traceutil/trace.go:171","msg":"trace[1776325730] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1052; }","duration":"328.720672ms","start":"2026-02-10T21:23:22.895993Z","end":"2026-02-10T21:23:23.224714Z","steps":["trace[1776325730] 'agreement among raft nodes before linearized reading' (duration: 328.664562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.224756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.895971Z","time spent":"328.779032ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3040,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-02-10T21:23:23.224954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.56698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-02-10T21:23:23.22499Z","caller":"traceutil/trace.go:171","msg":"trace[148970625] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:1052; }","duration":"349.63626ms","start":"2026-02-10T21:23:22.875345Z","end":"2026-02-10T21:23:23.224982Z","steps":["trace[148970625] 'agreement among raft nodes before linearized reading' (duration: 349.57418ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.225021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.875332Z","time spent":"349.68324ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":635,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-10T21:23:23.225207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.311278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/kube-public/\" range_end:\"/registry/jobs/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:23:23.225355Z","caller":"traceutil/trace.go:171","msg":"trace[593587785] range","detail":"{range_begin:/registry/jobs/kube-public/; range_end:/registry/jobs/kube-public0; response_count:0; response_revision:1052; }","duration":"395.457407ms","start":"2026-02-10T21:23:22.829862Z","end":"2026-02-10T21:23:23.225319Z","steps":["trace[593587785] 'agreement among raft nodes before linearized reading' (duration: 395.293338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.225456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:22.829857Z","time spent":"395.587457ms","remote":"127.0.0.1:37748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/kube-public/\" range_end:\"/registry/jobs/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-02-10T21:23:23.587449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.573606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T21:23:23.588111Z","caller":"traceutil/trace.go:171","msg":"trace[21920088] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"350.609305ms","start":"2026-02-10T21:23:23.237475Z","end":"2026-02-10T21:23:23.588084Z","steps":["trace[21920088] 'process raft request' (duration: 124.303413ms)","trace[21920088] 'compare' (duration: 225.402437ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:23:23.588247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.237459Z","time spent":"350.716966ms","remote":"127.0.0.1:37774","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-10T21:23:23.588574Z","caller":"traceutil/trace.go:171","msg":"trace[2133038667] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"341.312376ms","start":"2026-02-10T21:23:23.247247Z","end":"2026-02-10T21:23:23.588559Z","steps":["trace[2133038667] 'process raft request' (duration: 340.671678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.588638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.247237Z","time spent":"341.370056ms","remote":"127.0.0.1:37774","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-10T21:23:23.588784Z","caller":"traceutil/trace.go:171","msg":"trace[1346964005] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"346.106776ms","start":"2026-02-10T21:23:23.242667Z","end":"2026-02-10T21:23:23.588774Z","steps":["trace[1346964005] 'read index received' (duration: 119.118646ms)","trace[1346964005] 'applied index is now lower than readState.Index' (duration: 226.98684ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:23:23.589111Z","caller":"traceutil/trace.go:171","msg":"trace[1471815224] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"266.077778ms","start":"2026-02-10T21:23:23.322512Z","end":"2026-02-10T21:23:23.588589Z","steps":["trace[1471815224] 'process raft request' (duration: 265.4893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.776211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.128912ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-10T21:23:23.776307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.61894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T21:23:23.77658Z","caller":"traceutil/trace.go:171","msg":"trace[556095297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1055; }","duration":"533.906347ms","start":"2026-02-10T21:23:23.242652Z","end":"2026-02-10T21:23:23.776558Z","steps":["trace[556095297] 'agreement among raft nodes before linearized reading' (duration: 347.08391ms)","trace[556095297] 'range keys from in-memory index tree' (duration: 186.29761ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:23:23.776635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.242644Z","time spent":"533.978367ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T21:23:23.776819Z","caller":"traceutil/trace.go:171","msg":"trace[1507713898] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1099; }","duration":"187.987211ms","start":"2026-02-10T21:23:23.588811Z","end":"2026-02-10T21:23:23.776798Z","steps":["trace[1507713898] 'read index received' (duration: 942.125µs)","trace[1507713898] 'applied index is now lower than readState.Index' (duration: 187.043146ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T21:23:23.777067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.538023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" ","response":"range_response_count:1 size:370"} {"level":"info","ts":"2026-02-10T21:23:23.777114Z","caller":"traceutil/trace.go:171","msg":"trace[690720673] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking; range_end:; response_count:1; response_revision:1055; }","duration":"380.595823ms","start":"2026-02-10T21:23:23.396506Z","end":"2026-02-10T21:23:23.777101Z","steps":["trace[690720673] 'agreement among raft nodes before linearized reading' (duration: 380.466664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.777246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.396495Z","time spent":"380.642363ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":393,"request content":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" "} {"level":"warn","ts":"2026-02-10T21:23:23.777579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.709766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/\" range_end:\"/registry/services/endpoints/kube-system0\" limit:500 ","response":"range_response_count:1 size:760"} {"level":"info","ts":"2026-02-10T21:23:23.777644Z","caller":"traceutil/trace.go:171","msg":"trace[677409942] range","detail":"{range_begin:/registry/services/endpoints/kube-system/; range_end:/registry/services/endpoints/kube-system0; response_count:1; response_revision:1055; }","duration":"377.804665ms","start":"2026-02-10T21:23:23.399829Z","end":"2026-02-10T21:23:23.777633Z","steps":["trace[677409942] 'agreement among raft nodes before linearized reading' (duration: 377.673296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.777778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.399824Z","time spent":"377.842715ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":783,"request content":"key:\"/registry/services/endpoints/kube-system/\" range_end:\"/registry/services/endpoints/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-02-10T21:23:23.778334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.156604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-02-10T21:23:23.778388Z","caller":"traceutil/trace.go:171","msg":"trace[363564160] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1055; }","duration":"421.253534ms","start":"2026-02-10T21:23:23.357123Z","end":"2026-02-10T21:23:23.778376Z","steps":["trace[363564160] 'agreement among raft nodes before linearized reading' (duration: 421.156044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.778424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.357109Z","time spent":"421.306204ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3040,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-02-10T21:23:23.778703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.84146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/kube-public/\" range_end:\"/registry/networkpolicies/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:23:23.778752Z","caller":"traceutil/trace.go:171","msg":"trace[1596146862] range","detail":"{range_begin:/registry/networkpolicies/kube-public/; range_end:/registry/networkpolicies/kube-public0; response_count:0; response_revision:1055; }","duration":"392.91482ms","start":"2026-02-10T21:23:23.385823Z","end":"2026-02-10T21:23:23.778737Z","steps":["trace[1596146862] 'agreement among raft nodes before linearized reading' (duration: 392.84107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.778904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.385795Z","time spent":"393.090799ms","remote":"127.0.0.1:37798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/kube-public/\" range_end:\"/registry/networkpolicies/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-02-10T21:23:23.779574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.915103ms","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-10T21:23:23.779618Z","caller":"traceutil/trace.go:171","msg":"trace[1415207330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1055; }","duration":"516.990573ms","start":"2026-02-10T21:23:23.262617Z","end":"2026-02-10T21:23:23.779608Z","steps":["trace[1415207330] 'agreement among raft nodes before linearized reading' (duration: 516.732024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:23.779732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T21:23:23.262597Z","time spent":"517.045833ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-10T21:23:25.432479Z","caller":"traceutil/trace.go:171","msg":"trace[360989793] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"179.564718ms","start":"2026-02-10T21:23:25.252902Z","end":"2026-02-10T21:23:25.432467Z","steps":["trace[360989793] 'read index received' (duration: 179.418119ms)","trace[360989793] 'applied index is now lower than readState.Index' (duration: 146.059µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:23:25.432541Z","caller":"traceutil/trace.go:171","msg":"trace[346714841] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"197.56956ms","start":"2026-02-10T21:23:25.234966Z","end":"2026-02-10T21:23:25.432535Z","steps":["trace[346714841] 'process raft request' (duration: 197.388831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:25.432701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.791517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-public/\" range_end:\"/registry/statefulsets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T21:23:25.432719Z","caller":"traceutil/trace.go:171","msg":"trace[498176183] range","detail":"{range_begin:/registry/statefulsets/kube-public/; range_end:/registry/statefulsets/kube-public0; response_count:0; response_revision:1058; }","duration":"179.887807ms","start":"2026-02-10T21:23:25.252825Z","end":"2026-02-10T21:23:25.432713Z","steps":["trace[498176183] 'agreement among raft nodes before linearized reading' (duration: 179.842898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:25.432841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.387092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/\" range_end:\"/registry/roles/kube-system0\" limit:500 ","response":"range_response_count:11 size:5916"} {"level":"info","ts":"2026-02-10T21:23:25.432873Z","caller":"traceutil/trace.go:171","msg":"trace[1058795166] range","detail":"{range_begin:/registry/roles/kube-system/; range_end:/registry/roles/kube-system0; response_count:11; response_revision:1058; }","duration":"156.423921ms","start":"2026-02-10T21:23:25.276426Z","end":"2026-02-10T21:23:25.432849Z","steps":["trace[1058795166] 'agreement among raft nodes before linearized reading' (duration: 156.371481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:25.432979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.644438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-dns\" ","response":"range_response_count:1 size:760"} {"level":"info","ts":"2026-02-10T21:23:25.43299Z","caller":"traceutil/trace.go:171","msg":"trace[2112443279] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-dns; range_end:; response_count:1; response_revision:1058; }","duration":"120.668488ms","start":"2026-02-10T21:23:25.312318Z","end":"2026-02-10T21:23:25.432987Z","steps":["trace[2112443279] 'agreement among raft nodes before linearized reading' (duration: 120.624148ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:25.433072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.222389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-02-10T21:23:25.433083Z","caller":"traceutil/trace.go:171","msg":"trace[1796879414] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1058; }","duration":"134.255269ms","start":"2026-02-10T21:23:25.298824Z","end":"2026-02-10T21:23:25.433079Z","steps":["trace[1796879414] 'agreement among raft nodes before linearized reading' (duration: 134.218409ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T21:23:31.802954Z","caller":"traceutil/trace.go:171","msg":"trace[1800741839] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"176.161616ms","start":"2026-02-10T21:23:31.626749Z","end":"2026-02-10T21:23:31.802911Z","steps":["trace[1800741839] 'read index received' (duration: 175.926227ms)","trace[1800741839] 'applied index is now lower than readState.Index' (duration: 232.499µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T21:23:31.803281Z","caller":"traceutil/trace.go:171","msg":"trace[978069730] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"177.489379ms","start":"2026-02-10T21:23:31.625762Z","end":"2026-02-10T21:23:31.803251Z","steps":["trace[978069730] 'process raft request' (duration: 176.984641ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:31.80355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.778443ms","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-10T21:23:31.803732Z","caller":"traceutil/trace.go:171","msg":"trace[1769901682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1076; }","duration":"176.979822ms","start":"2026-02-10T21:23:31.626738Z","end":"2026-02-10T21:23:31.803718Z","steps":["trace[1769901682] 'agreement among raft nodes before linearized reading' (duration: 176.520904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:31.804091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.35255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-02-10T21:23:31.804158Z","caller":"traceutil/trace.go:171","msg":"trace[1615221182] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1076; }","duration":"170.43782ms","start":"2026-02-10T21:23:31.633705Z","end":"2026-02-10T21:23:31.804143Z","steps":["trace[1615221182] 'agreement among raft nodes before linearized reading' (duration: 170.32922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T21:23:31.80516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.938554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-10T21:23:31.805209Z","caller":"traceutil/trace.go:171","msg":"trace[1900769438] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:1076; }","duration":"146.989004ms","start":"2026-02-10T21:23:31.658207Z","end":"2026-02-10T21:23:31.805196Z","steps":["trace[1900769438] 'agreement among raft nodes before linearized reading' (duration: 146.904054ms)"],"step_count":1}