{"level":"warn","ts":"2026-02-13T14:17:27.692264Z","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-13T14:17:27.692364Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.36: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.36:2380","--initial-cluster=instance=https://162.253.55.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.36: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-13T14:17:27.692429Z","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-13T14:17:27.692442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-02-13T14:17:27.692466Z","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-13T14:17:27.694603Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"]} {"level":"info","ts":"2026-02-13T14:17:27.694678Z","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.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.36: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-13T14:17:27.701833Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.968598ms"} {"level":"info","ts":"2026-02-13T14:17:27.707272Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb89ec34a9687f0b","cluster-id":"d8e0d5e222e856c9"} {"level":"info","ts":"2026-02-13T14:17:27.707314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T14:17:27.707333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 0"} {"level":"info","ts":"2026-02-13T14:17:27.707341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb89ec34a9687f0b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T14:17:27.707348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 1"} {"level":"info","ts":"2026-02-13T14:17:27.707384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"warn","ts":"2026-02-13T14:17:27.718911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T14:17:27.766491Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T14:17:27.775185Z","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-13T14:17:27.78172Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb89ec34a9687f0b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T14:17:27.784509Z","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-13T14:17:27.784736Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-02-13T14:17:27.784748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-02-13T14:17:27.786722Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb89ec34a9687f0b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T14:17:27.786808Z","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-13T14:17:27.786831Z","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-13T14:17:27.786847Z","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-13T14:17:27.788142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"info","ts":"2026-02-13T14:17:27.788624Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","added-peer-id":"cb89ec34a9687f0b","added-peer-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-02-13T14:17:27.788962Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb89ec34a9687f0b","initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T14:17:27.788986Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T14:17:28.608016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T14:17:28.608054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T14:17:28.608071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgPreVoteResp from cb89ec34a9687f0b at term 1"} {"level":"info","ts":"2026-02-13T14:17:28.608081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became candidate at term 2"} {"level":"info","ts":"2026-02-13T14:17:28.608087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgVoteResp from cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-02-13T14:17:28.608095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became leader at term 2"} {"level":"info","ts":"2026-02-13T14:17:28.608101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb89ec34a9687f0b elected leader cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-02-13T14:17:28.609766Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb89ec34a9687f0b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.36:2379]}","request-path":"/0/members/cb89ec34a9687f0b/attributes","cluster-id":"d8e0d5e222e856c9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T14:17:28.609792Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T14:17:28.610018Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T14:17:28.610077Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T14:17:28.613693Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T14:17:28.613798Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T14:17:28.613835Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T14:17:28.613847Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T14:17:28.617414Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.36:2379"} {"level":"info","ts":"2026-02-13T14:17:28.619073Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T14:17:28.619131Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T14:17:33.750185Z","caller":"traceutil/trace.go:171","msg":"trace[1981017124] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"400.245657ms","start":"2026-02-13T14:17:33.349926Z","end":"2026-02-13T14:17:33.750172Z","steps":["trace[1981017124] 'process raft request' (duration: 367.150663ms)","trace[1981017124] 'compare' (duration: 32.878016ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:17:33.750456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:33.349906Z","time spent":"400.33718ms","remote":"127.0.0.1:44782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":203,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:17:33.750531Z","caller":"traceutil/trace.go:171","msg":"trace[1745380355] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:247; }","duration":"223.053595ms","start":"2026-02-13T14:17:33.527471Z","end":"2026-02-13T14:17:33.750525Z","steps":["trace[1745380355] 'read index received' (duration: 189.613208ms)","trace[1745380355] 'applied index is now lower than readState.Index' (duration: 33.439927ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:17:33.75061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.134218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:17:33.75063Z","caller":"traceutil/trace.go:171","msg":"trace[810620696] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:242; }","duration":"223.18372ms","start":"2026-02-13T14:17:33.527442Z","end":"2026-02-13T14:17:33.750626Z","steps":["trace[810620696] 'agreement among raft nodes before linearized reading' (duration: 223.138358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:33.758999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.32996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:17:33.75903Z","caller":"traceutil/trace.go:171","msg":"trace[431644530] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:245; }","duration":"101.371311ms","start":"2026-02-13T14:17:33.657652Z","end":"2026-02-13T14:17:33.759023Z","steps":["trace[431644530] 'agreement among raft nodes before linearized reading' (duration: 101.296578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:33.759245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.010415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-13T14:17:33.759268Z","caller":"traceutil/trace.go:171","msg":"trace[1073067390] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:245; }","duration":"102.069007ms","start":"2026-02-13T14:17:33.657195Z","end":"2026-02-13T14:17:33.759264Z","steps":["trace[1073067390] 'agreement among raft nodes before linearized reading' (duration: 102.029455ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.359458Z","caller":"traceutil/trace.go:171","msg":"trace[1745058957] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"152.960004ms","start":"2026-02-13T14:17:45.206484Z","end":"2026-02-13T14:17:45.359444Z","steps":["trace[1745058957] 'process raft request' (duration: 152.934063ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.359671Z","caller":"traceutil/trace.go:171","msg":"trace[542977257] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"154.307535ms","start":"2026-02-13T14:17:45.205357Z","end":"2026-02-13T14:17:45.359664Z","steps":["trace[542977257] 'process raft request' (duration: 111.700935ms)","trace[542977257] 'compare' (duration: 42.202565ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:45.359729Z","caller":"traceutil/trace.go:171","msg":"trace[401255345] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"154.320696ms","start":"2026-02-13T14:17:45.205405Z","end":"2026-02-13T14:17:45.359725Z","steps":["trace[401255345] 'process raft request' (duration: 153.971752ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.359816Z","caller":"traceutil/trace.go:171","msg":"trace[352053198] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"153.364929ms","start":"2026-02-13T14:17:45.206447Z","end":"2026-02-13T14:17:45.359812Z","steps":["trace[352053198] 'process raft request' (duration: 152.954893ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.611906Z","caller":"traceutil/trace.go:171","msg":"trace[1628712439] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"152.86683ms","start":"2026-02-13T14:17:45.459018Z","end":"2026-02-13T14:17:45.611885Z","steps":["trace[1628712439] 'process raft request' (duration: 152.824808ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.612125Z","caller":"traceutil/trace.go:171","msg":"trace[88952801] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"171.531305ms","start":"2026-02-13T14:17:45.440581Z","end":"2026-02-13T14:17:45.612112Z","steps":["trace[88952801] 'process raft request' (duration: 100.265207ms)","trace[88952801] 'compare' (duration: 70.611543ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:45.612337Z","caller":"traceutil/trace.go:171","msg":"trace[1798833453] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"165.866858ms","start":"2026-02-13T14:17:45.446461Z","end":"2026-02-13T14:17:45.612328Z","steps":["trace[1798833453] 'process raft request' (duration: 165.267895ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.612442Z","caller":"traceutil/trace.go:171","msg":"trace[1358411064] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"153.445133ms","start":"2026-02-13T14:17:45.458989Z","end":"2026-02-13T14:17:45.612434Z","steps":["trace[1358411064] 'process raft request' (duration: 152.819569ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.867485Z","caller":"traceutil/trace.go:171","msg":"trace[68742221] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"242.290332ms","start":"2026-02-13T14:17:45.625179Z","end":"2026-02-13T14:17:45.867469Z","steps":["trace[68742221] 'process raft request' (duration: 242.25214ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.867973Z","caller":"traceutil/trace.go:171","msg":"trace[1910715273] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"244.983776ms","start":"2026-02-13T14:17:45.622978Z","end":"2026-02-13T14:17:45.867962Z","steps":["trace[1910715273] 'process raft request' (duration: 166.124128ms)","trace[1910715273] 'compare' (duration: 78.214883ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:45.86818Z","caller":"traceutil/trace.go:171","msg":"trace[1637110240] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"245.147562ms","start":"2026-02-13T14:17:45.623024Z","end":"2026-02-13T14:17:45.868172Z","steps":["trace[1637110240] 'process raft request' (duration: 244.374212ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.878204Z","caller":"traceutil/trace.go:171","msg":"trace[963457520] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"197.101283ms","start":"2026-02-13T14:17:45.681086Z","end":"2026-02-13T14:17:45.878187Z","steps":["trace[963457520] 'process raft request' (duration: 196.963968ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.878376Z","caller":"traceutil/trace.go:171","msg":"trace[981974177] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:411; }","duration":"127.354973ms","start":"2026-02-13T14:17:45.750874Z","end":"2026-02-13T14:17:45.878229Z","steps":["trace[981974177] 'read index received' (duration: 38.202222ms)","trace[981974177] 'applied index is now lower than readState.Index' (duration: 89.151981ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:45.878466Z","caller":"traceutil/trace.go:171","msg":"trace[82714411] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"197.312261ms","start":"2026-02-13T14:17:45.681149Z","end":"2026-02-13T14:17:45.878462Z","steps":["trace[82714411] 'process raft request' (duration: 196.997019ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.878446Z","caller":"traceutil/trace.go:171","msg":"trace[1887738287] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"197.28313ms","start":"2026-02-13T14:17:45.681157Z","end":"2026-02-13T14:17:45.87844Z","steps":["trace[1887738287] 'process raft request' (duration: 197.012519ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:45.878769Z","caller":"traceutil/trace.go:171","msg":"trace[455913058] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"195.516472ms","start":"2026-02-13T14:17:45.683247Z","end":"2026-02-13T14:17:45.878764Z","steps":["trace[455913058] 'process raft request' (duration: 194.956231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:45.878862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.988368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:17:45.878896Z","caller":"traceutil/trace.go:171","msg":"trace[1225576983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"128.059851ms","start":"2026-02-13T14:17:45.750829Z","end":"2026-02-13T14:17:45.878889Z","steps":["trace[1225576983] 'agreement among raft nodes before linearized reading' (duration: 128.007989ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:46.081305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.154181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:17:46.081412Z","caller":"traceutil/trace.go:171","msg":"trace[37000049] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"193.449357ms","start":"2026-02-13T14:17:45.887937Z","end":"2026-02-13T14:17:46.081386Z","steps":["trace[37000049] 'process raft request' (duration: 83.916191ms)","trace[37000049] 'compare' (duration: 109.042657ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:46.081931Z","caller":"traceutil/trace.go:171","msg":"trace[93518774] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"188.748177ms","start":"2026-02-13T14:17:45.89317Z","end":"2026-02-13T14:17:46.081918Z","steps":["trace[93518774] 'process raft request' (duration: 188.713656ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:46.082131Z","caller":"traceutil/trace.go:171","msg":"trace[1158056678] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"193.855422ms","start":"2026-02-13T14:17:45.88827Z","end":"2026-02-13T14:17:46.082126Z","steps":["trace[1158056678] 'process raft request' (duration: 193.524989ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:48.56223Z","caller":"traceutil/trace.go:171","msg":"trace[1518976797] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"140.910961ms","start":"2026-02-13T14:17:48.421299Z","end":"2026-02-13T14:17:48.56221Z","steps":["trace[1518976797] 'read index received' (duration: 49.591824ms)","trace[1518976797] 'applied index is now lower than readState.Index' (duration: 91.318207ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:17:48.562442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.072188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:17:48.562478Z","caller":"traceutil/trace.go:171","msg":"trace[1098359348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"141.182232ms","start":"2026-02-13T14:17:48.421286Z","end":"2026-02-13T14:17:48.562468Z","steps":["trace[1098359348] 'agreement among raft nodes before linearized reading' (duration: 141.047487ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:48.562866Z","caller":"traceutil/trace.go:171","msg":"trace[2113531078] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"148.791054ms","start":"2026-02-13T14:17:48.414065Z","end":"2026-02-13T14:17:48.562856Z","steps":["trace[2113531078] 'process raft request' (duration: 56.864834ms)","trace[2113531078] 'compare' (duration: 91.15009ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:17:55.134828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582566599368380,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T14:17:55.164493Z","caller":"traceutil/trace.go:171","msg":"trace[1168637681] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:444; }","duration":"530.302351ms","start":"2026-02-13T14:17:54.634168Z","end":"2026-02-13T14:17:55.16447Z","steps":["trace[1168637681] 'read index received' (duration: 530.150845ms)","trace[1168637681] 'applied index is now lower than readState.Index' (duration: 150.736µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:55.164711Z","caller":"traceutil/trace.go:171","msg":"trace[268523910] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"580.062064ms","start":"2026-02-13T14:17:54.584636Z","end":"2026-02-13T14:17:55.164698Z","steps":["trace[268523910] 'process raft request' (duration: 579.737131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.164855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:54.584626Z","time spent":"580.114786ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T14:17:55.165041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.874134ms","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-13T14:17:55.165082Z","caller":"traceutil/trace.go:171","msg":"trace[339661077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"530.933816ms","start":"2026-02-13T14:17:54.634136Z","end":"2026-02-13T14:17:55.16507Z","steps":["trace[339661077] 'agreement among raft nodes before linearized reading' (duration: 530.865644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.165117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:54.634126Z","time spent":"530.983638ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T14:17:55.165387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.114585ms","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-13T14:17:55.165425Z","caller":"traceutil/trace.go:171","msg":"trace[377369583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"391.202979ms","start":"2026-02-13T14:17:54.774211Z","end":"2026-02-13T14:17:55.165414Z","steps":["trace[377369583] 'agreement among raft nodes before linearized reading' (duration: 391.120755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.165452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:54.774193Z","time spent":"391.25281ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T14:17:55.165679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.38ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-02-13T14:17:55.165713Z","caller":"traceutil/trace.go:171","msg":"trace[364976886] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:429; }","duration":"249.452892ms","start":"2026-02-13T14:17:54.91625Z","end":"2026-02-13T14:17:55.165703Z","steps":["trace[364976886] 'agreement among raft nodes before linearized reading' (duration: 249.385749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.637642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.413741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:17:55.638754Z","caller":"traceutil/trace.go:171","msg":"trace[1749186629] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:445; }","duration":"365.858026ms","start":"2026-02-13T14:17:55.272864Z","end":"2026-02-13T14:17:55.638722Z","steps":["trace[1749186629] 'read index received' (duration: 218.305671ms)","trace[1749186629] 'applied index is now lower than readState.Index' (duration: 147.551525ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:55.639073Z","caller":"traceutil/trace.go:171","msg":"trace[2115536280] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"463.885357ms","start":"2026-02-13T14:17:55.175158Z","end":"2026-02-13T14:17:55.639044Z","steps":["trace[2115536280] 'process raft request' (duration: 316.003069ms)","trace[2115536280] 'compare' (duration: 145.833819ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:17:55.63938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.494141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-02-13T14:17:55.639575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:55.175133Z","time spent":"464.001882ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:17:55.639427Z","caller":"traceutil/trace.go:171","msg":"trace[261306044] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:431; }","duration":"366.558304ms","start":"2026-02-13T14:17:55.272858Z","end":"2026-02-13T14:17:55.639417Z","steps":["trace[261306044] 'agreement among raft nodes before linearized reading' (duration: 366.407778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.639739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:55.272806Z","time spent":"366.918848ms","remote":"127.0.0.1:44660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12693,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-02-13T14:17:55.640122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.23533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:17:55.640162Z","caller":"traceutil/trace.go:171","msg":"trace[152855102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"217.314422ms","start":"2026-02-13T14:17:55.422838Z","end":"2026-02-13T14:17:55.640152Z","steps":["trace[152855102] 'agreement among raft nodes before linearized reading' (duration: 217.228309ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:17:55.640526Z","caller":"traceutil/trace.go:171","msg":"trace[2101508614] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"465.187587ms","start":"2026-02-13T14:17:55.175327Z","end":"2026-02-13T14:17:55.640515Z","steps":["trace[2101508614] 'process raft request' (duration: 463.317915ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:55.642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:17:55.175321Z","time spent":"466.55401ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:17:58.60922Z","caller":"traceutil/trace.go:171","msg":"trace[2140046161] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"200.777912ms","start":"2026-02-13T14:17:58.408238Z","end":"2026-02-13T14:17:58.609016Z","steps":["trace[2140046161] 'read index received' (duration: 200.594485ms)","trace[2140046161] 'applied index is now lower than readState.Index' (duration: 182.577µs)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:17:58.610142Z","caller":"traceutil/trace.go:171","msg":"trace[1384303023] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"214.324047ms","start":"2026-02-13T14:17:58.3958Z","end":"2026-02-13T14:17:58.610124Z","steps":["trace[1384303023] 'process raft request' (duration: 212.960674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:17:58.610242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.983079ms","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-13T14:17:58.611016Z","caller":"traceutil/trace.go:171","msg":"trace[274388612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:470; }","duration":"202.77901ms","start":"2026-02-13T14:17:58.408221Z","end":"2026-02-13T14:17:58.611Z","steps":["trace[274388612] 'agreement among raft nodes before linearized reading' (duration: 201.964549ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:00.807992Z","caller":"traceutil/trace.go:171","msg":"trace[121629114] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"183.863118ms","start":"2026-02-13T14:18:00.624104Z","end":"2026-02-13T14:18:00.807968Z","steps":["trace[121629114] 'process raft request' (duration: 183.704982ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:00.817024Z","caller":"traceutil/trace.go:171","msg":"trace[1525336275] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"138.952794ms","start":"2026-02-13T14:18:00.678052Z","end":"2026-02-13T14:18:00.817005Z","steps":["trace[1525336275] 'process raft request' (duration: 138.867191ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:01.716316Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582566599368505,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T14:18:02.216717Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582566599368505,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T14:18:02.244175Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.365678719s","expected-duration":"1s"} {"level":"info","ts":"2026-02-13T14:18:02.244741Z","caller":"traceutil/trace.go:171","msg":"trace[315413867] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.366295012s","start":"2026-02-13T14:18:00.878424Z","end":"2026-02-13T14:18:02.244719Z","steps":["trace[315413867] 'process raft request' (duration: 1.366072913s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.245124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:00.878406Z","time spent":"1.366566413s","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:18:02.418676Z","caller":"traceutil/trace.go:171","msg":"trace[1098387937] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:516; }","duration":"1.202770375s","start":"2026-02-13T14:18:01.215888Z","end":"2026-02-13T14:18:02.418658Z","steps":["trace[1098387937] 'read index received' (duration: 1.029461678s)","trace[1098387937] 'applied index is now lower than readState.Index' (duration: 173.307777ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:02.419109Z","caller":"traceutil/trace.go:171","msg":"trace[882291613] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"1.416760879s","start":"2026-02-13T14:18:01.002335Z","end":"2026-02-13T14:18:02.419096Z","steps":["trace[882291613] 'process raft request' (duration: 1.415871155s)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:02.419318Z","caller":"traceutil/trace.go:171","msg":"trace[1174550719] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"740.31994ms","start":"2026-02-13T14:18:01.678985Z","end":"2026-02-13T14:18:02.419305Z","steps":["trace[1174550719] 'process raft request' (duration: 739.419905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.419504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.678967Z","time spent":"740.404254ms","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:18:02.419921Z","caller":"traceutil/trace.go:171","msg":"trace[156081760] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.340957214s","start":"2026-02-13T14:18:01.078952Z","end":"2026-02-13T14:18:02.41991Z","steps":["trace[156081760] 'process raft request' (duration: 1.339352932s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.420346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.078933Z","time spent":"1.341025927s","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:18:02.420591Z","caller":"traceutil/trace.go:171","msg":"trace[1527748199] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"1.142488104s","start":"2026-02-13T14:18:01.278091Z","end":"2026-02-13T14:18:02.42058Z","steps":["trace[1527748199] 'process raft request' (duration: 1.140253047s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.420793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.278076Z","time spent":"1.142575068s","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T14:18:02.421007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.002317Z","time spent":"1.416830591s","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:02.421273Z","caller":"traceutil/trace.go:171","msg":"trace[2034349278] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"940.038838ms","start":"2026-02-13T14:18:01.481223Z","end":"2026-02-13T14:18:02.421261Z","steps":["trace[2034349278] 'process raft request' (duration: 937.154756ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:02.421586Z","caller":"traceutil/trace.go:171","msg":"trace[1512425481] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"489.160195ms","start":"2026-02-13T14:18:01.932414Z","end":"2026-02-13T14:18:02.421574Z","steps":["trace[1512425481] 'process raft request' (duration: 486.052044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.421713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.481204Z","time spent":"940.486366ms","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T14:18:02.422229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.932398Z","time spent":"489.229798ms","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:18:02.422376Z","caller":"traceutil/trace.go:171","msg":"trace[1446005038] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"319.628915ms","start":"2026-02-13T14:18:02.102736Z","end":"2026-02-13T14:18:02.422365Z","steps":["trace[1446005038] 'process raft request' (duration: 315.849538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.423183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075403948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:02.423217Z","caller":"traceutil/trace.go:171","msg":"trace[863158156] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:507; }","duration":"1.075437459s","start":"2026-02-13T14:18:01.34777Z","end":"2026-02-13T14:18:02.423208Z","steps":["trace[863158156] 'agreement among raft nodes before linearized reading' (duration: 1.075379097s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.423334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.34775Z","time spent":"1.075573025s","remote":"127.0.0.1:44660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"info","ts":"2026-02-13T14:18:02.423454Z","caller":"traceutil/trace.go:171","msg":"trace[979095667] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"169.79042ms","start":"2026-02-13T14:18:02.253657Z","end":"2026-02-13T14:18:02.423447Z","steps":["trace[979095667] 'process raft request' (duration: 169.451257ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.423692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.344328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-13T14:18:02.42372Z","caller":"traceutil/trace.go:171","msg":"trace[288484262] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:507; }","duration":"147.39401ms","start":"2026-02-13T14:18:02.276319Z","end":"2026-02-13T14:18:02.423713Z","steps":["trace[288484262] 'agreement among raft nodes before linearized reading' (duration: 147.267605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.423844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.486074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T14:18:02.423866Z","caller":"traceutil/trace.go:171","msg":"trace[1577051794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:507; }","duration":"683.528425ms","start":"2026-02-13T14:18:01.740333Z","end":"2026-02-13T14:18:02.423861Z","steps":["trace[1577051794] 'agreement among raft nodes before linearized reading' (duration: 683.454473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.423901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.740323Z","time spent":"683.573217ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T14:18:02.424016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.08293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-13T14:18:02.424038Z","caller":"traceutil/trace.go:171","msg":"trace[1448473148] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:1; response_revision:507; }","duration":"690.132282ms","start":"2026-02-13T14:18:01.733901Z","end":"2026-02-13T14:18:02.424033Z","steps":["trace[1448473148] 'agreement among raft nodes before linearized reading' (duration: 690.093491ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.424056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.733888Z","time spent":"690.163993ms","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.36\" "} {"level":"warn","ts":"2026-02-13T14:18:02.424222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.283396ms","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-13T14:18:02.424247Z","caller":"traceutil/trace.go:171","msg":"trace[531616844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:507; }","duration":"760.343658ms","start":"2026-02-13T14:18:01.663896Z","end":"2026-02-13T14:18:02.42424Z","steps":["trace[531616844] 'agreement among raft nodes before linearized reading' (duration: 760.284916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.424286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.663876Z","time spent":"760.404811ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T14:18:02.424418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.402116ms","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-13T14:18:02.424441Z","caller":"traceutil/trace.go:171","msg":"trace[1478288561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"764.468269ms","start":"2026-02-13T14:18:01.659967Z","end":"2026-02-13T14:18:02.424436Z","steps":["trace[1478288561] 'agreement among raft nodes before linearized reading' (duration: 764.407476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.424481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.659949Z","time spent":"764.52691ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-13T14:18:02.424584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00133209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:02.424605Z","caller":"traceutil/trace.go:171","msg":"trace[1439323151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"1.001394063s","start":"2026-02-13T14:18:01.423206Z","end":"2026-02-13T14:18:02.4246Z","steps":["trace[1439323151] 'agreement among raft nodes before linearized reading' (duration: 1.001360812s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.424621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.423185Z","time spent":"1.001432944s","remote":"127.0.0.1:44562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T14:18:02.425119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.209229076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T14:18:02.425149Z","caller":"traceutil/trace.go:171","msg":"trace[138618619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"1.209283468s","start":"2026-02-13T14:18:01.215859Z","end":"2026-02-13T14:18:02.425143Z","steps":["trace[138618619] 'agreement among raft nodes before linearized reading' (duration: 1.209207135s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:02.425197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:01.215847Z","time spent":"1.209344541s","remote":"127.0.0.1:44844","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-13T14:18:02.425429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:02.102712Z","time spent":"319.934587ms","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T14:18:04.977158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582566599368594,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-13T14:18:05.064124Z","caller":"traceutil/trace.go:171","msg":"trace[488209673] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"629.213237ms","start":"2026-02-13T14:18:04.434895Z","end":"2026-02-13T14:18:05.064109Z","steps":["trace[488209673] 'process raft request' (duration: 629.127954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.064235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.434883Z","time spent":"629.284449ms","remote":"127.0.0.1:44756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4364,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:05.065982Z","caller":"traceutil/trace.go:171","msg":"trace[407362636] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"589.759131ms","start":"2026-02-13T14:18:04.476214Z","end":"2026-02-13T14:18:05.065973Z","steps":["trace[407362636] 'read index received' (duration: 587.869197ms)","trace[407362636] 'applied index is now lower than readState.Index' (duration: 1.889444ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:05.066094Z","caller":"traceutil/trace.go:171","msg":"trace[194722695] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"249.971783ms","start":"2026-02-13T14:18:04.816117Z","end":"2026-02-13T14:18:05.066089Z","steps":["trace[194722695] 'process raft request' (duration: 249.818297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.06625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.033701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-13T14:18:05.066268Z","caller":"traceutil/trace.go:171","msg":"trace[1570994923] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:550; }","duration":"590.073913ms","start":"2026-02-13T14:18:04.476188Z","end":"2026-02-13T14:18:05.066262Z","steps":["trace[1570994923] 'agreement among raft nodes before linearized reading' (duration: 589.973119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.476155Z","time spent":"590.123565ms","remote":"127.0.0.1:44624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188276,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-13T14:18:05.066403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.914317ms","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-13T14:18:05.066416Z","caller":"traceutil/trace.go:171","msg":"trace[1165863782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"579.935718ms","start":"2026-02-13T14:18:04.486476Z","end":"2026-02-13T14:18:05.066412Z","steps":["trace[1165863782] 'agreement among raft nodes before linearized reading' (duration: 579.898606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.486472Z","time spent":"579.953019ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T14:18:05.066541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.049711ms","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-13T14:18:05.066553Z","caller":"traceutil/trace.go:171","msg":"trace[1543085273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"199.093642ms","start":"2026-02-13T14:18:04.867456Z","end":"2026-02-13T14:18:05.066549Z","steps":["trace[1543085273] 'agreement among raft nodes before linearized reading' (duration: 199.055801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.160341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T14:18:05.066623Z","caller":"traceutil/trace.go:171","msg":"trace[1836866110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:550; }","duration":"530.196472ms","start":"2026-02-13T14:18:04.536423Z","end":"2026-02-13T14:18:05.06662Z","steps":["trace[1836866110] 'agreement among raft nodes before linearized reading' (duration: 530.174511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.536418Z","time spent":"530.214752ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T14:18:05.06671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.834308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T14:18:05.066721Z","caller":"traceutil/trace.go:171","msg":"trace[1998196336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"547.85535ms","start":"2026-02-13T14:18:04.518863Z","end":"2026-02-13T14:18:05.066718Z","steps":["trace[1998196336] 'agreement among raft nodes before linearized reading' (duration: 547.822279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.518857Z","time spent":"547.8724ms","remote":"127.0.0.1:44844","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-13T14:18:05.066788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.954445ms","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-13T14:18:05.0668Z","caller":"traceutil/trace.go:171","msg":"trace[674203103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:550; }","duration":"573.980647ms","start":"2026-02-13T14:18:04.492815Z","end":"2026-02-13T14:18:05.066796Z","steps":["trace[674203103] 'agreement among raft nodes before linearized reading' (duration: 573.960016ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:05.066813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:04.49281Z","time spent":"573.999957ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-13T14:18:09.411949Z","caller":"traceutil/trace.go:171","msg":"trace[761296668] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"262.93806ms","start":"2026-02-13T14:18:09.148995Z","end":"2026-02-13T14:18:09.411933Z","steps":["trace[761296668] 'process raft request' (duration: 262.908721ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:09.412141Z","caller":"traceutil/trace.go:171","msg":"trace[1820088079] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"267.010357ms","start":"2026-02-13T14:18:09.145124Z","end":"2026-02-13T14:18:09.412135Z","steps":["trace[1820088079] 'process raft request' (duration: 173.633916ms)","trace[1820088079] 'compare' (duration: 93.032882ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:09.706507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.399159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-13T14:18:09.706563Z","caller":"traceutil/trace.go:171","msg":"trace[1353996959] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:568; }","duration":"152.483849ms","start":"2026-02-13T14:18:09.554068Z","end":"2026-02-13T14:18:09.706552Z","steps":["trace[1353996959] 'range keys from in-memory index tree' (duration: 152.332749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:10.593689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.503492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:18:10.593757Z","caller":"traceutil/trace.go:171","msg":"trace[662195564] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"170.410409ms","start":"2026-02-13T14:18:10.423335Z","end":"2026-02-13T14:18:10.593745Z","steps":["trace[662195564] 'read index received' (duration: 18.727977ms)","trace[662195564] 'applied index is now lower than readState.Index' (duration: 151.681752ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:10.593822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.487369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:10.593839Z","caller":"traceutil/trace.go:171","msg":"trace[1539509643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"170.525559ms","start":"2026-02-13T14:18:10.423309Z","end":"2026-02-13T14:18:10.593834Z","steps":["trace[1539509643] 'agreement among raft nodes before linearized reading' (duration: 170.462529ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:10.594013Z","caller":"traceutil/trace.go:171","msg":"trace[963477619] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"811.380306ms","start":"2026-02-13T14:18:09.782626Z","end":"2026-02-13T14:18:10.594007Z","steps":["trace[963477619] 'process raft request' (duration: 659.513435ms)","trace[963477619] 'compare' (duration: 151.179153ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:10.594047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:09.782611Z","time spent":"811.419366ms","remote":"127.0.0.1:44766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:11.42686Z","caller":"traceutil/trace.go:171","msg":"trace[921192473] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"284.536723ms","start":"2026-02-13T14:18:11.14231Z","end":"2026-02-13T14:18:11.426847Z","steps":["trace[921192473] 'process raft request' (duration: 284.435303ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:11.427005Z","caller":"traceutil/trace.go:171","msg":"trace[357010848] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:590; }","duration":"280.968861ms","start":"2026-02-13T14:18:11.146031Z","end":"2026-02-13T14:18:11.427Z","steps":["trace[357010848] 'read index received' (duration: 280.966621ms)","trace[357010848] 'applied index is now lower than readState.Index' (duration: 1.85µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:11.427114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.107303ms","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-13T14:18:11.427134Z","caller":"traceutil/trace.go:171","msg":"trace[871151931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:571; }","duration":"262.162163ms","start":"2026-02-13T14:18:11.164967Z","end":"2026-02-13T14:18:11.427129Z","steps":["trace[871151931] 'agreement among raft nodes before linearized reading' (duration: 262.066173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:11.427259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.226431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-13T14:18:11.427276Z","caller":"traceutil/trace.go:171","msg":"trace[209101641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:571; }","duration":"281.242981ms","start":"2026-02-13T14:18:11.146029Z","end":"2026-02-13T14:18:11.427272Z","steps":["trace[209101641] 'agreement among raft nodes before linearized reading' (duration: 281.203751ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.235228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9154582566599368677,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T14:18:12.946464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.041467ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:12.946577Z","caller":"traceutil/trace.go:171","msg":"trace[470682311] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:572; }","duration":"664.160877ms","start":"2026-02-13T14:18:12.2824Z","end":"2026-02-13T14:18:12.946561Z","steps":["trace[470682311] 'range keys from in-memory index tree' (duration: 664.029967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.947734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.853074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:18:12.947956Z","caller":"traceutil/trace.go:171","msg":"trace[1859420105] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"183.312656ms","start":"2026-02-13T14:18:12.764631Z","end":"2026-02-13T14:18:12.947943Z","steps":["trace[1859420105] 'process raft request' (duration: 183.269146ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:12.948244Z","caller":"traceutil/trace.go:171","msg":"trace[2062532944] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.516358251s","start":"2026-02-13T14:18:11.431873Z","end":"2026-02-13T14:18:12.948232Z","steps":["trace[2062532944] 'process raft request' (duration: 849.952528ms)","trace[2062532944] 'compare' (duration: 664.552686ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:12.948316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:11.431868Z","time spent":"1.516404151s","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:12.948734Z","caller":"traceutil/trace.go:171","msg":"trace[2044014645] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.51677767s","start":"2026-02-13T14:18:11.431932Z","end":"2026-02-13T14:18:12.948709Z","steps":["trace[2044014645] 'process raft request' (duration: 1.515870052s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.948882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:11.431928Z","time spent":"1.51688665s","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:12.948987Z","caller":"traceutil/trace.go:171","msg":"trace[617403082] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.51702834s","start":"2026-02-13T14:18:11.431953Z","end":"2026-02-13T14:18:12.948982Z","steps":["trace[617403082] 'process raft request' (duration: 1.515901942s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.949016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:11.43195Z","time spent":"1.51705141s","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:12.949052Z","caller":"traceutil/trace.go:171","msg":"trace[975469643] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:591; }","duration":"1.214729557s","start":"2026-02-13T14:18:11.734317Z","end":"2026-02-13T14:18:12.949047Z","steps":["trace[975469643] 'read index received' (duration: 547.497125ms)","trace[975469643] 'applied index is now lower than readState.Index' (duration: 667.231832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:12.949143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214826157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-13T14:18:12.949158Z","caller":"traceutil/trace.go:171","msg":"trace[1797836089] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:1; response_revision:576; }","duration":"1.214863767s","start":"2026-02-13T14:18:11.73429Z","end":"2026-02-13T14:18:12.949154Z","steps":["trace[1797836089] 'agreement among raft nodes before linearized reading' (duration: 1.214814527s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.949173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:11.734278Z","time spent":"1.214890277s","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.36\" "} {"level":"warn","ts":"2026-02-13T14:18:12.949278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.381483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:12.94929Z","caller":"traceutil/trace.go:171","msg":"trace[224652125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"527.419623ms","start":"2026-02-13T14:18:12.421867Z","end":"2026-02-13T14:18:12.949286Z","steps":["trace[224652125] 'agreement among raft nodes before linearized reading' (duration: 527.397423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:12.949301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:12.421853Z","time spent":"527.445773ms","remote":"127.0.0.1:44562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T14:18:15.177386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.40301662s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:18:15.177443Z","caller":"traceutil/trace.go:171","msg":"trace[1851015265] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"1.743500768s","start":"2026-02-13T14:18:13.433934Z","end":"2026-02-13T14:18:15.177435Z","steps":["trace[1851015265] 'read index received' (duration: 340.327729ms)","trace[1851015265] 'applied index is now lower than readState.Index' (duration: 1.403172399s)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:15.177498Z","caller":"traceutil/trace.go:171","msg":"trace[943238853] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"2.174718706s","start":"2026-02-13T14:18:13.002774Z","end":"2026-02-13T14:18:15.177492Z","steps":["trace[943238853] 'process raft request' (duration: 771.550386ms)","trace[943238853] 'compare' (duration: 1.40295586s)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:15.177528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:13.002757Z","time spent":"2.174756566s","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T14:18:15.177647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722188531s","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-13T14:18:15.177688Z","caller":"traceutil/trace.go:171","msg":"trace[562276803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"1.722229891s","start":"2026-02-13T14:18:13.455445Z","end":"2026-02-13T14:18:15.177675Z","steps":["trace[562276803] 'agreement among raft nodes before linearized reading' (duration: 1.722079101s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.177719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.303088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-02-13T14:18:15.177719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:13.455416Z","time spent":"1.722296321s","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-13T14:18:15.177733Z","caller":"traceutil/trace.go:171","msg":"trace[397954798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"220.329538ms","start":"2026-02-13T14:18:14.957399Z","end":"2026-02-13T14:18:15.177729Z","steps":["trace[397954798] 'agreement among raft nodes before linearized reading' (duration: 220.280668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.177811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.743877138s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T14:18:15.177822Z","caller":"traceutil/trace.go:171","msg":"trace[223951113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"1.743911948s","start":"2026-02-13T14:18:13.433907Z","end":"2026-02-13T14:18:15.177819Z","steps":["trace[223951113] 'agreement among raft nodes before linearized reading' (duration: 1.743879028s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.177833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:13.433894Z","time spent":"1.743936368s","remote":"127.0.0.1:44844","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-13T14:18:15.177899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.432998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T14:18:15.17791Z","caller":"traceutil/trace.go:171","msg":"trace[1663535620] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:577; }","duration":"220.452408ms","start":"2026-02-13T14:18:14.957454Z","end":"2026-02-13T14:18:15.177907Z","steps":["trace[1663535620] 'agreement among raft nodes before linearized reading' (duration: 220.420168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.17791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.961947ms","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-13T14:18:15.177939Z","caller":"traceutil/trace.go:171","msg":"trace[566444898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"222.011067ms","start":"2026-02-13T14:18:14.955919Z","end":"2026-02-13T14:18:15.17793Z","steps":["trace[566444898] 'agreement among raft nodes before linearized reading' (duration: 221.933237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.178035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.427822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:15.17806Z","caller":"traceutil/trace.go:171","msg":"trace[1189283819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"758.473422ms","start":"2026-02-13T14:18:14.419578Z","end":"2026-02-13T14:18:15.178052Z","steps":["trace[1189283819] 'agreement among raft nodes before linearized reading' (duration: 758.424182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.178083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:14.419559Z","time spent":"758.518162ms","remote":"127.0.0.1:44562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-13T14:18:15.502376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.970083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:18:15.502456Z","caller":"traceutil/trace.go:171","msg":"trace[1397347812] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"320.831477ms","start":"2026-02-13T14:18:15.181612Z","end":"2026-02-13T14:18:15.502443Z","steps":["trace[1397347812] 'process raft request' (duration: 166.742524ms)","trace[1397347812] 'compare' (duration: 153.886493ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:15.502495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.181602Z","time spent":"320.875697ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:15.596358Z","caller":"traceutil/trace.go:171","msg":"trace[2137953698] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"410.733028ms","start":"2026-02-13T14:18:15.185605Z","end":"2026-02-13T14:18:15.596338Z","steps":["trace[2137953698] 'process raft request' (duration: 410.668338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.067829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-13T14:18:15.596491Z","caller":"traceutil/trace.go:171","msg":"trace[1158574354] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:583; }","duration":"412.100999ms","start":"2026-02-13T14:18:15.184385Z","end":"2026-02-13T14:18:15.596486Z","steps":["trace[1158574354] 'agreement among raft nodes before linearized reading' (duration: 412.023309ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.185598Z","time spent":"410.823278ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T14:18:15.596509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.184382Z","time spent":"412.122599ms","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-13T14:18:15.59665Z","caller":"traceutil/trace.go:171","msg":"trace[1601823185] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"407.729268ms","start":"2026-02-13T14:18:15.188916Z","end":"2026-02-13T14:18:15.596645Z","steps":["trace[1601823185] 'process raft request' (duration: 407.389488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.18891Z","time spent":"407.750088ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:15.596708Z","caller":"traceutil/trace.go:171","msg":"trace[1211421060] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"392.876038ms","start":"2026-02-13T14:18:15.203829Z","end":"2026-02-13T14:18:15.596705Z","steps":["trace[1211421060] 'process raft request' (duration: 392.524628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.203798Z","time spent":"392.918718ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:15.596391Z","caller":"traceutil/trace.go:171","msg":"trace[1754146229] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:597; }","duration":"411.985739ms","start":"2026-02-13T14:18:15.184397Z","end":"2026-02-13T14:18:15.596383Z","steps":["trace[1754146229] 'read index received' (duration: 164.025094ms)","trace[1754146229] 'applied index is now lower than readState.Index' (duration: 247.960165ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:15.596851Z","caller":"traceutil/trace.go:171","msg":"trace[1609748834] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"413.897919ms","start":"2026-02-13T14:18:15.182948Z","end":"2026-02-13T14:18:15.596846Z","steps":["trace[1609748834] 'process raft request' (duration: 413.133339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.182941Z","time spent":"413.921049ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:15.596907Z","caller":"traceutil/trace.go:171","msg":"trace[1881206220] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"412.544629ms","start":"2026-02-13T14:18:15.184359Z","end":"2026-02-13T14:18:15.596904Z","steps":["trace[1881206220] 'process raft request' (duration: 411.870639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:15.596925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:15.184348Z","time spent":"412.566629ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T14:18:15.596961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.631154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:15.596971Z","caller":"traceutil/trace.go:171","msg":"trace[1118422081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"173.662854ms","start":"2026-02-13T14:18:15.423305Z","end":"2026-02-13T14:18:15.596968Z","steps":["trace[1118422081] 'agreement among raft nodes before linearized reading' (duration: 173.646894ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:19.238734Z","caller":"traceutil/trace.go:171","msg":"trace[1284550386] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"105.568305ms","start":"2026-02-13T14:18:19.133143Z","end":"2026-02-13T14:18:19.238712Z","steps":["trace[1284550386] 'process raft request' (duration: 32.73558ms)","trace[1284550386] 'compare' (duration: 72.722755ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:27.855424Z","caller":"traceutil/trace.go:171","msg":"trace[1648772537] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"159.685658ms","start":"2026-02-13T14:18:27.69573Z","end":"2026-02-13T14:18:27.855415Z","steps":["trace[1648772537] 'process raft request' (duration: 147.578865ms)","trace[1648772537] 'compare' (duration: 11.924202ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:27.855504Z","caller":"traceutil/trace.go:171","msg":"trace[1195331431] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:691; }","duration":"137.830697ms","start":"2026-02-13T14:18:27.717487Z","end":"2026-02-13T14:18:27.855317Z","steps":["trace[1195331431] 'read index received' (duration: 45.526013ms)","trace[1195331431] 'applied index is now lower than readState.Index' (duration: 92.304134ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:27.855691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.192999ms","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-13T14:18:27.856941Z","caller":"traceutil/trace.go:171","msg":"trace[253342765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:670; }","duration":"139.471227ms","start":"2026-02-13T14:18:27.717461Z","end":"2026-02-13T14:18:27.856932Z","steps":["trace[253342765] 'agreement among raft nodes before linearized reading' (duration: 138.077298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:27.857016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.520668ms","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-13T14:18:27.857032Z","caller":"traceutil/trace.go:171","msg":"trace[2106757664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:670; }","duration":"136.546468ms","start":"2026-02-13T14:18:27.720481Z","end":"2026-02-13T14:18:27.857028Z","steps":["trace[2106757664] 'agreement among raft nodes before linearized reading' (duration: 135.283591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:29.184063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.21153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-13T14:18:29.184252Z","caller":"traceutil/trace.go:171","msg":"trace[557897053] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"310.694771ms","start":"2026-02-13T14:18:28.873542Z","end":"2026-02-13T14:18:29.184236Z","steps":["trace[557897053] 'process raft request' (duration: 310.620621ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:29.184256Z","caller":"traceutil/trace.go:171","msg":"trace[4414191] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"316.469758ms","start":"2026-02-13T14:18:28.867764Z","end":"2026-02-13T14:18:29.184234Z","steps":["trace[4414191] 'process raft request' (duration: 91.014326ms)","trace[4414191] 'compare' (duration: 225.11797ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:29.184309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:28.873534Z","time spent":"310.750501ms","remote":"127.0.0.1:44642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T14:18:29.18436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:28.867751Z","time spent":"316.54914ms","remote":"127.0.0.1:44766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5010,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:29.343507Z","caller":"traceutil/trace.go:171","msg":"trace[1679540880] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"142.177209ms","start":"2026-02-13T14:18:29.20131Z","end":"2026-02-13T14:18:29.343487Z","steps":["trace[1679540880] 'process raft request' (duration: 117.297628ms)","trace[1679540880] 'compare' (duration: 24.816661ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:18:29.535666Z","caller":"traceutil/trace.go:171","msg":"trace[75330015] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"329.389719ms","start":"2026-02-13T14:18:29.206261Z","end":"2026-02-13T14:18:29.53565Z","steps":["trace[75330015] 'process raft request' (duration: 324.546895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:29.535769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:29.206247Z","time spent":"329.464199ms","remote":"127.0.0.1:44766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4832,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:29.536175Z","caller":"traceutil/trace.go:171","msg":"trace[308972386] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:707; }","duration":"115.049702ms","start":"2026-02-13T14:18:29.421118Z","end":"2026-02-13T14:18:29.536168Z","steps":["trace[308972386] 'read index received' (duration: 109.640925ms)","trace[308972386] 'applied index is now lower than readState.Index' (duration: 5.408337ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:18:29.536225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.105483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:18:29.536243Z","caller":"traceutil/trace.go:171","msg":"trace[118557558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:686; }","duration":"115.125063ms","start":"2026-02-13T14:18:29.421114Z","end":"2026-02-13T14:18:29.536239Z","steps":["trace[118557558] 'agreement among raft nodes before linearized reading' (duration: 115.083112ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:18:29.536317Z","caller":"traceutil/trace.go:171","msg":"trace[386277733] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"329.995943ms","start":"2026-02-13T14:18:29.206317Z","end":"2026-02-13T14:18:29.536313Z","steps":["trace[386277733] 'process raft request' (duration: 329.287708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:29.536346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:29.206313Z","time spent":"330.018583ms","remote":"127.0.0.1:44748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":783,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T14:18:29.536402Z","caller":"traceutil/trace.go:171","msg":"trace[1341885232] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"329.990223ms","start":"2026-02-13T14:18:29.206408Z","end":"2026-02-13T14:18:29.536398Z","steps":["trace[1341885232] 'process raft request' (duration: 329.718421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:18:29.536428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:18:29.206404Z","time spent":"330.012343ms","remote":"127.0.0.1:44642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-13T14:19:24.983795Z","caller":"traceutil/trace.go:171","msg":"trace[1540716178] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"103.709298ms","start":"2026-02-13T14:19:24.880067Z","end":"2026-02-13T14:19:24.983776Z","steps":["trace[1540716178] 'read index received' (duration: 19.10248ms)","trace[1540716178] 'applied index is now lower than readState.Index' (duration: 84.605988ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:19:24.984075Z","caller":"traceutil/trace.go:171","msg":"trace[1184496034] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"104.066346ms","start":"2026-02-13T14:19:24.879995Z","end":"2026-02-13T14:19:24.984062Z","steps":["trace[1184496034] 'process raft request' (duration: 78.891257ms)","trace[1184496034] 'compare' (duration: 24.817921ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:19:24.984323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.23757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1536"} {"level":"info","ts":"2026-02-13T14:19:24.984361Z","caller":"traceutil/trace.go:171","msg":"trace[833044110] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:906; }","duration":"104.294741ms","start":"2026-02-13T14:19:24.880057Z","end":"2026-02-13T14:19:24.984352Z","steps":["trace[833044110] 'agreement among raft nodes before linearized reading' (duration: 104.169398ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:28.319322Z","caller":"traceutil/trace.go:171","msg":"trace[747089259] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"175.097856ms","start":"2026-02-13T14:19:28.144192Z","end":"2026-02-13T14:19:28.31929Z","steps":["trace[747089259] 'read index received' (duration: 174.811429ms)","trace[747089259] 'applied index is now lower than readState.Index' (duration: 285.457µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:19:28.31971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.508155ms","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-13T14:19:28.31976Z","caller":"traceutil/trace.go:171","msg":"trace[2118957643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:917; }","duration":"175.608658ms","start":"2026-02-13T14:19:28.144139Z","end":"2026-02-13T14:19:28.319747Z","steps":["trace[2118957643] 'agreement among raft nodes before linearized reading' (duration: 175.464004ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:28.320336Z","caller":"traceutil/trace.go:171","msg":"trace[1837879543] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"206.04611ms","start":"2026-02-13T14:19:28.114276Z","end":"2026-02-13T14:19:28.320322Z","steps":["trace[1837879543] 'process raft request' (duration: 204.78826ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:32.586321Z","caller":"traceutil/trace.go:171","msg":"trace[2026299659] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"134.536753ms","start":"2026-02-13T14:19:32.451769Z","end":"2026-02-13T14:19:32.586306Z","steps":["trace[2026299659] 'process raft request' (duration: 134.502373ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:32.586548Z","caller":"traceutil/trace.go:171","msg":"trace[22554244] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"134.932803ms","start":"2026-02-13T14:19:32.451608Z","end":"2026-02-13T14:19:32.586541Z","steps":["trace[22554244] 'process raft request' (duration: 116.418881ms)","trace[22554244] 'compare' (duration: 17.806215ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:19:35.625255Z","caller":"traceutil/trace.go:171","msg":"trace[1870825697] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"127.39352ms","start":"2026-02-13T14:19:35.497843Z","end":"2026-02-13T14:19:35.625237Z","steps":["trace[1870825697] 'process raft request' (duration: 127.279908ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:36.584603Z","caller":"traceutil/trace.go:171","msg":"trace[1128491634] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"152.139649ms","start":"2026-02-13T14:19:36.432449Z","end":"2026-02-13T14:19:36.584589Z","steps":["trace[1128491634] 'process raft request' (duration: 152.040557ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:37.044521Z","caller":"traceutil/trace.go:171","msg":"trace[679267839] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"578.326555ms","start":"2026-02-13T14:19:36.466178Z","end":"2026-02-13T14:19:37.044504Z","steps":["trace[679267839] 'read index received' (duration: 118.730743ms)","trace[679267839] 'applied index is now lower than readState.Index' (duration: 459.595232ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:19:37.045503Z","caller":"traceutil/trace.go:171","msg":"trace[1445659013] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"602.747476ms","start":"2026-02-13T14:19:36.442697Z","end":"2026-02-13T14:19:37.045445Z","steps":["trace[1445659013] 'process raft request' (duration: 601.694919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.045627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.44269Z","time spent":"602.87172ms","remote":"127.0.0.1:44756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5217,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-13T14:19:37.045832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.650009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T14:19:37.045873Z","caller":"traceutil/trace.go:171","msg":"trace[1676746057] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:946; }","duration":"579.712459ms","start":"2026-02-13T14:19:36.466148Z","end":"2026-02-13T14:19:37.045861Z","steps":["trace[1676746057] 'agreement among raft nodes before linearized reading' (duration: 579.654068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.0459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.466135Z","time spent":"579.758961ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-02-13T14:19:37.143656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.645444ms","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-13T14:19:37.144021Z","caller":"traceutil/trace.go:171","msg":"trace[143212770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:946; }","duration":"485.014494ms","start":"2026-02-13T14:19:36.658988Z","end":"2026-02-13T14:19:37.144002Z","steps":["trace[143212770] 'agreement among raft nodes before linearized reading' (duration: 484.499461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.144212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.658957Z","time spent":"485.239369ms","remote":"127.0.0.1:44844","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-13T14:19:37.144638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.44129ms","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-13T14:19:37.144723Z","caller":"traceutil/trace.go:171","msg":"trace[1931876517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"506.584314ms","start":"2026-02-13T14:19:36.638121Z","end":"2026-02-13T14:19:37.144705Z","steps":["trace[1931876517] 'agreement among raft nodes before linearized reading' (duration: 506.262166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.145087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.638107Z","time spent":"506.950923ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-13T14:19:37.145683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.314251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T14:19:37.145877Z","caller":"traceutil/trace.go:171","msg":"trace[1096036394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:946; }","duration":"624.491206ms","start":"2026-02-13T14:19:36.52133Z","end":"2026-02-13T14:19:37.145822Z","steps":["trace[1096036394] 'agreement among raft nodes before linearized reading' (duration: 624.276751ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.146124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.521319Z","time spent":"624.747742ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-13T14:19:37.146571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.803795ms","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-13T14:19:37.146618Z","caller":"traceutil/trace.go:171","msg":"trace[818364876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:946; }","duration":"664.861807ms","start":"2026-02-13T14:19:36.481744Z","end":"2026-02-13T14:19:37.146606Z","steps":["trace[818364876] 'agreement among raft nodes before linearized reading' (duration: 664.744304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:37.146648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:36.481739Z","time spent":"664.901808ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-13T14:19:37.286688Z","caller":"traceutil/trace.go:171","msg":"trace[1509254059] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"127.825839ms","start":"2026-02-13T14:19:37.158845Z","end":"2026-02-13T14:19:37.286671Z","steps":["trace[1509254059] 'process raft request' (duration: 99.616339ms)","trace[1509254059] 'compare' (duration: 27.819211ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T14:19:37.286875Z","caller":"traceutil/trace.go:171","msg":"trace[567189807] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"126.572048ms","start":"2026-02-13T14:19:37.160298Z","end":"2026-02-13T14:19:37.28687Z","steps":["trace[567189807] 'process raft request' (duration: 126.081825ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:37.286962Z","caller":"traceutil/trace.go:171","msg":"trace[1413030564] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"120.844334ms","start":"2026-02-13T14:19:37.166114Z","end":"2026-02-13T14:19:37.286958Z","steps":["trace[1413030564] 'process raft request' (duration: 120.466214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:38.372667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.164663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T14:19:38.372724Z","caller":"traceutil/trace.go:171","msg":"trace[512851290] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:950; }","duration":"718.269095ms","start":"2026-02-13T14:19:37.654443Z","end":"2026-02-13T14:19:38.372713Z","steps":["trace[512851290] 'count revisions from in-memory index tree' (duration: 718.09447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:38.372752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:37.654402Z","time spent":"718.343127ms","remote":"127.0.0.1:44782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-02-13T14:19:38.379527Z","caller":"traceutil/trace.go:171","msg":"trace[1762927489] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:989; }","duration":"108.322584ms","start":"2026-02-13T14:19:38.271194Z","end":"2026-02-13T14:19:38.379517Z","steps":["trace[1762927489] 'read index received' (duration: 108.215971ms)","trace[1762927489] 'applied index is now lower than readState.Index' (duration: 105.933µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T14:19:38.379595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.396565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T14:19:38.379619Z","caller":"traceutil/trace.go:171","msg":"trace[2073405456] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:951; }","duration":"108.458957ms","start":"2026-02-13T14:19:38.271152Z","end":"2026-02-13T14:19:38.379611Z","steps":["trace[2073405456] 'agreement among raft nodes before linearized reading' (duration: 108.402006ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T14:19:38.379865Z","caller":"traceutil/trace.go:171","msg":"trace[2112239113] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"420.159697ms","start":"2026-02-13T14:19:37.959697Z","end":"2026-02-13T14:19:38.379856Z","steps":["trace[2112239113] 'process raft request' (duration: 419.726286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T14:19:38.379924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T14:19:37.959673Z","time spent":"420.214168ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}