{"level":"warn","ts":"2026-02-26T06:10:50.944293Z","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-26T06:10:50.944369Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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://199.204.45.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-26T06:10:50.944589Z","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-26T06:10:50.944602Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-02-26T06:10:50.944622Z","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-26T06:10:50.945162Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-02-26T06:10:50.945225Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-26T06:10:50.953258Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.063712ms"} {"level":"info","ts":"2026-02-26T06:10:50.972421Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-02-26T06:10:50.972528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T06:10:50.972557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-02-26T06:10:50.972571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T06:10:50.972586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-02-26T06:10:50.972625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-02-26T06:10:50.987378Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T06:10:50.991069Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T06:10:50.99445Z","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-26T06:10:50.997587Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T06:10:50.998942Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T06:10:50.999183Z","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-26T06:10:50.99931Z","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-26T06:10:50.999322Z","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-26T06:10:50.999419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-02-26T06:10:50.999525Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-02-26T06:10:51.000984Z","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-26T06:10:51.001141Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-02-26T06:10:51.002639Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-02-26T06:10:51.003679Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T06:10:51.00373Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T06:10:51.772985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T06:10:51.77308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T06:10:51.773111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-02-26T06:10:51.773134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-02-26T06:10:51.773147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-02-26T06:10:51.773164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-02-26T06:10:51.773178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-02-26T06:10:51.775782Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T06:10:51.776463Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T06:10:51.77645Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T06:10:51.776497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T06:10:51.776797Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T06:10:51.776933Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T06:10:51.776976Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T06:10:51.77696Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T06:10:51.777063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T06:10:51.779824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-02-26T06:10:51.781156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T06:10:53.432891Z","caller":"traceutil/trace.go:171","msg":"trace[1874308441] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"103.983209ms","start":"2026-02-26T06:10:53.328869Z","end":"2026-02-26T06:10:53.432852Z","steps":["trace[1874308441] 'process raft request' (duration: 103.872527ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:53.43293Z","caller":"traceutil/trace.go:171","msg":"trace[1901023552] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"104.804983ms","start":"2026-02-26T06:10:53.328096Z","end":"2026-02-26T06:10:53.432901Z","steps":["trace[1901023552] 'process raft request' (duration: 104.571048ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:53.433138Z","caller":"traceutil/trace.go:171","msg":"trace[275945344] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"103.684933ms","start":"2026-02-26T06:10:53.329428Z","end":"2026-02-26T06:10:53.433113Z","steps":["trace[275945344] 'process raft request' (duration: 103.383708ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:53.433288Z","caller":"traceutil/trace.go:171","msg":"trace[841927147] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"103.958958ms","start":"2026-02-26T06:10:53.32931Z","end":"2026-02-26T06:10:53.433269Z","steps":["trace[841927147] 'process raft request' (duration: 103.469219ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:53.628513Z","caller":"traceutil/trace.go:171","msg":"trace[1764205625] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"130.408401ms","start":"2026-02-26T06:10:53.498081Z","end":"2026-02-26T06:10:53.62849Z","steps":["trace[1764205625] 'process raft request' (duration: 130.148786ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:53.628508Z","caller":"traceutil/trace.go:171","msg":"trace[1851328569] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"132.676283ms","start":"2026-02-26T06:10:53.495802Z","end":"2026-02-26T06:10:53.628478Z","steps":["trace[1851328569] 'process raft request' (duration: 92.623346ms)","trace[1851328569] 'compare' (duration: 39.66236ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:53.928486Z","caller":"traceutil/trace.go:171","msg":"trace[1682984108] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"101.270639ms","start":"2026-02-26T06:10:53.827151Z","end":"2026-02-26T06:10:53.928421Z","steps":["trace[1682984108] 'process raft request' (duration: 78.653006ms)","trace[1682984108] 'compare' (duration: 22.398788ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:53.928543Z","caller":"traceutil/trace.go:171","msg":"trace[1467120769] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"100.872241ms","start":"2026-02-26T06:10:53.827652Z","end":"2026-02-26T06:10:53.928524Z","steps":["trace[1467120769] 'process raft request' (duration: 100.625755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:10:54.186278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.484012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-26T06:10:54.186406Z","caller":"traceutil/trace.go:171","msg":"trace[634997744] linearizableReadLoop","detail":"{readStateIndex:73; appliedIndex:72; }","duration":"183.415107ms","start":"2026-02-26T06:10:54.002974Z","end":"2026-02-26T06:10:54.186389Z","steps":["trace[634997744] 'read index received' (duration: 38.041219ms)","trace[634997744] 'applied index is now lower than readState.Index' (duration: 145.369328ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:54.186463Z","caller":"traceutil/trace.go:171","msg":"trace[1334900617] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"193.933944ms","start":"2026-02-26T06:10:53.992485Z","end":"2026-02-26T06:10:54.186419Z","steps":["trace[1334900617] 'process raft request' (duration: 48.496714ms)","trace[1334900617] 'compare' (duration: 144.333289ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:54.186572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.56552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1897b70e371577ca\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-02-26T06:10:54.186664Z","caller":"traceutil/trace.go:171","msg":"trace[1249294258] range","detail":"{range_begin:/registry/events/default/instance.1897b70e371577ca; range_end:; response_count:1; response_revision:68; }","duration":"183.694062ms","start":"2026-02-26T06:10:54.002944Z","end":"2026-02-26T06:10:54.186638Z","steps":["trace[1249294258] 'agreement among raft nodes before linearized reading' (duration: 183.521529ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:54.20489Z","caller":"traceutil/trace.go:171","msg":"trace[206176036] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"201.622757ms","start":"2026-02-26T06:10:54.003248Z","end":"2026-02-26T06:10:54.204871Z","steps":["trace[206176036] 'process raft request' (duration: 201.507165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:10:54.204953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.506708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T06:10:54.205004Z","caller":"traceutil/trace.go:171","msg":"trace[2090332562] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:69; }","duration":"191.57514ms","start":"2026-02-26T06:10:54.013413Z","end":"2026-02-26T06:10:54.204988Z","steps":["trace[2090332562] 'agreement among raft nodes before linearized reading' (duration: 191.429217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:10:54.204997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.983648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-26T06:10:54.205099Z","caller":"traceutil/trace.go:171","msg":"trace[643064626] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:69; }","duration":"191.098679ms","start":"2026-02-26T06:10:54.013984Z","end":"2026-02-26T06:10:54.205083Z","steps":["trace[643064626] 'agreement among raft nodes before linearized reading' (duration: 190.975037ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:55.669015Z","caller":"traceutil/trace.go:171","msg":"trace[382907584] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"150.157667ms","start":"2026-02-26T06:10:55.51883Z","end":"2026-02-26T06:10:55.668987Z","steps":["trace[382907584] 'process raft request' (duration: 89.483196ms)","trace[382907584] 'compare' (duration: 60.526669ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:55.885192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.569543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:10:55.885296Z","caller":"traceutil/trace.go:171","msg":"trace[2144518642] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"124.278595ms","start":"2026-02-26T06:10:55.760997Z","end":"2026-02-26T06:10:55.885275Z","steps":["trace[2144518642] 'process raft request' (duration: 23.544259ms)","trace[2144518642] 'compare' (duration: 100.456371ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:56.161073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.622256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:10:56.161266Z","caller":"traceutil/trace.go:171","msg":"trace[1511925796] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"176.461645ms","start":"2026-02-26T06:10:55.984749Z","end":"2026-02-26T06:10:56.161211Z","steps":["trace[1511925796] 'process raft request' (duration: 42.606184ms)","trace[1511925796] 'compare' (duration: 133.2602ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:56.86755Z","caller":"traceutil/trace.go:171","msg":"trace[2144991465] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:225; }","duration":"246.206273ms","start":"2026-02-26T06:10:56.621309Z","end":"2026-02-26T06:10:56.867515Z","steps":["trace[2144991465] 'read index received' (duration: 198.113157ms)","trace[2144991465] 'applied index is now lower than readState.Index' (duration: 48.091505ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:56.867608Z","caller":"traceutil/trace.go:171","msg":"trace[1619218585] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"270.465934ms","start":"2026-02-26T06:10:56.597115Z","end":"2026-02-26T06:10:56.86758Z","steps":["trace[1619218585] 'process raft request' (duration: 222.154924ms)","trace[1619218585] 'compare' (duration: 47.984144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:56.867814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.481427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:10:56.867972Z","caller":"traceutil/trace.go:171","msg":"trace[882276841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:221; }","duration":"246.696601ms","start":"2026-02-26T06:10:56.62126Z","end":"2026-02-26T06:10:56.867957Z","steps":["trace[882276841] 'agreement among raft nodes before linearized reading' (duration: 246.400046ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:10:56.867879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.662376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:10:56.868173Z","caller":"traceutil/trace.go:171","msg":"trace[424835581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:221; }","duration":"221.947821ms","start":"2026-02-26T06:10:56.646137Z","end":"2026-02-26T06:10:56.868085Z","steps":["trace[424835581] 'agreement among raft nodes before linearized reading' (duration: 221.689606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:10:57.102764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.669542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:10:57.102938Z","caller":"traceutil/trace.go:171","msg":"trace[411917025] linearizableReadLoop","detail":"{readStateIndex:232; appliedIndex:230; }","duration":"207.909519ms","start":"2026-02-26T06:10:56.895008Z","end":"2026-02-26T06:10:57.102917Z","steps":["trace[411917025] 'read index received' (duration: 99.043653ms)","trace[411917025] 'applied index is now lower than readState.Index' (duration: 108.864396ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:57.103036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.033852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-26T06:10:57.103062Z","caller":"traceutil/trace.go:171","msg":"trace[965612300] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:227; }","duration":"208.110423ms","start":"2026-02-26T06:10:56.894941Z","end":"2026-02-26T06:10:57.103051Z","steps":["trace[965612300] 'agreement among raft nodes before linearized reading' (duration: 208.030682ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:57.103156Z","caller":"traceutil/trace.go:171","msg":"trace[1194101477] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"209.995417ms","start":"2026-02-26T06:10:56.893112Z","end":"2026-02-26T06:10:57.103107Z","steps":["trace[1194101477] 'process raft request' (duration: 100.882877ms)","trace[1194101477] 'compare' (duration: 108.57361ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:57.103344Z","caller":"traceutil/trace.go:171","msg":"trace[500769197] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"208.418428ms","start":"2026-02-26T06:10:56.894878Z","end":"2026-02-26T06:10:57.103296Z","steps":["trace[500769197] 'process raft request' (duration: 207.979251ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:57.26314Z","caller":"traceutil/trace.go:171","msg":"trace[1078358203] linearizableReadLoop","detail":"{readStateIndex:236; appliedIndex:235; }","duration":"103.263591ms","start":"2026-02-26T06:10:57.159824Z","end":"2026-02-26T06:10:57.263088Z","steps":["trace[1078358203] 'read index received' (duration: 81.658739ms)","trace[1078358203] 'applied index is now lower than readState.Index' (duration: 21.603792ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:57.263356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.512726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:10:57.263219Z","caller":"traceutil/trace.go:171","msg":"trace[368635709] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"117.364364ms","start":"2026-02-26T06:10:57.14582Z","end":"2026-02-26T06:10:57.263184Z","steps":["trace[368635709] 'process raft request' (duration: 95.677311ms)","trace[368635709] 'compare' (duration: 21.440628ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:57.263415Z","caller":"traceutil/trace.go:171","msg":"trace[1468397131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:231; }","duration":"103.604168ms","start":"2026-02-26T06:10:57.159797Z","end":"2026-02-26T06:10:57.263401Z","steps":["trace[1468397131] 'agreement among raft nodes before linearized reading' (duration: 103.447375ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:57.471934Z","caller":"traceutil/trace.go:171","msg":"trace[165535826] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"121.610681ms","start":"2026-02-26T06:10:57.350294Z","end":"2026-02-26T06:10:57.471905Z","steps":["trace[165535826] 'process raft request' (duration: 39.003934ms)","trace[165535826] 'compare' (duration: 82.303882ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:59.353658Z","caller":"traceutil/trace.go:171","msg":"trace[589745116] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:287; }","duration":"153.576473ms","start":"2026-02-26T06:10:59.200043Z","end":"2026-02-26T06:10:59.35362Z","steps":["trace[589745116] 'read index received' (duration: 106.638601ms)","trace[589745116] 'applied index is now lower than readState.Index' (duration: 46.936532ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:10:59.353801Z","caller":"traceutil/trace.go:171","msg":"trace[2063288337] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"166.211548ms","start":"2026-02-26T06:10:59.187576Z","end":"2026-02-26T06:10:59.353787Z","steps":["trace[2063288337] 'process raft request' (duration: 119.172465ms)","trace[2063288337] 'compare' (duration: 46.749938ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:10:59.354243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.172796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:10:59.354294Z","caller":"traceutil/trace.go:171","msg":"trace[1216869068] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:282; }","duration":"154.284827ms","start":"2026-02-26T06:10:59.199996Z","end":"2026-02-26T06:10:59.354281Z","steps":["trace[1216869068] 'agreement among raft nodes before linearized reading' (duration: 154.183555ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:10:59.479169Z","caller":"traceutil/trace.go:171","msg":"trace[515201098] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"119.848908ms","start":"2026-02-26T06:10:59.359287Z","end":"2026-02-26T06:10:59.479136Z","steps":["trace[515201098] 'process raft request' (duration: 108.67024ms)","trace[515201098] 'compare' (duration: 10.898683ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:00.006181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.847526ms","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-26T06:11:00.006269Z","caller":"traceutil/trace.go:171","msg":"trace[989447908] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:290; }","duration":"255.013969ms","start":"2026-02-26T06:10:59.751236Z","end":"2026-02-26T06:11:00.00625Z","steps":["trace[989447908] 'range keys from in-memory index tree' (duration: 254.715353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:00.006384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.99704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:11:00.006606Z","caller":"traceutil/trace.go:171","msg":"trace[533995901] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"164.747842ms","start":"2026-02-26T06:10:59.841835Z","end":"2026-02-26T06:11:00.006582Z","steps":["trace[533995901] 'process raft request' (duration: 164.680261ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.006566Z","caller":"traceutil/trace.go:171","msg":"trace[1393942517] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"254.48669ms","start":"2026-02-26T06:10:59.752029Z","end":"2026-02-26T06:11:00.006515Z","steps":["trace[1393942517] 'process raft request' (duration: 99.268055ms)","trace[1393942517] 'compare' (duration: 154.784916ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:00.006629Z","caller":"traceutil/trace.go:171","msg":"trace[1667382471] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"166.192049ms","start":"2026-02-26T06:10:59.840408Z","end":"2026-02-26T06:11:00.0066Z","steps":["trace[1667382471] 'read index received' (duration: 10.933923ms)","trace[1667382471] 'applied index is now lower than readState.Index' (duration: 155.254976ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:00.006894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.450134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-26T06:11:00.006994Z","caller":"traceutil/trace.go:171","msg":"trace[132648807] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:292; }","duration":"166.611127ms","start":"2026-02-26T06:10:59.840358Z","end":"2026-02-26T06:11:00.006969Z","steps":["trace[132648807] 'agreement among raft nodes before linearized reading' (duration: 166.370312ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.065423Z","caller":"traceutil/trace.go:171","msg":"trace[1394857050] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"120.944169ms","start":"2026-02-26T06:10:59.944461Z","end":"2026-02-26T06:11:00.065406Z","steps":["trace[1394857050] 'process raft request' (duration: 120.836697ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.096915Z","caller":"traceutil/trace.go:171","msg":"trace[1993310671] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"134.293075ms","start":"2026-02-26T06:10:59.962604Z","end":"2026-02-26T06:11:00.096897Z","steps":["trace[1993310671] 'process raft request' (duration: 134.119862ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.097128Z","caller":"traceutil/trace.go:171","msg":"trace[331801450] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"134.089341ms","start":"2026-02-26T06:10:59.96303Z","end":"2026-02-26T06:11:00.097119Z","steps":["trace[331801450] 'process raft request' (duration: 133.804356ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.097269Z","caller":"traceutil/trace.go:171","msg":"trace[1694508528] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"133.924377ms","start":"2026-02-26T06:10:59.963324Z","end":"2026-02-26T06:11:00.097248Z","steps":["trace[1694508528] 'process raft request' (duration: 133.596521ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.097418Z","caller":"traceutil/trace.go:171","msg":"trace[1518667058] transaction","detail":"{read_only:false; number_of_response:0; response_revision:294; }","duration":"132.277428ms","start":"2026-02-26T06:10:59.965133Z","end":"2026-02-26T06:11:00.09741Z","steps":["trace[1518667058] 'process raft request' (duration: 131.823959ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.097599Z","caller":"traceutil/trace.go:171","msg":"trace[1153892243] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"130.820151ms","start":"2026-02-26T06:10:59.966743Z","end":"2026-02-26T06:11:00.097563Z","steps":["trace[1153892243] 'process raft request' (duration: 130.26684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:00.097665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.678361ms","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-26T06:11:00.097694Z","caller":"traceutil/trace.go:171","msg":"trace[1361033855] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:296; }","duration":"255.766073ms","start":"2026-02-26T06:10:59.841918Z","end":"2026-02-26T06:11:00.097684Z","steps":["trace[1361033855] 'agreement among raft nodes before linearized reading' (duration: 255.700602ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.22339Z","caller":"traceutil/trace.go:171","msg":"trace[1381099732] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"120.758334ms","start":"2026-02-26T06:11:00.102609Z","end":"2026-02-26T06:11:00.223368Z","steps":["trace[1381099732] 'process raft request' (duration: 30.512037ms)","trace[1381099732] 'compare' (duration: 90.119524ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:00.229326Z","caller":"traceutil/trace.go:171","msg":"trace[16811902] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"126.330197ms","start":"2026-02-26T06:11:00.102971Z","end":"2026-02-26T06:11:00.229301Z","steps":["trace[16811902] 'process raft request' (duration: 126.106093ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.229458Z","caller":"traceutil/trace.go:171","msg":"trace[2091702] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"124.478322ms","start":"2026-02-26T06:11:00.104953Z","end":"2026-02-26T06:11:00.229431Z","steps":["trace[2091702] 'process raft request' (duration: 124.282129ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.229516Z","caller":"traceutil/trace.go:171","msg":"trace[779104284] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"119.122223ms","start":"2026-02-26T06:11:00.110369Z","end":"2026-02-26T06:11:00.229491Z","steps":["trace[779104284] 'process raft request' (duration: 118.9982ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:00.229793Z","caller":"traceutil/trace.go:171","msg":"trace[2018014463] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"123.929813ms","start":"2026-02-26T06:11:00.105544Z","end":"2026-02-26T06:11:00.229474Z","steps":["trace[2018014463] 'process raft request' (duration: 123.74805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:00.674206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.158808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:11:00.674397Z","caller":"traceutil/trace.go:171","msg":"trace[339536535] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"396.672919ms","start":"2026-02-26T06:11:00.277674Z","end":"2026-02-26T06:11:00.674347Z","steps":["trace[339536535] 'process raft request' (duration: 112.279216ms)","trace[339536535] 'compare' (duration: 283.957005ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:00.674565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.277633Z","time spent":"396.854873ms","remote":"127.0.0.1:49266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3200,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T06:11:00.674613Z","caller":"traceutil/trace.go:171","msg":"trace[778697973] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"394.708632ms","start":"2026-02-26T06:11:00.279614Z","end":"2026-02-26T06:11:00.674322Z","steps":["trace[778697973] 'read index received' (duration: 110.279648ms)","trace[778697973] 'applied index is now lower than readState.Index' (duration: 284.427414ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:00.67486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.220021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:00.674952Z","caller":"traceutil/trace.go:171","msg":"trace[1866781554] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:308; }","duration":"395.355474ms","start":"2026-02-26T06:11:00.279574Z","end":"2026-02-26T06:11:00.67493Z","steps":["trace[1866781554] 'agreement among raft nodes before linearized reading' (duration: 395.013768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:00.675042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.279561Z","time spent":"395.470166ms","remote":"127.0.0.1:49032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "} {"level":"info","ts":"2026-02-26T06:11:00.980544Z","caller":"traceutil/trace.go:171","msg":"trace[1047181570] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"252.925487ms","start":"2026-02-26T06:11:00.727593Z","end":"2026-02-26T06:11:00.980518Z","steps":["trace[1047181570] 'read index received' (duration: 234.21314ms)","trace[1047181570] 'applied index is now lower than readState.Index' (duration: 18.710927ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:00.980606Z","caller":"traceutil/trace.go:171","msg":"trace[949293815] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"253.748963ms","start":"2026-02-26T06:11:00.726823Z","end":"2026-02-26T06:11:00.980572Z","steps":["trace[949293815] 'process raft request' (duration: 234.906244ms)","trace[949293815] 'compare' (duration: 18.615885ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:00.980867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.253425ms","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-26T06:11:00.980954Z","caller":"traceutil/trace.go:171","msg":"trace[120967788] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:311; }","duration":"253.379377ms","start":"2026-02-26T06:11:00.727555Z","end":"2026-02-26T06:11:00.980935Z","steps":["trace[120967788] 'agreement among raft nodes before linearized reading' (duration: 253.096421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.261339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.888687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-02-26T06:11:01.261664Z","caller":"traceutil/trace.go:171","msg":"trace[374000420] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"366.391105ms","start":"2026-02-26T06:11:00.895233Z","end":"2026-02-26T06:11:01.261624Z","steps":["trace[374000420] 'process raft request' (duration: 240.036529ms)","trace[374000420] 'compare' (duration: 125.820856ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:01.261687Z","caller":"traceutil/trace.go:171","msg":"trace[1373784485] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"366.300173ms","start":"2026-02-26T06:11:00.895353Z","end":"2026-02-26T06:11:01.261653Z","steps":["trace[1373784485] 'process raft request' (duration: 366.14651ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.261717Z","caller":"traceutil/trace.go:171","msg":"trace[1180852643] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"366.128199ms","start":"2026-02-26T06:11:00.895567Z","end":"2026-02-26T06:11:01.261696Z","steps":["trace[1180852643] 'process raft request' (duration: 366.015837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.261857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.89532Z","time spent":"366.452005ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T06:11:01.261871Z","caller":"traceutil/trace.go:171","msg":"trace[917586160] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"366.204671ms","start":"2026-02-26T06:11:00.895653Z","end":"2026-02-26T06:11:01.261857Z","steps":["trace[917586160] 'process raft request' (duration: 365.974057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.261958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.895614Z","time spent":"366.308232ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T06:11:01.261819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.72321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"warn","ts":"2026-02-26T06:11:01.262001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.895557Z","time spent":"366.333282ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T06:11:01.262042Z","caller":"traceutil/trace.go:171","msg":"trace[1029490928] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:311; }","duration":"366.993356ms","start":"2026-02-26T06:11:00.895032Z","end":"2026-02-26T06:11:01.262025Z","steps":["trace[1029490928] 'agreement among raft nodes before linearized reading' (duration: 366.704921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.2621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.895016Z","time spent":"367.064307ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5536,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-26T06:11:01.261833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.895198Z","time spent":"366.554178ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T06:11:01.261691Z","caller":"traceutil/trace.go:171","msg":"trace[254205525] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:320; }","duration":"281.040149ms","start":"2026-02-26T06:11:00.98062Z","end":"2026-02-26T06:11:01.26166Z","steps":["trace[254205525] 'read index received' (duration: 154.608582ms)","trace[254205525] 'applied index is now lower than readState.Index' (duration: 126.429607ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:01.338306Z","caller":"traceutil/trace.go:171","msg":"trace[1331479696] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"351.540567ms","start":"2026-02-26T06:11:00.98673Z","end":"2026-02-26T06:11:01.338271Z","steps":["trace[1331479696] 'process raft request' (duration: 351.428815ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.338363Z","caller":"traceutil/trace.go:171","msg":"trace[758088572] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"353.619917ms","start":"2026-02-26T06:11:00.984702Z","end":"2026-02-26T06:11:01.338322Z","steps":["trace[758088572] 'process raft request' (duration: 353.2175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.3385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.791435ms","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-26T06:11:01.338583Z","caller":"traceutil/trace.go:171","msg":"trace[1303722173] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:313; }","duration":"188.931458ms","start":"2026-02-26T06:11:01.149633Z","end":"2026-02-26T06:11:01.338564Z","steps":["trace[1303722173] 'agreement among raft nodes before linearized reading' (duration: 188.745055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.338519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.984684Z","time spent":"353.761189ms","remote":"127.0.0.1:49032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T06:11:01.338844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:00.986716Z","time spent":"351.710281ms","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T06:11:01.338503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.657924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-26T06:11:01.338915Z","caller":"traceutil/trace.go:171","msg":"trace[1098511818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:313; }","duration":"189.107811ms","start":"2026-02-26T06:11:01.149794Z","end":"2026-02-26T06:11:01.338902Z","steps":["trace[1098511818] 'agreement among raft nodes before linearized reading' (duration: 188.568011ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.450166Z","caller":"traceutil/trace.go:171","msg":"trace[1714311345] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:326; }","duration":"111.912368ms","start":"2026-02-26T06:11:01.338227Z","end":"2026-02-26T06:11:01.450139Z","steps":["trace[1714311345] 'read index received' (duration: 57.918515ms)","trace[1714311345] 'applied index is now lower than readState.Index' (duration: 53.991873ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:01.450342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.661268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"} {"level":"warn","ts":"2026-02-26T06:11:01.450363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.648478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-02-26T06:11:01.450387Z","caller":"traceutil/trace.go:171","msg":"trace[1076917318] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:314; }","duration":"185.75382ms","start":"2026-02-26T06:11:01.264621Z","end":"2026-02-26T06:11:01.450375Z","steps":["trace[1076917318] 'agreement among raft nodes before linearized reading' (duration: 185.644178ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.450438Z","caller":"traceutil/trace.go:171","msg":"trace[2115214201] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"146.199695ms","start":"2026-02-26T06:11:01.304219Z","end":"2026-02-26T06:11:01.450419Z","steps":["trace[2115214201] 'process raft request' (duration: 91.963408ms)","trace[2115214201] 'compare' (duration: 53.81236ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:01.450445Z","caller":"traceutil/trace.go:171","msg":"trace[1929260789] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:314; }","duration":"185.750129ms","start":"2026-02-26T06:11:01.264671Z","end":"2026-02-26T06:11:01.450421Z","steps":["trace[1929260789] 'agreement among raft nodes before linearized reading' (duration: 185.588947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.450367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.574117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"warn","ts":"2026-02-26T06:11:01.450565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.655876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-02-26T06:11:01.450649Z","caller":"traceutil/trace.go:171","msg":"trace[1482115804] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:314; }","duration":"185.912132ms","start":"2026-02-26T06:11:01.264724Z","end":"2026-02-26T06:11:01.450636Z","steps":["trace[1482115804] 'agreement among raft nodes before linearized reading' (duration: 185.469614ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.450685Z","caller":"traceutil/trace.go:171","msg":"trace[441776598] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:314; }","duration":"186.855589ms","start":"2026-02-26T06:11:01.26379Z","end":"2026-02-26T06:11:01.450646Z","steps":["trace[441776598] 'agreement among raft nodes before linearized reading' (duration: 186.562874ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.457163Z","caller":"traceutil/trace.go:171","msg":"trace[767673637] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"114.528247ms","start":"2026-02-26T06:11:01.3426Z","end":"2026-02-26T06:11:01.457129Z","steps":["trace[767673637] 'process raft request' (duration: 114.238491ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.457409Z","caller":"traceutil/trace.go:171","msg":"trace[868864156] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"114.281652ms","start":"2026-02-26T06:11:01.342972Z","end":"2026-02-26T06:11:01.457254Z","steps":["trace[868864156] 'process raft request' (duration: 114.072818ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.457883Z","caller":"traceutil/trace.go:171","msg":"trace[1043371754] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"111.693394ms","start":"2026-02-26T06:11:01.346176Z","end":"2026-02-26T06:11:01.45787Z","steps":["trace[1043371754] 'process raft request' (duration: 111.007272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.458154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.27422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-26T06:11:01.458187Z","caller":"traceutil/trace.go:171","msg":"trace[4038050] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:317; }","duration":"115.360672ms","start":"2026-02-26T06:11:01.342814Z","end":"2026-02-26T06:11:01.458175Z","steps":["trace[4038050] 'agreement among raft nodes before linearized reading' (duration: 115.015695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:01.689556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.232232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:11:01.689723Z","caller":"traceutil/trace.go:171","msg":"trace[1585959515] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"151.959782ms","start":"2026-02-26T06:11:01.537741Z","end":"2026-02-26T06:11:01.689701Z","steps":["trace[1585959515] 'read index received' (duration: 30.394645ms)","trace[1585959515] 'applied index is now lower than readState.Index' (duration: 121.562687ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:01.689947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.180376ms","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-26T06:11:01.690026Z","caller":"traceutil/trace.go:171","msg":"trace[106121209] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:325; }","duration":"152.312218ms","start":"2026-02-26T06:11:01.537695Z","end":"2026-02-26T06:11:01.690007Z","steps":["trace[106121209] 'agreement among raft nodes before linearized reading' (duration: 152.169485ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:01.690552Z","caller":"traceutil/trace.go:171","msg":"trace[1297531868] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"157.887121ms","start":"2026-02-26T06:11:01.532648Z","end":"2026-02-26T06:11:01.690535Z","steps":["trace[1297531868] 'process raft request' (duration: 35.588311ms)","trace[1297531868] 'compare' (duration: 121.050597ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:02.33832Z","caller":"traceutil/trace.go:171","msg":"trace[253458421] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"138.225145ms","start":"2026-02-26T06:11:02.200045Z","end":"2026-02-26T06:11:02.33827Z","steps":["trace[253458421] 'read index received' (duration: 73.567206ms)","trace[253458421] 'applied index is now lower than readState.Index' (duration: 64.656469ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:02.33861Z","caller":"traceutil/trace.go:171","msg":"trace[306703466] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"181.880456ms","start":"2026-02-26T06:11:02.156696Z","end":"2026-02-26T06:11:02.338576Z","steps":["trace[306703466] 'process raft request' (duration: 117.008372ms)","trace[306703466] 'compare' (duration: 64.404386ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:02.338805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.737045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-26T06:11:02.339302Z","caller":"traceutil/trace.go:171","msg":"trace[338758423] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:340; }","duration":"139.295156ms","start":"2026-02-26T06:11:02.19998Z","end":"2026-02-26T06:11:02.339276Z","steps":["trace[338758423] 'agreement among raft nodes before linearized reading' (duration: 138.678254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:03.350398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.151009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:11:03.350533Z","caller":"traceutil/trace.go:171","msg":"trace[789073300] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"268.709665ms","start":"2026-02-26T06:11:03.081802Z","end":"2026-02-26T06:11:03.350512Z","steps":["trace[789073300] 'process raft request' (duration: 37.358663ms)","trace[789073300] 'compare' (duration: 230.808703ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:03.35836Z","caller":"traceutil/trace.go:171","msg":"trace[720707865] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:366; }","duration":"258.198841ms","start":"2026-02-26T06:11:03.100138Z","end":"2026-02-26T06:11:03.358336Z","steps":["trace[720707865] 'read index received' (duration: 18.946682ms)","trace[720707865] 'applied index is now lower than readState.Index' (duration: 239.250779ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:03.358584Z","caller":"traceutil/trace.go:171","msg":"trace[1437514343] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"275.41756ms","start":"2026-02-26T06:11:03.083152Z","end":"2026-02-26T06:11:03.35857Z","steps":["trace[1437514343] 'process raft request' (duration: 274.970741ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.35884Z","caller":"traceutil/trace.go:171","msg":"trace[389418562] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"275.061873ms","start":"2026-02-26T06:11:03.083768Z","end":"2026-02-26T06:11:03.358829Z","steps":["trace[389418562] 'process raft request' (duration: 274.466522ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.359107Z","caller":"traceutil/trace.go:171","msg":"trace[1936118934] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"269.55588ms","start":"2026-02-26T06:11:03.08954Z","end":"2026-02-26T06:11:03.359096Z","steps":["trace[1936118934] 'process raft request' (duration: 268.742256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:03.359285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.135847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-26T06:11:03.359321Z","caller":"traceutil/trace.go:171","msg":"trace[206330874] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:357; }","duration":"259.236819ms","start":"2026-02-26T06:11:03.100072Z","end":"2026-02-26T06:11:03.359309Z","steps":["trace[206330874] 'agreement among raft nodes before linearized reading' (duration: 259.154228ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:03.359565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.209892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-26T06:11:03.359649Z","caller":"traceutil/trace.go:171","msg":"trace[1355813814] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:357; }","duration":"208.355565ms","start":"2026-02-26T06:11:03.151275Z","end":"2026-02-26T06:11:03.35963Z","steps":["trace[1355813814] 'agreement among raft nodes before linearized reading' (duration: 208.174492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:03.359933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.569651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-26T06:11:03.359977Z","caller":"traceutil/trace.go:171","msg":"trace[265594225] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:357; }","duration":"159.635272ms","start":"2026-02-26T06:11:03.200331Z","end":"2026-02-26T06:11:03.359967Z","steps":["trace[265594225] 'agreement among raft nodes before linearized reading' (duration: 159.55818ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.518735Z","caller":"traceutil/trace.go:171","msg":"trace[655475742] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"142.127396ms","start":"2026-02-26T06:11:03.376553Z","end":"2026-02-26T06:11:03.51868Z","steps":["trace[655475742] 'process raft request' (duration: 124.366416ms)","trace[655475742] 'compare' (duration: 17.521026ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:03.518803Z","caller":"traceutil/trace.go:171","msg":"trace[415000706] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"142.021834ms","start":"2026-02-26T06:11:03.376722Z","end":"2026-02-26T06:11:03.518743Z","steps":["trace[415000706] 'process raft request' (duration: 141.908032ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.51889Z","caller":"traceutil/trace.go:171","msg":"trace[745583848] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"103.420729ms","start":"2026-02-26T06:11:03.415446Z","end":"2026-02-26T06:11:03.518867Z","steps":["trace[745583848] 'process raft request' (duration: 103.224436ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.519269Z","caller":"traceutil/trace.go:171","msg":"trace[929383563] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"142.560674ms","start":"2026-02-26T06:11:03.376694Z","end":"2026-02-26T06:11:03.519255Z","steps":["trace[929383563] 'process raft request' (duration: 141.884012ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.859038Z","caller":"traceutil/trace.go:171","msg":"trace[1272190367] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"255.942199ms","start":"2026-02-26T06:11:03.603065Z","end":"2026-02-26T06:11:03.859007Z","steps":["trace[1272190367] 'process raft request' (duration: 177.539164ms)","trace[1272190367] 'compare' (duration: 78.1533ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:03.859365Z","caller":"traceutil/trace.go:171","msg":"trace[951302593] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"254.688025ms","start":"2026-02-26T06:11:03.604656Z","end":"2026-02-26T06:11:03.859344Z","steps":["trace[951302593] 'process raft request' (duration: 254.473771ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.859564Z","caller":"traceutil/trace.go:171","msg":"trace[696541984] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"255.824117ms","start":"2026-02-26T06:11:03.60373Z","end":"2026-02-26T06:11:03.859554Z","steps":["trace[696541984] 'process raft request' (duration: 255.209705ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.85957Z","caller":"traceutil/trace.go:171","msg":"trace[1442240178] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:385; }","duration":"135.507195ms","start":"2026-02-26T06:11:03.72404Z","end":"2026-02-26T06:11:03.859547Z","steps":["trace[1442240178] 'read index received' (duration: 56.576129ms)","trace[1442240178] 'applied index is now lower than readState.Index' (duration: 78.928045ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:03.859731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.682617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T06:11:03.859774Z","caller":"traceutil/trace.go:171","msg":"trace[1835277218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:382; }","duration":"135.81888ms","start":"2026-02-26T06:11:03.723944Z","end":"2026-02-26T06:11:03.859763Z","steps":["trace[1835277218] 'agreement among raft nodes before linearized reading' (duration: 135.700698ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.859852Z","caller":"traceutil/trace.go:171","msg":"trace[1705405961] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"254.093805ms","start":"2026-02-26T06:11:03.605747Z","end":"2026-02-26T06:11:03.859841Z","steps":["trace[1705405961] 'process raft request' (duration: 253.618885ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.860022Z","caller":"traceutil/trace.go:171","msg":"trace[1885817936] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"253.248459ms","start":"2026-02-26T06:11:03.606756Z","end":"2026-02-26T06:11:03.860005Z","steps":["trace[1885817936] 'process raft request' (duration: 252.657897ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.860032Z","caller":"traceutil/trace.go:171","msg":"trace[1990928353] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"254.683635ms","start":"2026-02-26T06:11:03.605336Z","end":"2026-02-26T06:11:03.860019Z","steps":["trace[1990928353] 'process raft request' (duration: 253.995122ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.859948Z","caller":"traceutil/trace.go:171","msg":"trace[534683085] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"254.609034ms","start":"2026-02-26T06:11:03.605255Z","end":"2026-02-26T06:11:03.859864Z","steps":["trace[534683085] 'process raft request' (duration: 254.014773ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.860469Z","caller":"traceutil/trace.go:171","msg":"trace[1503298098] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"239.922171ms","start":"2026-02-26T06:11:03.620533Z","end":"2026-02-26T06:11:03.860455Z","steps":["trace[1503298098] 'process raft request' (duration: 238.925542ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.860484Z","caller":"traceutil/trace.go:171","msg":"trace[214859077] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"186.190964ms","start":"2026-02-26T06:11:03.674282Z","end":"2026-02-26T06:11:03.860473Z","steps":["trace[214859077] 'process raft request' (duration: 185.223837ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:03.860615Z","caller":"traceutil/trace.go:171","msg":"trace[338537463] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"255.623992ms","start":"2026-02-26T06:11:03.60497Z","end":"2026-02-26T06:11:03.860594Z","steps":["trace[338537463] 'process raft request' (duration: 254.258177ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:05.235669Z","caller":"traceutil/trace.go:171","msg":"trace[1167185262] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"229.880701ms","start":"2026-02-26T06:11:05.005764Z","end":"2026-02-26T06:11:05.235645Z","steps":["trace[1167185262] 'process raft request' (duration: 229.389442ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:05.787398Z","caller":"traceutil/trace.go:171","msg":"trace[1574917052] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"179.261353ms","start":"2026-02-26T06:11:05.608101Z","end":"2026-02-26T06:11:05.787362Z","steps":["trace[1574917052] 'process raft request' (duration: 179.041619ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:05.796084Z","caller":"traceutil/trace.go:171","msg":"trace[233516305] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"185.608602ms","start":"2026-02-26T06:11:05.610451Z","end":"2026-02-26T06:11:05.796059Z","steps":["trace[233516305] 'process raft request' (duration: 185.460029ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:06.605049Z","caller":"traceutil/trace.go:171","msg":"trace[1374909223] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"169.298727ms","start":"2026-02-26T06:11:06.435686Z","end":"2026-02-26T06:11:06.604985Z","steps":["trace[1374909223] 'process raft request' (duration: 169.072113ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:06.796091Z","caller":"traceutil/trace.go:171","msg":"trace[1664233752] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"119.350131ms","start":"2026-02-26T06:11:06.676716Z","end":"2026-02-26T06:11:06.796066Z","steps":["trace[1664233752] 'process raft request' (duration: 118.79022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:07.078604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.939537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-02-26T06:11:07.078701Z","caller":"traceutil/trace.go:171","msg":"trace[1993958383] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:400; }","duration":"171.099671ms","start":"2026-02-26T06:11:06.90758Z","end":"2026-02-26T06:11:07.078679Z","steps":["trace[1993958383] 'range keys from in-memory index tree' (duration: 170.753943ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:08.247091Z","caller":"traceutil/trace.go:171","msg":"trace[407560947] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"208.526761ms","start":"2026-02-26T06:11:08.03853Z","end":"2026-02-26T06:11:08.247056Z","steps":["trace[407560947] 'process raft request' (duration: 207.752568ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:08.247211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.605385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T06:11:08.247301Z","caller":"traceutil/trace.go:171","msg":"trace[987529861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"206.774988ms","start":"2026-02-26T06:11:08.040503Z","end":"2026-02-26T06:11:08.247278Z","steps":["trace[987529861] 'agreement among raft nodes before linearized reading' (duration: 206.595545ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:08.247127Z","caller":"traceutil/trace.go:171","msg":"trace[703674450] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"206.455793ms","start":"2026-02-26T06:11:08.040582Z","end":"2026-02-26T06:11:08.247038Z","steps":["trace[703674450] 'read index received' (duration: 205.406463ms)","trace[703674450] 'applied index is now lower than readState.Index' (duration: 1.0477ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:16.347708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120012766601185,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T06:11:16.348228Z","caller":"traceutil/trace.go:171","msg":"trace[189281937] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:472; }","duration":"500.685269ms","start":"2026-02-26T06:11:15.847488Z","end":"2026-02-26T06:11:16.348174Z","steps":["trace[189281937] 'read index received' (duration: 500.477435ms)","trace[189281937] 'applied index is now lower than readState.Index' (duration: 205.754µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:16.34831Z","caller":"traceutil/trace.go:171","msg":"trace[976793388] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"507.713698ms","start":"2026-02-26T06:11:15.840547Z","end":"2026-02-26T06:11:16.348261Z","steps":["trace[976793388] 'process raft request' (duration: 507.310411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:16.348327Z","caller":"etcdserver/v3_server.go:874","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":3219120012766601187,"received-request-id":3219120012766601185} {"level":"warn","ts":"2026-02-26T06:11:16.348504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:15.840526Z","time spent":"507.868811ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T06:11:16.348538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.005494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T06:11:16.3486Z","caller":"traceutil/trace.go:171","msg":"trace[814034775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"501.118047ms","start":"2026-02-26T06:11:15.847464Z","end":"2026-02-26T06:11:16.348582Z","steps":["trace[814034775] 'agreement among raft nodes before linearized reading' (duration: 500.896523ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:16.348656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:15.847456Z","time spent":"501.190048ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T06:11:16.812654Z","caller":"traceutil/trace.go:171","msg":"trace[451341288] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"457.713885ms","start":"2026-02-26T06:11:16.3549Z","end":"2026-02-26T06:11:16.812614Z","steps":["trace[451341288] 'process raft request' (duration: 457.660665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:16.812899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:16.354875Z","time spent":"457.877808ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:16.813398Z","caller":"traceutil/trace.go:171","msg":"trace[1837090350] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"458.579041ms","start":"2026-02-26T06:11:16.354794Z","end":"2026-02-26T06:11:16.813373Z","steps":["trace[1837090350] 'process raft request' (duration: 457.713886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:16.813491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:16.354772Z","time spent":"458.677672ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:16.8136Z","caller":"traceutil/trace.go:171","msg":"trace[1590380771] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"458.907928ms","start":"2026-02-26T06:11:16.35468Z","end":"2026-02-26T06:11:16.813588Z","steps":["trace[1590380771] 'process raft request' (duration: 451.113893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:16.81376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:16.354651Z","time spent":"458.982359ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:22.713431Z","caller":"traceutil/trace.go:171","msg":"trace[1563343442] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"340.788966ms","start":"2026-02-26T06:11:22.372618Z","end":"2026-02-26T06:11:22.713407Z","steps":["trace[1563343442] 'process raft request' (duration: 340.656694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:22.713593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:22.372602Z","time spent":"340.896027ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T06:11:30.006259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.083515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T06:11:30.006389Z","caller":"traceutil/trace.go:171","msg":"trace[1838330353] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"468.207852ms","start":"2026-02-26T06:11:29.53816Z","end":"2026-02-26T06:11:30.006368Z","steps":["trace[1838330353] 'process raft request' (duration: 85.943965ms)","trace[1838330353] 'compare' (duration: 381.933583ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:30.006441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:29.538143Z","time spent":"468.277494ms","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T06:11:30.315371Z","caller":"traceutil/trace.go:171","msg":"trace[2059634608] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"378.600546ms","start":"2026-02-26T06:11:29.936748Z","end":"2026-02-26T06:11:30.315349Z","steps":["trace[2059634608] 'read index received' (duration: 378.556555ms)","trace[2059634608] 'applied index is now lower than readState.Index' (duration: 43.441µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:30.315485Z","caller":"traceutil/trace.go:171","msg":"trace[308983434] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"574.633573ms","start":"2026-02-26T06:11:29.740818Z","end":"2026-02-26T06:11:30.315452Z","steps":["trace[308983434] 'process raft request' (duration: 574.4183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:30.31563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:29.740795Z","time spent":"574.769686ms","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T06:11:30.315573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.787189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:30.315699Z","caller":"traceutil/trace.go:171","msg":"trace[1157010509] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:552; }","duration":"379.000881ms","start":"2026-02-26T06:11:29.93669Z","end":"2026-02-26T06:11:30.315691Z","steps":["trace[1157010509] 'agreement among raft nodes before linearized reading' (duration: 378.765528ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:30.315721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:29.936667Z","time spent":"379.047632ms","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-26T06:11:30.320148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.838153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:30.320544Z","caller":"traceutil/trace.go:171","msg":"trace[440312434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"374.31066ms","start":"2026-02-26T06:11:29.946205Z","end":"2026-02-26T06:11:30.320516Z","steps":["trace[440312434] 'agreement among raft nodes before linearized reading' (duration: 373.804652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:30.320611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.891822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:30.32067Z","caller":"traceutil/trace.go:171","msg":"trace[1968067107] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:553; }","duration":"183.985794ms","start":"2026-02-26T06:11:30.136666Z","end":"2026-02-26T06:11:30.320652Z","steps":["trace[1968067107] 'agreement among raft nodes before linearized reading' (duration: 183.899141ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:30.320397Z","caller":"traceutil/trace.go:171","msg":"trace[1329284797] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"309.539716ms","start":"2026-02-26T06:11:30.010832Z","end":"2026-02-26T06:11:30.320372Z","steps":["trace[1329284797] 'process raft request' (duration: 309.004038ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:30.320788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:30.010811Z","time spent":"309.919562ms","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T06:11:30.320645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:29.946184Z","time spent":"374.437852ms","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T06:11:33.044909Z","caller":"traceutil/trace.go:171","msg":"trace[319365474] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"283.033817ms","start":"2026-02-26T06:11:32.761843Z","end":"2026-02-26T06:11:33.044876Z","steps":["trace[319365474] 'read index received' (duration: 282.856674ms)","trace[319365474] 'applied index is now lower than readState.Index' (duration: 175.893µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:33.044982Z","caller":"traceutil/trace.go:171","msg":"trace[1053339400] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"291.492057ms","start":"2026-02-26T06:11:32.75345Z","end":"2026-02-26T06:11:33.044942Z","steps":["trace[1053339400] 'process raft request' (duration: 291.266174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.280941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.045236Z","caller":"traceutil/trace.go:171","msg":"trace[1195854057] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:599; }","duration":"283.412693ms","start":"2026-02-26T06:11:32.761808Z","end":"2026-02-26T06:11:33.04522Z","steps":["trace[1195854057] 'agreement among raft nodes before linearized reading' (duration: 283.2279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.222982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.045386Z","caller":"traceutil/trace.go:171","msg":"trace[1974248883] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:599; }","duration":"283.344893ms","start":"2026-02-26T06:11:32.762018Z","end":"2026-02-26T06:11:33.045363Z","steps":["trace[1974248883] 'agreement among raft nodes before linearized reading' (duration: 283.19005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.865656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T06:11:33.045567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.963641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-26T06:11:33.045588Z","caller":"traceutil/trace.go:171","msg":"trace[892903051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"143.930106ms","start":"2026-02-26T06:11:32.901653Z","end":"2026-02-26T06:11:33.045583Z","steps":["trace[892903051] 'agreement among raft nodes before linearized reading' (duration: 143.838315ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:33.045609Z","caller":"traceutil/trace.go:171","msg":"trace[1606314306] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:599; }","duration":"109.021022ms","start":"2026-02-26T06:11:32.936575Z","end":"2026-02-26T06:11:33.045596Z","steps":["trace[1606314306] 'agreement among raft nodes before linearized reading' (duration: 108.842139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.691126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T06:11:33.045675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.307633ms","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-26T06:11:33.045691Z","caller":"traceutil/trace.go:171","msg":"trace[1157212147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"142.390394ms","start":"2026-02-26T06:11:32.903297Z","end":"2026-02-26T06:11:33.045687Z","steps":["trace[1157212147] 'agreement among raft nodes before linearized reading' (duration: 142.360543ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:33.045691Z","caller":"traceutil/trace.go:171","msg":"trace[30704486] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:599; }","duration":"264.745158ms","start":"2026-02-26T06:11:32.780935Z","end":"2026-02-26T06:11:33.045681Z","steps":["trace[30704486] 'agreement among raft nodes before linearized reading' (duration: 264.698267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.900369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T06:11:33.045612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.399408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.045926Z","caller":"traceutil/trace.go:171","msg":"trace[1218314608] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:599; }","duration":"248.469017ms","start":"2026-02-26T06:11:32.797451Z","end":"2026-02-26T06:11:33.04592Z","steps":["trace[1218314608] 'agreement among raft nodes before linearized reading' (duration: 247.865388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.045929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.337627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.045961Z","caller":"traceutil/trace.go:171","msg":"trace[1757607309] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:599; }","duration":"265.461749ms","start":"2026-02-26T06:11:32.780489Z","end":"2026-02-26T06:11:33.045951Z","steps":["trace[1757607309] 'agreement among raft nodes before linearized reading' (duration: 265.377318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.046031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.604771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.046052Z","caller":"traceutil/trace.go:171","msg":"trace[1545363552] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:599; }","duration":"265.640161ms","start":"2026-02-26T06:11:32.780407Z","end":"2026-02-26T06:11:33.046047Z","steps":["trace[1545363552] 'agreement among raft nodes before linearized reading' (duration: 265.605261ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:33.046026Z","caller":"traceutil/trace.go:171","msg":"trace[1380946681] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:599; }","duration":"248.791193ms","start":"2026-02-26T06:11:32.797188Z","end":"2026-02-26T06:11:33.045979Z","steps":["trace[1380946681] 'agreement among raft nodes before linearized reading' (duration: 248.395797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.046108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.899661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.046123Z","caller":"traceutil/trace.go:171","msg":"trace[1544722926] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:599; }","duration":"283.932681ms","start":"2026-02-26T06:11:32.762186Z","end":"2026-02-26T06:11:33.046118Z","steps":["trace[1544722926] 'agreement among raft nodes before linearized reading' (duration: 283.911231ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.046331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.710127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T06:11:33.046421Z","caller":"traceutil/trace.go:171","msg":"trace[903679261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"155.852489ms","start":"2026-02-26T06:11:32.890554Z","end":"2026-02-26T06:11:33.046406Z","steps":["trace[903679261] 'agreement among raft nodes before linearized reading' (duration: 155.704867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:33.047209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.263555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:33.047276Z","caller":"traceutil/trace.go:171","msg":"trace[937342484] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:599; }","duration":"249.625976ms","start":"2026-02-26T06:11:32.797632Z","end":"2026-02-26T06:11:33.047258Z","steps":["trace[937342484] 'agreement among raft nodes before linearized reading' (duration: 248.156653ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:36.954019Z","caller":"traceutil/trace.go:171","msg":"trace[1414193261] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"379.555096ms","start":"2026-02-26T06:11:36.574444Z","end":"2026-02-26T06:11:36.953999Z","steps":["trace[1414193261] 'process raft request' (duration: 379.13845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:36.954131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:36.574435Z","time spent":"379.638137ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:37.454418Z","caller":"traceutil/trace.go:171","msg":"trace[910848162] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"392.489032ms","start":"2026-02-26T06:11:37.061899Z","end":"2026-02-26T06:11:37.454388Z","steps":["trace[910848162] 'read index received' (duration: 392.287468ms)","trace[910848162] 'applied index is now lower than readState.Index' (duration: 200.914µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:11:37.454653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.79655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-26T06:11:37.454689Z","caller":"traceutil/trace.go:171","msg":"trace[825487032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"389.889541ms","start":"2026-02-26T06:11:37.064791Z","end":"2026-02-26T06:11:37.45468Z","steps":["trace[825487032] 'agreement among raft nodes before linearized reading' (duration: 389.727849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:37.454678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.013992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-26T06:11:37.454678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.665913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T06:11:37.454725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:37.06477Z","time spent":"389.948913ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T06:11:37.454742Z","caller":"traceutil/trace.go:171","msg":"trace[1782573813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"388.114803ms","start":"2026-02-26T06:11:37.066615Z","end":"2026-02-26T06:11:37.454729Z","steps":["trace[1782573813] 'agreement among raft nodes before linearized reading' (duration: 387.92929ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:37.454756Z","caller":"traceutil/trace.go:171","msg":"trace[1982181668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"388.778614ms","start":"2026-02-26T06:11:37.065963Z","end":"2026-02-26T06:11:37.454742Z","steps":["trace[1982181668] 'agreement among raft nodes before linearized reading' (duration: 388.578081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:37.454745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.820997ms","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-26T06:11:37.454486Z","caller":"traceutil/trace.go:171","msg":"trace[332415858] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"453.235805ms","start":"2026-02-26T06:11:37.001214Z","end":"2026-02-26T06:11:37.45445Z","steps":["trace[332415858] 'process raft request' (duration: 453.049892ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:37.454858Z","caller":"traceutil/trace.go:171","msg":"trace[1470076265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"392.99621ms","start":"2026-02-26T06:11:37.061841Z","end":"2026-02-26T06:11:37.454837Z","steps":["trace[1470076265] 'agreement among raft nodes before linearized reading' (duration: 392.665275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:37.454789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:37.066604Z","time spent":"388.177244ms","remote":"127.0.0.1:49076","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-26T06:11:37.454912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:37.061808Z","time spent":"393.094262ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T06:11:37.454945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:37.001193Z","time spent":"453.677751ms","remote":"127.0.0.1:49014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T06:11:37.454791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:37.065949Z","time spent":"388.835415ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T06:11:37.737372Z","caller":"traceutil/trace.go:171","msg":"trace[250160239] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"270.063381ms","start":"2026-02-26T06:11:37.467284Z","end":"2026-02-26T06:11:37.737348Z","steps":["trace[250160239] 'process raft request' (duration: 264.470085ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:37.737703Z","caller":"traceutil/trace.go:171","msg":"trace[1296900306] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"264.994782ms","start":"2026-02-26T06:11:37.472693Z","end":"2026-02-26T06:11:37.737688Z","steps":["trace[1296900306] 'process raft request' (duration: 264.81475ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:37.737669Z","caller":"traceutil/trace.go:171","msg":"trace[1481595890] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:635; }","duration":"216.339829ms","start":"2026-02-26T06:11:37.521294Z","end":"2026-02-26T06:11:37.737634Z","steps":["trace[1481595890] 'read index received' (duration: 210.393107ms)","trace[1481595890] 'applied index is now lower than readState.Index' (duration: 5.945421ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T06:11:37.737714Z","caller":"traceutil/trace.go:171","msg":"trace[2095123034] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"270.301565ms","start":"2026-02-26T06:11:37.467381Z","end":"2026-02-26T06:11:37.737682Z","steps":["trace[2095123034] 'process raft request' (duration: 269.92596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:37.737854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.536961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-26T06:11:37.737898Z","caller":"traceutil/trace.go:171","msg":"trace[412972965] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:618; }","duration":"216.618352ms","start":"2026-02-26T06:11:37.521268Z","end":"2026-02-26T06:11:37.737886Z","steps":["trace[412972965] 'agreement among raft nodes before linearized reading' (duration: 216.527821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:37.737887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.084659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T06:11:37.737984Z","caller":"traceutil/trace.go:171","msg":"trace[596418053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"170.223501ms","start":"2026-02-26T06:11:37.567742Z","end":"2026-02-26T06:11:37.737965Z","steps":["trace[596418053] 'agreement among raft nodes before linearized reading' (duration: 170.086329ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:39.141684Z","caller":"traceutil/trace.go:171","msg":"trace[1498598113] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"178.940509ms","start":"2026-02-26T06:11:38.962716Z","end":"2026-02-26T06:11:39.141656Z","steps":["trace[1498598113] 'process raft request' (duration: 178.746156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.508873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.31474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T06:11:40.508891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.221068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-26T06:11:40.508976Z","caller":"traceutil/trace.go:171","msg":"trace[1856462374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"766.502892ms","start":"2026-02-26T06:11:39.742448Z","end":"2026-02-26T06:11:40.508951Z","steps":["trace[1856462374] 'range keys from in-memory index tree' (duration: 766.041626ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:40.508985Z","caller":"traceutil/trace.go:171","msg":"trace[760610337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"766.329241ms","start":"2026-02-26T06:11:39.742634Z","end":"2026-02-26T06:11:40.508963Z","steps":["trace[760610337] 'range keys from in-memory index tree' (duration: 766.052386ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.509033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:39.742602Z","time spent":"766.420131ms","remote":"127.0.0.1:49076","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-26T06:11:40.509036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:39.742424Z","time spent":"766.600625ms","remote":"127.0.0.1:49076","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-26T06:11:40.509064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.668415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T06:11:40.508896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013994932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-26T06:11:40.509134Z","caller":"traceutil/trace.go:171","msg":"trace[859711600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"766.784707ms","start":"2026-02-26T06:11:39.742336Z","end":"2026-02-26T06:11:40.509121Z","steps":["trace[859711600] 'range keys from in-memory index tree' (duration: 766.489743ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.509174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:39.742306Z","time spent":"766.855638ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-26T06:11:40.509177Z","caller":"traceutil/trace.go:171","msg":"trace[1974600392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"1.014297007s","start":"2026-02-26T06:11:39.494845Z","end":"2026-02-26T06:11:40.509142Z","steps":["trace[1974600392] 'range keys from in-memory index tree' (duration: 1.01383608s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.50928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:39.494812Z","time spent":"1.014432539s","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T06:11:40.959086Z","caller":"traceutil/trace.go:171","msg":"trace[255929514] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"444.967076ms","start":"2026-02-26T06:11:40.514088Z","end":"2026-02-26T06:11:40.959055Z","steps":["trace[255929514] 'process raft request' (duration: 444.873835ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.959451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:40.514084Z","time spent":"445.100488ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:40.959129Z","caller":"traceutil/trace.go:171","msg":"trace[2072226892] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"445.052247ms","start":"2026-02-26T06:11:40.513992Z","end":"2026-02-26T06:11:40.959044Z","steps":["trace[2072226892] 'process raft request' (duration: 444.765672ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:11:40.959503Z","caller":"traceutil/trace.go:171","msg":"trace[873415542] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"445.348942ms","start":"2026-02-26T06:11:40.514113Z","end":"2026-02-26T06:11:40.959462Z","steps":["trace[873415542] 'process raft request' (duration: 444.896205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:11:40.959655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:40.513986Z","time spent":"445.571866ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T06:11:40.959721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:11:40.514083Z","time spent":"445.504324ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T06:11:45.310599Z","caller":"traceutil/trace.go:171","msg":"trace[1519255734] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"135.283049ms","start":"2026-02-26T06:11:45.175291Z","end":"2026-02-26T06:11:45.310574Z","steps":["trace[1519255734] 'process raft request' (duration: 135.148067ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:13:09.665373Z","caller":"traceutil/trace.go:171","msg":"trace[607027259] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1061; }","duration":"279.346287ms","start":"2026-02-26T06:13:09.386Z","end":"2026-02-26T06:13:09.665346Z","steps":["trace[607027259] 'read index received' (duration: 279.121644ms)","trace[607027259] 'applied index is now lower than readState.Index' (duration: 223.823µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T06:13:09.66555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.534851ms","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-26T06:13:09.665486Z","caller":"traceutil/trace.go:171","msg":"trace[1833838215] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"621.62908ms","start":"2026-02-26T06:13:09.043822Z","end":"2026-02-26T06:13:09.665451Z","steps":["trace[1833838215] 'process raft request' (duration: 621.357015ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:13:09.665591Z","caller":"traceutil/trace.go:171","msg":"trace[798870161] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1019; }","duration":"279.628363ms","start":"2026-02-26T06:13:09.385953Z","end":"2026-02-26T06:13:09.665581Z","steps":["trace[798870161] 'agreement among raft nodes before linearized reading' (duration: 279.543032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:13:09.665761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.349783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-26T06:13:09.6658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.284274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T06:13:09.665835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.003687ms","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-26T06:13:09.665966Z","caller":"traceutil/trace.go:171","msg":"trace[1264644168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1019; }","duration":"239.2084ms","start":"2026-02-26T06:13:09.426732Z","end":"2026-02-26T06:13:09.665941Z","steps":["trace[1264644168] 'agreement among raft nodes before linearized reading' (duration: 238.927996ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:13:09.665976Z","caller":"traceutil/trace.go:171","msg":"trace[264641852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1019; }","duration":"238.433266ms","start":"2026-02-26T06:13:09.427478Z","end":"2026-02-26T06:13:09.665911Z","steps":["trace[264641852] 'agreement among raft nodes before linearized reading' (duration: 238.174191ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T06:13:09.665849Z","caller":"traceutil/trace.go:171","msg":"trace[779689439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1019; }","duration":"239.482134ms","start":"2026-02-26T06:13:09.426349Z","end":"2026-02-26T06:13:09.665831Z","steps":["trace[779689439] 'agreement among raft nodes before linearized reading' (duration: 239.22482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T06:13:09.665775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T06:13:09.043806Z","time spent":"621.844674ms","remote":"127.0.0.1:49076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}