{"level":"warn","ts":"2026-02-11T02:26:58.376533Z","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-11T02:26:58.376624Z","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-11T02:26:58.376717Z","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-11T02:26:58.376727Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-02-11T02:26:58.376756Z","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-11T02:26:58.377372Z","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-11T02:26:58.377452Z","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-11T02:26:58.411258Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"33.564271ms"} {"level":"info","ts":"2026-02-11T02:26:58.460307Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-02-11T02:26:58.460394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T02:26:58.460428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-02-11T02:26:58.460442Z","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-11T02:26:58.460449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-02-11T02:26:58.460477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-02-11T02:26:58.591696Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T02:26:58.615047Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T02:26:58.628591Z","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-11T02:26:58.66378Z","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-11T02:26:58.685653Z","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-11T02:26:58.686091Z","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-11T02:26:58.686256Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T02:26:58.686415Z","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-11T02:26:58.686593Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-11T02:26:58.686647Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-02-11T02:26:58.689421Z","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-11T02:26:58.68951Z","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-11T02:26:58.68954Z","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-11T02:26:58.692692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-02-11T02:26:58.69281Z","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-11T02:26:58.692929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T02:26:58.692982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T02:26:58.693028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-02-11T02:26:58.693105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-02-11T02:26:58.693128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-11T02:26:58.693161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-02-11T02:26:58.693233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-02-11T02:26:58.725143Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:26:58.725533Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:58.72563Z","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-11T02:26:58.727475Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T02:26:58.727546Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-02-11T02:26:58.729322Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T02:26:58.7294Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T02:26:58.740157Z","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-11T02:26:58.74031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:58.740377Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T02:26:58.740612Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-11T02:27:04.571393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.859688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:27:04.571732Z","caller":"traceutil/trace.go:171","msg":"trace[872806538] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"145.76804ms","start":"2026-02-11T02:27:04.425948Z","end":"2026-02-11T02:27:04.571716Z","steps":["trace[872806538] 'process raft request' (duration: 23.238336ms)","trace[872806538] 'compare' (duration: 121.755727ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:04.572199Z","caller":"traceutil/trace.go:171","msg":"trace[1567491976] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"145.414507ms","start":"2026-02-11T02:27:04.426761Z","end":"2026-02-11T02:27:04.572175Z","steps":["trace[1567491976] 'process raft request' (duration: 145.319086ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:06.495504Z","caller":"traceutil/trace.go:171","msg":"trace[1016583441] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"150.559149ms","start":"2026-02-11T02:27:06.344923Z","end":"2026-02-11T02:27:06.495482Z","steps":["trace[1016583441] 'process raft request' (duration: 150.441428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:07.695467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.12264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:07.695544Z","caller":"traceutil/trace.go:171","msg":"trace[1514347534] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:0; response_revision:333; }","duration":"152.237722ms","start":"2026-02-11T02:27:07.543286Z","end":"2026-02-11T02:27:07.695524Z","steps":["trace[1514347534] 'range keys from in-memory index tree' (duration: 152.07186ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:08.111119Z","caller":"traceutil/trace.go:171","msg":"trace[694727] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:346; }","duration":"201.80401ms","start":"2026-02-11T02:27:07.909291Z","end":"2026-02-11T02:27:08.111095Z","steps":["trace[694727] 'read index received' (duration: 179.971614ms)","trace[694727] 'applied index is now lower than readState.Index' (duration: 21.830886ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:08.111301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.986811ms","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-11T02:27:08.111332Z","caller":"traceutil/trace.go:171","msg":"trace[259528497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:335; }","duration":"202.061571ms","start":"2026-02-11T02:27:07.909261Z","end":"2026-02-11T02:27:08.111322Z","steps":["trace[259528497] 'agreement among raft nodes before linearized reading' (duration: 201.918011ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:08.111638Z","caller":"traceutil/trace.go:171","msg":"trace[276887382] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"266.817455ms","start":"2026-02-11T02:27:07.844808Z","end":"2026-02-11T02:27:08.111626Z","steps":["trace[276887382] 'process raft request' (duration: 244.490955ms)","trace[276887382] 'compare' (duration: 21.651444ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:08.554401Z","caller":"traceutil/trace.go:171","msg":"trace[19232392] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"166.281635ms","start":"2026-02-11T02:27:08.388113Z","end":"2026-02-11T02:27:08.554395Z","steps":["trace[19232392] 'process raft request' (duration: 165.985802ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:08.554256Z","caller":"traceutil/trace.go:171","msg":"trace[1317537333] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:354; }","duration":"159.789488ms","start":"2026-02-11T02:27:08.394455Z","end":"2026-02-11T02:27:08.554245Z","steps":["trace[1317537333] 'read index received' (duration: 11.651374ms)","trace[1317537333] 'applied index is now lower than readState.Index' (duration: 148.137544ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:08.554622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.226493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-11T02:27:08.554646Z","caller":"traceutil/trace.go:171","msg":"trace[1379353215] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:343; }","duration":"111.290594ms","start":"2026-02-11T02:27:08.443348Z","end":"2026-02-11T02:27:08.554639Z","steps":["trace[1379353215] 'agreement among raft nodes before linearized reading' (duration: 111.249664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:08.554894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.129711ms","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-11T02:27:08.554913Z","caller":"traceutil/trace.go:171","msg":"trace[86665276] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:343; }","duration":"160.473154ms","start":"2026-02-11T02:27:08.394435Z","end":"2026-02-11T02:27:08.554908Z","steps":["trace[86665276] 'agreement among raft nodes before linearized reading' (duration: 160.13096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:09.123422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.334652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:27:09.123483Z","caller":"traceutil/trace.go:171","msg":"trace[1525650996] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"128.61981ms","start":"2026-02-11T02:27:08.994851Z","end":"2026-02-11T02:27:09.123471Z","steps":["trace[1525650996] 'read index received' (duration: 14.072926ms)","trace[1525650996] 'applied index is now lower than readState.Index' (duration: 114.546134ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:09.123635Z","caller":"traceutil/trace.go:171","msg":"trace[1413015005] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"152.12251ms","start":"2026-02-11T02:27:08.971507Z","end":"2026-02-11T02:27:09.123629Z","steps":["trace[1413015005] 'process raft request' (duration: 37.410824ms)","trace[1413015005] 'compare' (duration: 114.266131ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:09.123739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.885873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-11T02:27:09.123753Z","caller":"traceutil/trace.go:171","msg":"trace[614164826] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:353; }","duration":"128.917893ms","start":"2026-02-11T02:27:08.99483Z","end":"2026-02-11T02:27:09.123747Z","steps":["trace[614164826] 'agreement among raft nodes before linearized reading' (duration: 128.889002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:09.125609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.656898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-02-11T02:27:09.125675Z","caller":"traceutil/trace.go:171","msg":"trace[734418668] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:355; }","duration":"130.734488ms","start":"2026-02-11T02:27:08.994927Z","end":"2026-02-11T02:27:09.125661Z","steps":["trace[734418668] 'agreement among raft nodes before linearized reading' (duration: 130.624117ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:09.126014Z","caller":"traceutil/trace.go:171","msg":"trace[122665263] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"130.966691ms","start":"2026-02-11T02:27:08.995035Z","end":"2026-02-11T02:27:09.126001Z","steps":["trace[122665263] 'process raft request' (duration: 130.371445ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:09.126299Z","caller":"traceutil/trace.go:171","msg":"trace[253566574] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"130.818609ms","start":"2026-02-11T02:27:08.99547Z","end":"2026-02-11T02:27:09.126288Z","steps":["trace[253566574] 'process raft request' (duration: 130.043582ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:13.356078Z","caller":"traceutil/trace.go:171","msg":"trace[2029338673] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"375.486242ms","start":"2026-02-11T02:27:12.980575Z","end":"2026-02-11T02:27:13.356061Z","steps":["trace[2029338673] 'read index received' (duration: 375.35036ms)","trace[2029338673] 'applied index is now lower than readState.Index' (duration: 135.392µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:13.356271Z","caller":"traceutil/trace.go:171","msg":"trace[877237932] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"378.246324ms","start":"2026-02-11T02:27:12.978019Z","end":"2026-02-11T02:27:13.356265Z","steps":["trace[877237932] 'process raft request' (duration: 377.959182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.356336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:12.97801Z","time spent":"378.280656ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:13.35645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.871705ms","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-11T02:27:13.356472Z","caller":"traceutil/trace.go:171","msg":"trace[901039890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:402; }","duration":"375.903415ms","start":"2026-02-11T02:27:12.980562Z","end":"2026-02-11T02:27:13.356465Z","steps":["trace[901039890] 'agreement among raft nodes before linearized reading' (duration: 375.869505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.356486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:12.980557Z","time spent":"375.925935ms","remote":"127.0.0.1:46032","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-11T02:27:13.356562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.184174ms","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-11T02:27:13.356578Z","caller":"traceutil/trace.go:171","msg":"trace[1676550904] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:402; }","duration":"202.225384ms","start":"2026-02-11T02:27:13.154349Z","end":"2026-02-11T02:27:13.356575Z","steps":["trace[1676550904] 'agreement among raft nodes before linearized reading' (duration: 202.194514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.356679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.990609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-11T02:27:13.356697Z","caller":"traceutil/trace.go:171","msg":"trace[1291593981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:402; }","duration":"148.027799ms","start":"2026-02-11T02:27:13.208665Z","end":"2026-02-11T02:27:13.356693Z","steps":["trace[1291593981] 'agreement among raft nodes before linearized reading' (duration: 148.002119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.866987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.174329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T02:27:13.867137Z","caller":"traceutil/trace.go:171","msg":"trace[1002974184] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"507.150567ms","start":"2026-02-11T02:27:13.35994Z","end":"2026-02-11T02:27:13.86709Z","steps":["trace[1002974184] 'process raft request' (duration: 371.626686ms)","trace[1002974184] 'compare' (duration: 135.054608ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:13.867201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:13.359928Z","time spent":"507.244668ms","remote":"127.0.0.1:46032","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-11T02:27:13.902771Z","caller":"traceutil/trace.go:171","msg":"trace[1078477668] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:416; }","duration":"270.47635ms","start":"2026-02-11T02:27:13.632279Z","end":"2026-02-11T02:27:13.902755Z","steps":["trace[1078477668] 'read index received' (duration: 99.401263ms)","trace[1078477668] 'applied index is now lower than readState.Index' (duration: 171.074217ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:13.902871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.596171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:13.9029Z","caller":"traceutil/trace.go:171","msg":"trace[1854520617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:405; }","duration":"270.664591ms","start":"2026-02-11T02:27:13.632227Z","end":"2026-02-11T02:27:13.902891Z","steps":["trace[1854520617] 'agreement among raft nodes before linearized reading' (duration: 270.597961ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:13.903173Z","caller":"traceutil/trace.go:171","msg":"trace[1749192298] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"541.525334ms","start":"2026-02-11T02:27:13.361636Z","end":"2026-02-11T02:27:13.903161Z","steps":["trace[1749192298] 'process raft request' (duration: 540.984919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.903257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:13.361629Z","time spent":"541.590844ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:13.903468Z","caller":"traceutil/trace.go:171","msg":"trace[399150326] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"535.888695ms","start":"2026-02-11T02:27:13.367567Z","end":"2026-02-11T02:27:13.903456Z","steps":["trace[399150326] 'process raft request' (duration: 535.132929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:13.90353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:13.367561Z","time spent":"535.939685ms","remote":"127.0.0.1:45946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T02:27:13.910303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.007474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-11T02:27:13.910477Z","caller":"traceutil/trace.go:171","msg":"trace[977978242] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:405; }","duration":"158.221136ms","start":"2026-02-11T02:27:13.75224Z","end":"2026-02-11T02:27:13.910461Z","steps":["trace[977978242] 'agreement among raft nodes before linearized reading' (duration: 157.976344ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:25.962773Z","caller":"traceutil/trace.go:171","msg":"trace[455051154] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"161.548868ms","start":"2026-02-11T02:27:25.801196Z","end":"2026-02-11T02:27:25.962744Z","steps":["trace[455051154] 'process raft request' (duration: 161.241886ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.179646Z","caller":"traceutil/trace.go:171","msg":"trace[100461291] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"136.925307ms","start":"2026-02-11T02:27:26.042705Z","end":"2026-02-11T02:27:26.17963Z","steps":["trace[100461291] 'process raft request' (duration: 136.905007ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.179888Z","caller":"traceutil/trace.go:171","msg":"trace[1584531927] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"139.353406ms","start":"2026-02-11T02:27:26.04053Z","end":"2026-02-11T02:27:26.179883Z","steps":["trace[1584531927] 'process raft request' (duration: 139.049164ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.180124Z","caller":"traceutil/trace.go:171","msg":"trace[1926517065] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"139.961201ms","start":"2026-02-11T02:27:26.040156Z","end":"2026-02-11T02:27:26.180117Z","steps":["trace[1926517065] 'process raft request' (duration: 96.57009ms)","trace[1926517065] 'compare' (duration: 42.755546ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:26.396018Z","caller":"traceutil/trace.go:171","msg":"trace[1398990775] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"144.414426ms","start":"2026-02-11T02:27:26.251578Z","end":"2026-02-11T02:27:26.395993Z","steps":["trace[1398990775] 'process raft request' (duration: 108.843056ms)","trace[1398990775] 'compare' (duration: 35.029535ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:26.833167Z","caller":"traceutil/trace.go:171","msg":"trace[1921464895] transaction","detail":"{read_only:false; number_of_response:1; response_revision:494; }","duration":"109.674743ms","start":"2026-02-11T02:27:26.723466Z","end":"2026-02-11T02:27:26.833141Z","steps":["trace[1921464895] 'process raft request' (duration: 44.091786ms)","trace[1921464895] 'compare' (duration: 65.471446ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:26.834962Z","caller":"traceutil/trace.go:171","msg":"trace[893541479] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:511; }","duration":"102.357545ms","start":"2026-02-11T02:27:26.732589Z","end":"2026-02-11T02:27:26.834947Z","steps":["trace[893541479] 'read index received' (duration: 34.977924ms)","trace[893541479] 'applied index is now lower than readState.Index' (duration: 67.379131ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:26.835113Z","caller":"traceutil/trace.go:171","msg":"trace[1121733465] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"102.426636ms","start":"2026-02-11T02:27:26.732672Z","end":"2026-02-11T02:27:26.835099Z","steps":["trace[1121733465] 'process raft request' (duration: 102.186124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:26.835453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.843749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329932"} {"level":"info","ts":"2026-02-11T02:27:26.835549Z","caller":"traceutil/trace.go:171","msg":"trace[329610977] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:497; }","duration":"102.965821ms","start":"2026-02-11T02:27:26.732571Z","end":"2026-02-11T02:27:26.835536Z","steps":["trace[329610977] 'agreement among raft nodes before linearized reading' (duration: 102.535267ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.835623Z","caller":"traceutil/trace.go:171","msg":"trace[306055432] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"105.563761ms","start":"2026-02-11T02:27:26.729955Z","end":"2026-02-11T02:27:26.835519Z","steps":["trace[306055432] 'process raft request' (duration: 104.786054ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:26.836023Z","caller":"traceutil/trace.go:171","msg":"trace[1587460094] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"100.029527ms","start":"2026-02-11T02:27:26.735983Z","end":"2026-02-11T02:27:26.836012Z","steps":["trace[1587460094] 'process raft request' (duration: 98.915458ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:32.896366Z","caller":"traceutil/trace.go:171","msg":"trace[852058120] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:556; }","duration":"470.838483ms","start":"2026-02-11T02:27:32.425507Z","end":"2026-02-11T02:27:32.896345Z","steps":["trace[852058120] 'read index received' (duration: 470.694662ms)","trace[852058120] 'applied index is now lower than readState.Index' (duration: 143.191µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:32.896475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.947824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T02:27:32.896506Z","caller":"traceutil/trace.go:171","msg":"trace[491990300] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:538; }","duration":"470.985274ms","start":"2026-02-11T02:27:32.425505Z","end":"2026-02-11T02:27:32.89649Z","steps":["trace[491990300] 'agreement among raft nodes before linearized reading' (duration: 470.911833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:32.896536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:32.4255Z","time spent":"471.030264ms","remote":"127.0.0.1:45808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "} {"level":"info","ts":"2026-02-11T02:27:32.896687Z","caller":"traceutil/trace.go:171","msg":"trace[569463904] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"478.749653ms","start":"2026-02-11T02:27:32.417912Z","end":"2026-02-11T02:27:32.896661Z","steps":["trace[569463904] 'process raft request' (duration: 478.34138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:32.896841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:32.417903Z","time spent":"478.838774ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:33.662532Z","caller":"traceutil/trace.go:171","msg":"trace[1764998685] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"115.90639ms","start":"2026-02-11T02:27:33.54661Z","end":"2026-02-11T02:27:33.662517Z","steps":["trace[1764998685] 'process raft request' (duration: 115.612279ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:34.44867Z","caller":"traceutil/trace.go:171","msg":"trace[1212997664] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"210.820214ms","start":"2026-02-11T02:27:34.237834Z","end":"2026-02-11T02:27:34.448654Z","steps":["trace[1212997664] 'read index received' (duration: 210.715574ms)","trace[1212997664] 'applied index is now lower than readState.Index' (duration: 104.06µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:34.4488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.947795ms","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-11T02:27:34.448816Z","caller":"traceutil/trace.go:171","msg":"trace[375424711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"210.995176ms","start":"2026-02-11T02:27:34.237816Z","end":"2026-02-11T02:27:34.448811Z","steps":["trace[375424711] 'agreement among raft nodes before linearized reading' (duration: 210.894575ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:34.448899Z","caller":"traceutil/trace.go:171","msg":"trace[1794909808] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"219.911053ms","start":"2026-02-11T02:27:34.228971Z","end":"2026-02-11T02:27:34.448882Z","steps":["trace[1794909808] 'process raft request' (duration: 219.592131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:36.383619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.665001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ncq5x\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-11T02:27:36.383693Z","caller":"traceutil/trace.go:171","msg":"trace[500723527] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ncq5x; range_end:; response_count:1; response_revision:548; }","duration":"177.770602ms","start":"2026-02-11T02:27:36.205904Z","end":"2026-02-11T02:27:36.383675Z","steps":["trace[500723527] 'range keys from in-memory index tree' (duration: 177.529601ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:36.813028Z","caller":"traceutil/trace.go:171","msg":"trace[1751526962] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"361.5468ms","start":"2026-02-11T02:27:36.451465Z","end":"2026-02-11T02:27:36.813012Z","steps":["trace[1751526962] 'read index received' (duration: 361.362829ms)","trace[1751526962] 'applied index is now lower than readState.Index' (duration: 183.431µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:36.813102Z","caller":"traceutil/trace.go:171","msg":"trace[1262277023] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"418.186025ms","start":"2026-02-11T02:27:36.394909Z","end":"2026-02-11T02:27:36.813095Z","steps":["trace[1262277023] 'process raft request' (duration: 417.988553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:36.813193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:36.394893Z","time spent":"418.224975ms","remote":"127.0.0.1:45946","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-11T02:27:36.813368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.905593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-11T02:27:36.813398Z","caller":"traceutil/trace.go:171","msg":"trace[395084588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:549; }","duration":"361.950413ms","start":"2026-02-11T02:27:36.451432Z","end":"2026-02-11T02:27:36.813383Z","steps":["trace[395084588] 'agreement among raft nodes before linearized reading' (duration: 361.846192ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:36.813417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:36.451419Z","time spent":"361.993443ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T02:27:36.813501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.500199ms","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-11T02:27:36.813547Z","caller":"traceutil/trace.go:171","msg":"trace[2030672657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"357.60695ms","start":"2026-02-11T02:27:36.455928Z","end":"2026-02-11T02:27:36.813535Z","steps":["trace[2030672657] 'agreement among raft nodes before linearized reading' (duration: 357.489369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:36.813572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:36.455917Z","time spent":"357.64898ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T02:27:37.480388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.384105ms","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-11T02:27:37.480439Z","caller":"traceutil/trace.go:171","msg":"trace[888467001] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"576.515016ms","start":"2026-02-11T02:27:36.903912Z","end":"2026-02-11T02:27:37.480427Z","steps":["trace[888467001] 'range keys from in-memory index tree' (duration: 576.216464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:37.480461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:36.90389Z","time spent":"576.566686ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T02:27:38.130719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388290408095906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-11T02:27:38.555393Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.071816473s","expected-duration":"1s"} {"level":"info","ts":"2026-02-11T02:27:38.555752Z","caller":"traceutil/trace.go:171","msg":"trace[1051815731] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.072233618s","start":"2026-02-11T02:27:37.483499Z","end":"2026-02-11T02:27:38.555732Z","steps":["trace[1051815731] 'process raft request' (duration: 1.072098606s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.555857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:37.483482Z","time spent":"1.072306068s","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:38.562548Z","caller":"traceutil/trace.go:171","msg":"trace[658990505] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"932.173427ms","start":"2026-02-11T02:27:37.630358Z","end":"2026-02-11T02:27:38.562531Z","steps":["trace[658990505] 'read index received' (duration: 925.289691ms)","trace[658990505] 'applied index is now lower than readState.Index' (duration: 6.870756ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:38.562698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.319429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T02:27:38.56272Z","caller":"traceutil/trace.go:171","msg":"trace[1474433719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"932.39465ms","start":"2026-02-11T02:27:37.630319Z","end":"2026-02-11T02:27:38.562713Z","steps":["trace[1474433719] 'agreement among raft nodes before linearized reading' (duration: 932.321099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.562741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:37.630303Z","time spent":"932.43278ms","remote":"127.0.0.1:45794","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-11T02:27:38.562949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.896083ms","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-11T02:27:38.562964Z","caller":"traceutil/trace.go:171","msg":"trace[839885368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"885.936825ms","start":"2026-02-11T02:27:37.677023Z","end":"2026-02-11T02:27:38.56296Z","steps":["trace[839885368] 'agreement among raft nodes before linearized reading' (duration: 885.849524ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:38.562976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:37.677011Z","time spent":"885.962645ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-11T02:27:39.374763Z","caller":"traceutil/trace.go:171","msg":"trace[196863765] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"154.059025ms","start":"2026-02-11T02:27:39.220682Z","end":"2026-02-11T02:27:39.374741Z","steps":["trace[196863765] 'process raft request' (duration: 153.944772ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:39.553681Z","caller":"traceutil/trace.go:171","msg":"trace[1275345305] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"327.690736ms","start":"2026-02-11T02:27:39.225968Z","end":"2026-02-11T02:27:39.553658Z","steps":["trace[1275345305] 'process raft request' (duration: 327.572193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:39.553812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:27:39.225958Z","time spent":"327.788029ms","remote":"127.0.0.1:45946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16901,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:27:41.562052Z","caller":"traceutil/trace.go:171","msg":"trace[84633321] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"112.987027ms","start":"2026-02-11T02:27:41.448562Z","end":"2026-02-11T02:27:41.561549Z","steps":["trace[84633321] 'process raft request' (duration: 112.869953ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.718797Z","caller":"traceutil/trace.go:171","msg":"trace[577480723] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"210.89236ms","start":"2026-02-11T02:27:42.507886Z","end":"2026-02-11T02:27:42.718778Z","steps":["trace[577480723] 'process raft request' (duration: 117.284588ms)","trace[577480723] 'compare' (duration: 93.121699ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:42.718912Z","caller":"traceutil/trace.go:171","msg":"trace[1003949683] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"210.697684ms","start":"2026-02-11T02:27:42.508207Z","end":"2026-02-11T02:27:42.718905Z","steps":["trace[1003949683] 'process raft request' (duration: 210.181101ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.718988Z","caller":"traceutil/trace.go:171","msg":"trace[232761985] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"136.558449ms","start":"2026-02-11T02:27:42.582424Z","end":"2026-02-11T02:27:42.718983Z","steps":["trace[232761985] 'process raft request' (duration: 135.998145ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.719063Z","caller":"traceutil/trace.go:171","msg":"trace[1799285241] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:624; }","duration":"141.931291ms","start":"2026-02-11T02:27:42.577125Z","end":"2026-02-11T02:27:42.719057Z","steps":["trace[1799285241] 'read index received' (duration: 47.996122ms)","trace[1799285241] 'applied index is now lower than readState.Index' (duration: 93.934499ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:27:42.719272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.131757ms","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-11T02:27:42.719295Z","caller":"traceutil/trace.go:171","msg":"trace[165495299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"142.193059ms","start":"2026-02-11T02:27:42.577095Z","end":"2026-02-11T02:27:42.719288Z","steps":["trace[165495299] 'agreement among raft nodes before linearized reading' (duration: 142.102056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:27:42.719437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.773568ms","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-11T02:27:42.719455Z","caller":"traceutil/trace.go:171","msg":"trace[547977630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"135.810339ms","start":"2026-02-11T02:27:42.583639Z","end":"2026-02-11T02:27:42.71945Z","steps":["trace[547977630] 'agreement among raft nodes before linearized reading' (duration: 135.754407ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.90811Z","caller":"traceutil/trace.go:171","msg":"trace[604006947] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"153.257781ms","start":"2026-02-11T02:27:42.754841Z","end":"2026-02-11T02:27:42.908098Z","steps":["trace[604006947] 'process raft request' (duration: 152.852871ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:27:42.907919Z","caller":"traceutil/trace.go:171","msg":"trace[740762859] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"155.322907ms","start":"2026-02-11T02:27:42.752574Z","end":"2026-02-11T02:27:42.907897Z","steps":["trace[740762859] 'process raft request' (duration: 126.927024ms)","trace[740762859] 'compare' (duration: 27.865659ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:27:43.623893Z","caller":"traceutil/trace.go:171","msg":"trace[1729784258] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"154.158173ms","start":"2026-02-11T02:27:43.469719Z","end":"2026-02-11T02:27:43.623877Z","steps":["trace[1729784258] 'process raft request' (duration: 154.04134ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:57.429604Z","caller":"traceutil/trace.go:171","msg":"trace[1965633371] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"111.59031ms","start":"2026-02-11T02:28:57.317988Z","end":"2026-02-11T02:28:57.429578Z","steps":["trace[1965633371] 'process raft request' (duration: 111.258195ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:28:57.624678Z","caller":"traceutil/trace.go:171","msg":"trace[1425940288] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"103.468743ms","start":"2026-02-11T02:28:57.521184Z","end":"2026-02-11T02:28:57.624653Z","steps":["trace[1425940288] 'read index received' (duration: 103.212019ms)","trace[1425940288] 'applied index is now lower than readState.Index' (duration: 255.364µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:28:57.628707Z","caller":"traceutil/trace.go:171","msg":"trace[407560027] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"194.46166ms","start":"2026-02-11T02:28:57.434233Z","end":"2026-02-11T02:28:57.628695Z","steps":["trace[407560027] 'process raft request' (duration: 190.246789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:28:57.629614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.413733ms","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-11T02:28:57.62965Z","caller":"traceutil/trace.go:171","msg":"trace[898145283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:958; }","duration":"108.460954ms","start":"2026-02-11T02:28:57.521179Z","end":"2026-02-11T02:28:57.62964Z","steps":["trace[898145283] 'agreement among raft nodes before linearized reading' (duration: 108.348382ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T02:29:06.067051Z","caller":"traceutil/trace.go:171","msg":"trace[1322980399] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"339.932927ms","start":"2026-02-11T02:29:05.727097Z","end":"2026-02-11T02:29:06.06703Z","steps":["trace[1322980399] 'process raft request' (duration: 339.819806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:06.06719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:29:05.727085Z","time spent":"340.026748ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:29:06.182449Z","caller":"traceutil/trace.go:171","msg":"trace[2137938868] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1028; }","duration":"306.045568ms","start":"2026-02-11T02:29:05.876389Z","end":"2026-02-11T02:29:06.182434Z","steps":["trace[2137938868] 'read index received' (duration: 191.238286ms)","trace[2137938868] 'applied index is now lower than readState.Index' (duration: 114.806632ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:29:06.182552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.15267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:29:06.182583Z","caller":"traceutil/trace.go:171","msg":"trace[1997733423] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:989; }","duration":"306.220951ms","start":"2026-02-11T02:29:05.876352Z","end":"2026-02-11T02:29:06.182573Z","steps":["trace[1997733423] 'agreement among raft nodes before linearized reading' (duration: 306.14626ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:06.182607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:29:05.876338Z","time spent":"306.262232ms","remote":"127.0.0.1:46236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-11T02:29:06.182896Z","caller":"traceutil/trace.go:171","msg":"trace[945076566] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"454.221684ms","start":"2026-02-11T02:29:05.728661Z","end":"2026-02-11T02:29:06.182883Z","steps":["trace[945076566] 'process raft request' (duration: 407.36945ms)","trace[945076566] 'compare' (duration: 46.250785ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T02:29:06.182967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:29:05.728649Z","time spent":"454.277214ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:29:06.183166Z","caller":"traceutil/trace.go:171","msg":"trace[161730829] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"453.871299ms","start":"2026-02-11T02:29:05.729269Z","end":"2026-02-11T02:29:06.183141Z","steps":["trace[161730829] 'process raft request' (duration: 453.106358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:06.183214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:29:05.729261Z","time spent":"453.93049ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T02:29:06.183273Z","caller":"traceutil/trace.go:171","msg":"trace[144038591] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"452.176836ms","start":"2026-02-11T02:29:05.73109Z","end":"2026-02-11T02:29:06.183267Z","steps":["trace[144038591] 'process raft request' (duration: 451.318454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:06.183312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T02:29:05.731082Z","time spent":"452.209116ms","remote":"127.0.0.1:46032","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-11T02:29:07.048984Z","caller":"traceutil/trace.go:171","msg":"trace[1518114925] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1031; }","duration":"170.065116ms","start":"2026-02-11T02:29:06.878896Z","end":"2026-02-11T02:29:07.048961Z","steps":["trace[1518114925] 'read index received' (duration: 169.892613ms)","trace[1518114925] 'applied index is now lower than readState.Index' (duration: 171.663µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T02:29:07.050889Z","caller":"traceutil/trace.go:171","msg":"trace[1534366788] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"205.367963ms","start":"2026-02-11T02:29:06.84388Z","end":"2026-02-11T02:29:07.049248Z","steps":["trace[1534366788] 'process raft request' (duration: 204.963987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:07.053434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.377183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:29:07.053485Z","caller":"traceutil/trace.go:171","msg":"trace[1918215854] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:990; }","duration":"174.628257ms","start":"2026-02-11T02:29:06.878841Z","end":"2026-02-11T02:29:07.05347Z","steps":["trace[1918215854] 'agreement among raft nodes before linearized reading' (duration: 174.319503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T02:29:07.053697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.427617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T02:29:07.053734Z","caller":"traceutil/trace.go:171","msg":"trace[1141805688] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:990; }","duration":"135.542899ms","start":"2026-02-11T02:29:06.918183Z","end":"2026-02-11T02:29:07.053725Z","steps":["trace[1141805688] 'agreement among raft nodes before linearized reading' (duration: 135.486558ms)"],"step_count":1}