{"level":"warn","ts":"2026-02-17T16:07:41.293255Z","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-17T16:07:41.293355Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.12:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.12:2380","--initial-cluster=instance=https://162.253.55.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.12: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-17T16:07:41.293437Z","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-17T16:07:41.293458Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-17T16:07:41.293481Z","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-17T16:07:41.297607Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"]} {"level":"info","ts":"2026-02-17T16:07:41.29773Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.12: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-17T16:07:41.308774Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.759869ms"} {"level":"info","ts":"2026-02-17T16:07:41.332153Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"} {"level":"info","ts":"2026-02-17T16:07:41.332329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T16:07:41.33235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"} {"level":"info","ts":"2026-02-17T16:07:41.332427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4c6dc24a78438ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T16:07:41.332438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"} {"level":"info","ts":"2026-02-17T16:07:41.332529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"warn","ts":"2026-02-17T16:07:41.340863Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T16:07:41.345219Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T16:07:41.346568Z","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-17T16:07:41.348574Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4c6dc24a78438ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T16:07:41.349549Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4c6dc24a78438ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T16:07:41.349728Z","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-17T16:07:41.34981Z","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-17T16:07:41.349868Z","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-17T16:07:41.350133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"info","ts":"2026-02-17T16:07:41.350269Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","added-peer-id":"b4c6dc24a78438ca","added-peer-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-17T16:07:41.357773Z","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-17T16:07:41.360058Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4c6dc24a78438ca","initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T16:07:41.360218Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T16:07:41.360398Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-17T16:07:41.36053Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-17T16:07:41.734833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T16:07:41.735044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T16:07:41.735142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"} {"level":"info","ts":"2026-02-17T16:07:41.73524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"} {"level":"info","ts":"2026-02-17T16:07:41.735326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-17T16:07:41.735396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"} {"level":"info","ts":"2026-02-17T16:07:41.735485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-17T16:07:41.737112Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4c6dc24a78438ca","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.12:2379]}","request-path":"/0/members/b4c6dc24a78438ca/attributes","cluster-id":"587227f9a3f73e98","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T16:07:41.737321Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:07:41.737815Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:07:41.738155Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:07:41.738245Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T16:07:41.738651Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T16:07:41.738753Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:07:41.738894Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:07:41.73899Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:07:41.740377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"} {"level":"info","ts":"2026-02-17T16:07:41.741619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T16:07:46.088902Z","caller":"traceutil/trace.go:171","msg":"trace[116711906] linearizableReadLoop","detail":"{readStateIndex:212; appliedIndex:211; }","duration":"198.846515ms","start":"2026-02-17T16:07:45.890034Z","end":"2026-02-17T16:07:46.088881Z","steps":["trace[116711906] 'read index received' (duration: 10.660937ms)","trace[116711906] 'applied index is now lower than readState.Index' (duration: 188.184818ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:07:46.089727Z","caller":"traceutil/trace.go:171","msg":"trace[1595248971] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"200.638305ms","start":"2026-02-17T16:07:45.889054Z","end":"2026-02-17T16:07:46.089692Z","steps":["trace[1595248971] 'process raft request' (duration: 101.671461ms)","trace[1595248971] 'compare' (duration: 97.855063ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:07:46.090187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.130336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-17T16:07:46.090234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.072186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:07:46.090271Z","caller":"traceutil/trace.go:171","msg":"trace[1537312758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:208; }","duration":"200.313156ms","start":"2026-02-17T16:07:45.88994Z","end":"2026-02-17T16:07:46.090253Z","steps":["trace[1537312758] 'agreement among raft nodes before linearized reading' (duration: 200.158885ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:07:46.090296Z","caller":"traceutil/trace.go:171","msg":"trace[853173513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:208; }","duration":"200.219167ms","start":"2026-02-17T16:07:45.890064Z","end":"2026-02-17T16:07:46.090284Z","steps":["trace[853173513] 'agreement among raft nodes before linearized reading' (duration: 200.102376ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:07:46.090812Z","caller":"traceutil/trace.go:171","msg":"trace[1164555842] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"198.600557ms","start":"2026-02-17T16:07:45.8922Z","end":"2026-02-17T16:07:46.090801Z","steps":["trace[1164555842] 'process raft request' (duration: 196.621605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.203088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271406326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:07:59.203183Z","caller":"traceutil/trace.go:171","msg":"trace[2135531531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:371; }","duration":"1.271539978s","start":"2026-02-17T16:07:57.931624Z","end":"2026-02-17T16:07:59.203164Z","steps":["trace[2135531531] 'range keys from in-memory index tree' (duration: 1.271321425s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.203223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:57.931607Z","time spent":"1.271606749s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:07:59.203688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.256698688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"info","ts":"2026-02-17T16:07:59.203745Z","caller":"traceutil/trace.go:171","msg":"trace[1886079454] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:371; }","duration":"1.256793419s","start":"2026-02-17T16:07:57.946937Z","end":"2026-02-17T16:07:59.203731Z","steps":["trace[1886079454] 'range keys from in-memory index tree' (duration: 1.256579687s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.203769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:57.94692Z","time spent":"1.256843379s","remote":"127.0.0.1:42426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T16:07:59.203898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252397151s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:07:59.203913Z","caller":"traceutil/trace.go:171","msg":"trace[795041873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:371; }","duration":"1.252426021s","start":"2026-02-17T16:07:57.951481Z","end":"2026-02-17T16:07:59.203907Z","steps":["trace[795041873] 'range keys from in-memory index tree' (duration: 1.252353369s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.203925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:57.951474Z","time spent":"1.252449091s","remote":"127.0.0.1:42504","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-17T16:07:59.204049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205655757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"info","ts":"2026-02-17T16:07:59.204062Z","caller":"traceutil/trace.go:171","msg":"trace[240680510] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:371; }","duration":"1.205705877s","start":"2026-02-17T16:07:57.998353Z","end":"2026-02-17T16:07:59.204058Z","steps":["trace[240680510] 'range keys from in-memory index tree' (duration: 1.205606416s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.204074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:57.99834Z","time spent":"1.205730717s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4279,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-17T16:07:59.204284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052212981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T16:07:59.204297Z","caller":"traceutil/trace.go:171","msg":"trace[2053724863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:371; }","duration":"1.052265602s","start":"2026-02-17T16:07:58.152027Z","end":"2026-02-17T16:07:59.204293Z","steps":["trace[2053724863] 'range keys from in-memory index tree' (duration: 1.051695542s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.204311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:58.152002Z","time spent":"1.052306052s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T16:07:59.204378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03918105s","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-17T16:07:59.204392Z","caller":"traceutil/trace.go:171","msg":"trace[1465355663] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:371; }","duration":"1.039237071s","start":"2026-02-17T16:07:58.16515Z","end":"2026-02-17T16:07:59.204387Z","steps":["trace[1465355663] 'range keys from in-memory index tree' (duration: 1.039072309s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.204404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:58.165129Z","time spent":"1.039271911s","remote":"127.0.0.1:42504","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-17T16:07:59.204786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.598119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:07:59.204801Z","caller":"traceutil/trace.go:171","msg":"trace[1314587952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:371; }","duration":"870.64073ms","start":"2026-02-17T16:07:58.334155Z","end":"2026-02-17T16:07:59.204796Z","steps":["trace[1314587952] 'range keys from in-memory index tree' (duration: 870.556308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:07:59.204812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:58.334094Z","time spent":"870.714691ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:00.653552Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.434644023s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:08:00.653995Z","caller":"traceutil/trace.go:171","msg":"trace[528969542] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"1.4351152s","start":"2026-02-17T16:07:59.218856Z","end":"2026-02-17T16:08:00.653971Z","steps":["trace[528969542] 'process raft request' (duration: 1.434925097s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:00.65454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:59.218848Z","time spent":"1.435213871s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:01.66585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.476538ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:01.665983Z","caller":"traceutil/trace.go:171","msg":"trace[2054319034] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:372; }","duration":"399.60305ms","start":"2026-02-17T16:08:01.266341Z","end":"2026-02-17T16:08:01.665944Z","steps":["trace[2054319034] 'range keys from in-memory index tree' (duration: 399.462848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.666423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.380823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:01.66671Z","caller":"traceutil/trace.go:171","msg":"trace[200134166] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"2.447712239s","start":"2026-02-17T16:07:59.218984Z","end":"2026-02-17T16:08:01.666696Z","steps":["trace[200134166] 'process raft request' (duration: 2.304882808s)","trace[200134166] 'compare' (duration: 141.860594ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:01.666776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:59.218979Z","time spent":"2.44776723s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:01.667026Z","caller":"traceutil/trace.go:171","msg":"trace[1461900085] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"2.446600672s","start":"2026-02-17T16:07:59.220413Z","end":"2026-02-17T16:08:01.667014Z","steps":["trace[1461900085] 'process raft request' (duration: 2.446070823s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.667097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:59.220406Z","time spent":"2.446657523s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4241,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:01.667449Z","caller":"traceutil/trace.go:171","msg":"trace[840511632] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"2.444661813s","start":"2026-02-17T16:07:59.222776Z","end":"2026-02-17T16:08:01.667438Z","steps":["trace[840511632] 'process raft request' (duration: 2.444187414s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.667564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:59.222768Z","time spent":"2.444750644s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:01.673173Z","caller":"traceutil/trace.go:171","msg":"trace[586688643] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"2.450332683s","start":"2026-02-17T16:07:59.222809Z","end":"2026-02-17T16:08:01.673142Z","steps":["trace[586688643] 'process raft request' (duration: 2.444594202s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.673321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:07:59.222806Z","time spent":"2.450435925s","remote":"127.0.0.1:42504","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-17T16:08:01.808713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.772414ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:08:01.808883Z","caller":"traceutil/trace.go:171","msg":"trace[1768327087] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:385; }","duration":"1.475506256s","start":"2026-02-17T16:08:00.333327Z","end":"2026-02-17T16:08:01.808833Z","steps":["trace[1768327087] 'read index received' (duration: 321.630774ms)","trace[1768327087] 'applied index is now lower than readState.Index' (duration: 1.153874132s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:01.808978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.475647269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:01.809013Z","caller":"traceutil/trace.go:171","msg":"trace[987287422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:376; }","duration":"1.47571843s","start":"2026-02-17T16:08:00.333285Z","end":"2026-02-17T16:08:01.809003Z","steps":["trace[987287422] 'agreement among raft nodes before linearized reading' (duration: 1.475653049s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.809046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:00.333263Z","time spent":"1.475776371s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:01.810147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.387786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"info","ts":"2026-02-17T16:08:01.810185Z","caller":"traceutil/trace.go:171","msg":"trace[1053231233] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:376; }","duration":"136.445027ms","start":"2026-02-17T16:08:01.673731Z","end":"2026-02-17T16:08:01.810176Z","steps":["trace[1053231233] 'agreement among raft nodes before linearized reading' (duration: 136.368636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.810493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.454592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-17T16:08:01.810523Z","caller":"traceutil/trace.go:171","msg":"trace[390589306] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:376; }","duration":"605.522244ms","start":"2026-02-17T16:08:01.204993Z","end":"2026-02-17T16:08:01.810515Z","steps":["trace[390589306] 'agreement among raft nodes before linearized reading' (duration: 605.446883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:01.810549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:01.204969Z","time spent":"605.573554ms","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4057,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-17T16:08:01.959645Z","caller":"traceutil/trace.go:171","msg":"trace[648122160] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"136.347606ms","start":"2026-02-17T16:08:01.823277Z","end":"2026-02-17T16:08:01.959625Z","steps":["trace[648122160] 'process raft request' (duration: 136.234244ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:01.959923Z","caller":"traceutil/trace.go:171","msg":"trace[1812084697] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:391; }","duration":"131.46108ms","start":"2026-02-17T16:08:01.828437Z","end":"2026-02-17T16:08:01.959898Z","steps":["trace[1812084697] 'read index received' (duration: 131.432139ms)","trace[1812084697] 'applied index is now lower than readState.Index' (duration: 27.02µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:01.960054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.595702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:01.960077Z","caller":"traceutil/trace.go:171","msg":"trace[1643455867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:377; }","duration":"131.656473ms","start":"2026-02-17T16:08:01.828413Z","end":"2026-02-17T16:08:01.960069Z","steps":["trace[1643455867] 'agreement among raft nodes before linearized reading' (duration: 131.560021ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:01.963366Z","caller":"traceutil/trace.go:171","msg":"trace[1557620169] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"134.030125ms","start":"2026-02-17T16:08:01.829326Z","end":"2026-02-17T16:08:01.963356Z","steps":["trace[1557620169] 'process raft request' (duration: 133.956873ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:06.876566Z","caller":"traceutil/trace.go:171","msg":"trace[143617898] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"122.359742ms","start":"2026-02-17T16:08:06.754191Z","end":"2026-02-17T16:08:06.876551Z","steps":["trace[143617898] 'process raft request' (duration: 122.27897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:10.565087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.812637ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-17T16:08:19.615361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.678241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:19.615543Z","caller":"traceutil/trace.go:171","msg":"trace[1190949324] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"611.231852ms","start":"2026-02-17T16:08:19.004297Z","end":"2026-02-17T16:08:19.615529Z","steps":["trace[1190949324] 'process raft request' (duration: 611.198561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:19.615606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:19.004278Z","time spent":"611.296974ms","remote":"127.0.0.1:42504","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-17T16:08:19.615868Z","caller":"traceutil/trace.go:171","msg":"trace[1950752149] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"631.417967ms","start":"2026-02-17T16:08:18.984437Z","end":"2026-02-17T16:08:19.615855Z","steps":["trace[1950752149] 'process raft request' (duration: 378.178517ms)","trace[1950752149] 'compare' (duration: 252.238906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:19.615922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:18.984429Z","time spent":"631.463938ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:19.616031Z","caller":"traceutil/trace.go:171","msg":"trace[425355732] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"625.635609ms","start":"2026-02-17T16:08:18.990385Z","end":"2026-02-17T16:08:19.616021Z","steps":["trace[425355732] 'process raft request' (duration: 625.05778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:19.616079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:18.990375Z","time spent":"625.67714ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:19.616181Z","caller":"traceutil/trace.go:171","msg":"trace[966086526] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:493; }","duration":"617.791035ms","start":"2026-02-17T16:08:18.99838Z","end":"2026-02-17T16:08:19.616171Z","steps":["trace[966086526] 'read index received' (duration: 364.244966ms)","trace[966086526] 'applied index is now lower than readState.Index' (duration: 253.545159ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:19.616287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.454261ms","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-17T16:08:19.616315Z","caller":"traceutil/trace.go:171","msg":"trace[977925268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:478; }","duration":"632.491722ms","start":"2026-02-17T16:08:18.983814Z","end":"2026-02-17T16:08:19.616306Z","steps":["trace[977925268] 'agreement among raft nodes before linearized reading' (duration: 632.394018ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:19.616341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:18.983809Z","time spent":"632.524953ms","remote":"127.0.0.1:42504","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-17T16:08:19.616421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.026576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:19.616447Z","caller":"traceutil/trace.go:171","msg":"trace[1417852591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"632.060018ms","start":"2026-02-17T16:08:18.984378Z","end":"2026-02-17T16:08:19.616438Z","steps":["trace[1417852591] 'agreement among raft nodes before linearized reading' (duration: 632.021457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:19.616505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:18.984373Z","time spent":"632.089569ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:20.609826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.450759ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:08:21.735691Z","caller":"traceutil/trace.go:171","msg":"trace[2049981762] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"106.935564ms","start":"2026-02-17T16:08:21.628731Z","end":"2026-02-17T16:08:21.735667Z","steps":["trace[2049981762] 'read index received' (duration: 106.721526ms)","trace[2049981762] 'applied index is now lower than readState.Index' (duration: 212.638µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:21.735801Z","caller":"traceutil/trace.go:171","msg":"trace[1375989692] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"109.154791ms","start":"2026-02-17T16:08:21.626636Z","end":"2026-02-17T16:08:21.73579Z","steps":["trace[1375989692] 'process raft request' (duration: 108.808669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:21.736075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.323097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:08:21.736111Z","caller":"traceutil/trace.go:171","msg":"trace[1441773202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:480; }","duration":"107.382439ms","start":"2026-02-17T16:08:21.628717Z","end":"2026-02-17T16:08:21.7361Z","steps":["trace[1441773202] 'agreement among raft nodes before linearized reading' (duration: 107.244084ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:21.979455Z","caller":"traceutil/trace.go:171","msg":"trace[764571015] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"225.440688ms","start":"2026-02-17T16:08:21.754Z","end":"2026-02-17T16:08:21.97944Z","steps":["trace[764571015] 'process raft request' (duration: 225.414557ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:21.979718Z","caller":"traceutil/trace.go:171","msg":"trace[1138914215] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"350.52195ms","start":"2026-02-17T16:08:21.62919Z","end":"2026-02-17T16:08:21.979712Z","steps":["trace[1138914215] 'process raft request' (duration: 306.479535ms)","trace[1138914215] 'compare' (duration: 43.655802ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:21.979775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:21.629182Z","time spent":"350.548581ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:21.979834Z","caller":"traceutil/trace.go:171","msg":"trace[17793761] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"244.066673ms","start":"2026-02-17T16:08:21.735761Z","end":"2026-02-17T16:08:21.979828Z","steps":["trace[17793761] 'read index received' (duration: 200.035238ms)","trace[17793761] 'applied index is now lower than readState.Index' (duration: 44.030945ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:21.979896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.898095ms","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-17T16:08:21.97991Z","caller":"traceutil/trace.go:171","msg":"trace[1284741148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"288.937357ms","start":"2026-02-17T16:08:21.690968Z","end":"2026-02-17T16:08:21.979906Z","steps":["trace[1284741148] 'agreement among raft nodes before linearized reading' (duration: 288.876475ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:22.252875Z","caller":"traceutil/trace.go:171","msg":"trace[1979441205] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"177.008348ms","start":"2026-02-17T16:08:22.075833Z","end":"2026-02-17T16:08:22.252841Z","steps":["trace[1979441205] 'process raft request' (duration: 143.844956ms)","trace[1979441205] 'compare' (duration: 32.982176ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:22.333529Z","caller":"traceutil/trace.go:171","msg":"trace[505428772] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"252.258218ms","start":"2026-02-17T16:08:22.081233Z","end":"2026-02-17T16:08:22.333492Z","steps":["trace[505428772] 'process raft request' (duration: 252.208787ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:22.334198Z","caller":"traceutil/trace.go:171","msg":"trace[1750563599] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"257.987211ms","start":"2026-02-17T16:08:22.0762Z","end":"2026-02-17T16:08:22.334187Z","steps":["trace[1750563599] 'process raft request' (duration: 257.10954ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:23.271711Z","caller":"traceutil/trace.go:171","msg":"trace[474725422] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"846.156162ms","start":"2026-02-17T16:08:22.425536Z","end":"2026-02-17T16:08:23.271692Z","steps":["trace[474725422] 'process raft request' (duration: 845.663104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:23.271825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:22.425518Z","time spent":"846.249625ms","remote":"127.0.0.1:42346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1427,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:24.240696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:24.741552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:25.242735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:25.743341Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:26.2436Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:26.333473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00024669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T16:08:26.333548Z","caller":"traceutil/trace.go:171","msg":"trace[620931304] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000363676s","start":"2026-02-17T16:08:24.333165Z","end":"2026-02-17T16:08:26.333528Z","steps":["trace[620931304] 'agreement among raft nodes before linearized reading' (duration: 2.000275222s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:26.333593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:24.333146Z","time spent":"2.000437658s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 16:08:26 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:26.743691Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:27.244589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:27.299326Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.870039943s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:08:28.333829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999948529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T16:08:28.333914Z","caller":"traceutil/trace.go:171","msg":"trace[1524351335] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000076744s","start":"2026-02-17T16:08:26.333817Z","end":"2026-02-17T16:08:28.333894Z","steps":["trace[1524351335] 'agreement among raft nodes before linearized reading' (duration: 1.99997452s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:28.333987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:26.333804Z","time spent":"2.000173618s","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 16:08:28 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:28.739941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999852993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T16:08:28.740021Z","caller":"traceutil/trace.go:171","msg":"trace[162950824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999992028s","start":"2026-02-17T16:08:23.74001Z","end":"2026-02-17T16:08:28.740002Z","steps":["trace[162950824] 'agreement among raft nodes before linearized reading' (duration: 4.999895134s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:28.740087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:23.739992Z","time spent":"5.000085751s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:08:28.983747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999472141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T16:08:28.983818Z","caller":"traceutil/trace.go:171","msg":"trace[363803861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999588725s","start":"2026-02-17T16:08:23.984216Z","end":"2026-02-17T16:08:28.983804Z","steps":["trace[363803861] 'agreement among raft nodes before linearized reading' (duration: 4.999501201s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:28.983852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:23.984198Z","time spent":"4.999646887s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/02/17 16:08:28 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:29.3316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.03196761s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:29.331708Z","caller":"traceutil/trace.go:171","msg":"trace[143444491] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"5.927193883s","start":"2026-02-17T16:08:23.404496Z","end":"2026-02-17T16:08:29.331689Z","steps":["trace[143444491] 'process raft request' (duration: 3.895053696s)","trace[143444491] 'compare' (duration: 2.031126987s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:29.331764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:23.404478Z","time spent":"5.927262916s","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2828,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:29.659349Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.359821247s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:08:30.095902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.1022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:30.096111Z","caller":"traceutil/trace.go:171","msg":"trace[1060926849] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:511; }","duration":"6.356021899s","start":"2026-02-17T16:08:23.740066Z","end":"2026-02-17T16:08:30.096088Z","steps":["trace[1060926849] 'read index received' (duration: 3.559496048s)","trace[1060926849] 'applied index is now lower than readState.Index' (duration: 2.796523361s)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:30.096396Z","caller":"traceutil/trace.go:171","msg":"trace[461655269] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"5.456967041s","start":"2026-02-17T16:08:24.639409Z","end":"2026-02-17T16:08:30.096376Z","steps":["trace[461655269] 'process raft request' (duration: 5.020284517s)","trace[461655269] 'compare' (duration: 435.933103ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:30.096496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:24.639393Z","time spent":"5.457047494s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:30.106559Z","caller":"traceutil/trace.go:171","msg":"trace[1993316679] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.768208833s","start":"2026-02-17T16:08:28.338334Z","end":"2026-02-17T16:08:30.106543Z","steps":["trace[1993316679] 'process raft request' (duration: 1.768100049s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.10664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:28.338308Z","time spent":"1.768301877s","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:30.106762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.121521113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:08:30.106796Z","caller":"traceutil/trace.go:171","msg":"trace[1715703961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:498; }","duration":"6.121575204s","start":"2026-02-17T16:08:23.985211Z","end":"2026-02-17T16:08:30.106786Z","steps":["trace[1715703961] 'agreement among raft nodes before linearized reading' (duration: 6.121450569s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.106824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:23.985203Z","time spent":"6.121613727s","remote":"127.0.0.1:42504","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-17T16:08:30.106938Z","caller":"traceutil/trace.go:171","msg":"trace[184352886] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"764.61575ms","start":"2026-02-17T16:08:29.342312Z","end":"2026-02-17T16:08:30.106928Z","steps":["trace[184352886] 'process raft request' (duration: 764.273656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.106993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:29.342303Z","time spent":"764.657863ms","remote":"127.0.0.1:42334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12712,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:30.107Z","caller":"traceutil/trace.go:171","msg":"trace[1253818111] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"839.106445ms","start":"2026-02-17T16:08:29.267883Z","end":"2026-02-17T16:08:30.10699Z","steps":["trace[1253818111] 'process raft request' (duration: 838.624585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.107183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:29.267858Z","time spent":"839.292012ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:30.107558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.765077951s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:30.108252Z","caller":"traceutil/trace.go:171","msg":"trace[740610119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"1.765787799s","start":"2026-02-17T16:08:28.342445Z","end":"2026-02-17T16:08:30.108233Z","steps":["trace[740610119] 'agreement among raft nodes before linearized reading' (duration: 1.764703375s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.10848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:28.342436Z","time spent":"1.76602573s","remote":"127.0.0.1:42244","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-17T16:08:30.108947Z","caller":"traceutil/trace.go:171","msg":"trace[316745684] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"766.896383ms","start":"2026-02-17T16:08:29.342032Z","end":"2026-02-17T16:08:30.108928Z","steps":["trace[316745684] 'process raft request' (duration: 764.515876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.109412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.82485501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:08:30.109465Z","caller":"traceutil/trace.go:171","msg":"trace[239170284] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:498; }","duration":"4.824967924s","start":"2026-02-17T16:08:25.284482Z","end":"2026-02-17T16:08:30.10945Z","steps":["trace[239170284] 'agreement among raft nodes before linearized reading' (duration: 4.824800327s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.109509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:25.284463Z","time spent":"4.825033417s","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "} {"level":"warn","ts":"2026-02-17T16:08:30.109789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.105934444s","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-17T16:08:30.109833Z","caller":"traceutil/trace.go:171","msg":"trace[145180207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:498; }","duration":"6.106028578s","start":"2026-02-17T16:08:24.003789Z","end":"2026-02-17T16:08:30.109818Z","steps":["trace[145180207] 'agreement among raft nodes before linearized reading' (duration: 6.105905333s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.10987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:24.00377Z","time spent":"6.106090571s","remote":"127.0.0.1:42504","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-17T16:08:30.111341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:29.342015Z","time spent":"767.390673ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3048,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:30.35227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.151179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:30.352429Z","caller":"traceutil/trace.go:171","msg":"trace[428553553] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"226.067021ms","start":"2026-02-17T16:08:30.126314Z","end":"2026-02-17T16:08:30.352381Z","steps":["trace[428553553] 'process raft request' (duration: 78.728945ms)","trace[428553553] 'compare' (duration: 146.974511ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:30.353025Z","caller":"traceutil/trace.go:171","msg":"trace[1827890837] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"226.354533ms","start":"2026-02-17T16:08:30.126643Z","end":"2026-02-17T16:08:30.352997Z","steps":["trace[1827890837] 'read index received' (duration: 78.410442ms)","trace[1827890837] 'applied index is now lower than readState.Index' (duration: 147.942631ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:30.353326Z","caller":"traceutil/trace.go:171","msg":"trace[688783158] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"226.725278ms","start":"2026-02-17T16:08:30.126575Z","end":"2026-02-17T16:08:30.353301Z","steps":["trace[688783158] 'process raft request' (duration: 226.121943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.353622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.959408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:30.353739Z","caller":"traceutil/trace.go:171","msg":"trace[1411250154] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:502; }","duration":"227.084333ms","start":"2026-02-17T16:08:30.12664Z","end":"2026-02-17T16:08:30.353724Z","steps":["trace[1411250154] 'agreement among raft nodes before linearized reading' (duration: 226.919206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.353903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.661177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-17T16:08:30.353948Z","caller":"traceutil/trace.go:171","msg":"trace[27315223] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:502; }","duration":"186.7353ms","start":"2026-02-17T16:08:30.167202Z","end":"2026-02-17T16:08:30.353937Z","steps":["trace[27315223] 'agreement among raft nodes before linearized reading' (duration: 186.601675ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:30.354057Z","caller":"traceutil/trace.go:171","msg":"trace[505748065] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"227.096303ms","start":"2026-02-17T16:08:30.126948Z","end":"2026-02-17T16:08:30.354044Z","steps":["trace[505748065] 'process raft request' (duration: 225.886314ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:30.354396Z","caller":"traceutil/trace.go:171","msg":"trace[157880183] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"227.384874ms","start":"2026-02-17T16:08:30.126995Z","end":"2026-02-17T16:08:30.35438Z","steps":["trace[157880183] 'process raft request' (duration: 225.880583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:30.35368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.137519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:30.354854Z","caller":"traceutil/trace.go:171","msg":"trace[577371717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"220.365529ms","start":"2026-02-17T16:08:30.134476Z","end":"2026-02-17T16:08:30.354842Z","steps":["trace[577371717] 'agreement among raft nodes before linearized reading' (duration: 219.140379ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:30.65859Z","caller":"traceutil/trace.go:171","msg":"trace[1540967926] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"231.888758ms","start":"2026-02-17T16:08:30.426684Z","end":"2026-02-17T16:08:30.658573Z","steps":["trace[1540967926] 'process raft request' (duration: 231.17998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:31.538207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.745369ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:31.538282Z","caller":"traceutil/trace.go:171","msg":"trace[341251554] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:506; }","duration":"271.827342ms","start":"2026-02-17T16:08:31.266442Z","end":"2026-02-17T16:08:31.53827Z","steps":["trace[341251554] 'range keys from in-memory index tree' (duration: 271.732729ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:31.688808Z","caller":"traceutil/trace.go:171","msg":"trace[2000594899] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.260511697s","start":"2026-02-17T16:08:30.428275Z","end":"2026-02-17T16:08:31.688786Z","steps":["trace[2000594899] 'process raft request' (duration: 1.260466025s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:31.688939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.428268Z","time spent":"1.260609001s","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":785,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:08:31.68923Z","caller":"traceutil/trace.go:171","msg":"trace[1415860071] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.262459877s","start":"2026-02-17T16:08:30.426759Z","end":"2026-02-17T16:08:31.689219Z","steps":["trace[1415860071] 'process raft request' (duration: 1.261693596s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:31.689319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.426755Z","time spent":"1.262499729s","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:31.689502Z","caller":"traceutil/trace.go:171","msg":"trace[1719889384] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.262425546s","start":"2026-02-17T16:08:30.427067Z","end":"2026-02-17T16:08:31.689492Z","steps":["trace[1719889384] 'process raft request' (duration: 1.261628843s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:31.689579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.427061Z","time spent":"1.262493788s","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":896,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:32.007309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.522513ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:08:32.007402Z","caller":"traceutil/trace.go:171","msg":"trace[583637996] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:525; }","duration":"1.580654046s","start":"2026-02-17T16:08:30.426731Z","end":"2026-02-17T16:08:32.007385Z","steps":["trace[583637996] 'read index received' (duration: 231.140438ms)","trace[583637996] 'applied index is now lower than readState.Index' (duration: 1.349512058s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:32.008127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.581381056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:08:32.008169Z","caller":"traceutil/trace.go:171","msg":"trace[723264284] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:509; }","duration":"1.581535423s","start":"2026-02-17T16:08:30.426623Z","end":"2026-02-17T16:08:32.008158Z","steps":["trace[723264284] 'agreement among raft nodes before linearized reading' (duration: 1.581385086s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.008202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.426611Z","time spent":"1.581583325s","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-17T16:08:32.086797Z","caller":"traceutil/trace.go:171","msg":"trace[1663581738] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"387.977242ms","start":"2026-02-17T16:08:31.698804Z","end":"2026-02-17T16:08:32.086781Z","steps":["trace[1663581738] 'process raft request' (duration: 387.774953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.086901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:31.698785Z","time spent":"388.060585ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3210,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:32.086994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.010134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:32.087013Z","caller":"traceutil/trace.go:171","msg":"trace[684025431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"752.053906ms","start":"2026-02-17T16:08:31.334952Z","end":"2026-02-17T16:08:32.087006Z","steps":["trace[684025431] 'agreement among raft nodes before linearized reading' (duration: 752.022295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.08703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:31.334937Z","time spent":"752.089238ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:32.087215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.658855197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3653"} {"level":"info","ts":"2026-02-17T16:08:32.087266Z","caller":"traceutil/trace.go:171","msg":"trace[1117231549] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:510; }","duration":"1.65892135s","start":"2026-02-17T16:08:30.428332Z","end":"2026-02-17T16:08:32.087254Z","steps":["trace[1117231549] 'agreement among raft nodes before linearized reading' (duration: 1.658783255s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.087293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.428329Z","time spent":"1.658958702s","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3676,"request content":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-02-17T16:08:32.087405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346059986s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:08:32.087431Z","caller":"traceutil/trace.go:171","msg":"trace[1038576834] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"1.34612631s","start":"2026-02-17T16:08:30.741297Z","end":"2026-02-17T16:08:32.087424Z","steps":["trace[1038576834] 'agreement among raft nodes before linearized reading' (duration: 1.346077138s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.087453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.741277Z","time spent":"1.346170811s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:08:32.087454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.652663996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-17T16:08:32.087474Z","caller":"traceutil/trace.go:171","msg":"trace[1779593971] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:510; }","duration":"1.652701957s","start":"2026-02-17T16:08:30.434766Z","end":"2026-02-17T16:08:32.087468Z","steps":["trace[1779593971] 'agreement among raft nodes before linearized reading' (duration: 1.652636435s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.087492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.434758Z","time spent":"1.652729868s","remote":"127.0.0.1:42334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12750,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-17T16:08:32.087603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100784684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:08:32.087642Z","caller":"traceutil/trace.go:171","msg":"trace[1974467086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:510; }","duration":"1.100838807s","start":"2026-02-17T16:08:30.986779Z","end":"2026-02-17T16:08:32.087617Z","steps":["trace[1974467086] 'agreement among raft nodes before linearized reading' (duration: 1.100764794s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:32.08766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:30.986759Z","time spent":"1.100897289s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:08:32.876244Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:33.37725Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:33.743514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:32.103255Z","time spent":"1.64024253s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/17 16:08:33 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:33.762992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:32.103216Z","time spent":"1.659771309s","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/17 16:08:33 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:33.878134Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:33.986538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:32.102296Z","time spent":"1.884235658s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/17 16:08:33 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:08:34.378309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:34.527751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.173478162s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-02-17T16:08:34.878562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:35.204092Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.152359504s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:08:35.333069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000382501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T16:08:35.333153Z","caller":"traceutil/trace.go:171","msg":"trace[313292549] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000534358s","start":"2026-02-17T16:08:33.332596Z","end":"2026-02-17T16:08:35.333131Z","steps":["trace[313292549] 'agreement among raft nodes before linearized reading' (duration: 2.000414033s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:35.333257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:33.33258Z","time spent":"2.000659503s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:36.355456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000241793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T16:08:36.355548Z","caller":"traceutil/trace.go:171","msg":"trace[1660241628] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00038579s","start":"2026-02-17T16:08:34.355142Z","end":"2026-02-17T16:08:36.355527Z","steps":["trace[1660241628] 'agreement among raft nodes before linearized reading' (duration: 2.000266264s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.355597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:34.355125Z","time spent":"2.000459832s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:36.479876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275594407s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:36.481548Z","caller":"traceutil/trace.go:171","msg":"trace[1810660996] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:532; }","duration":"4.106008968s","start":"2026-02-17T16:08:32.375523Z","end":"2026-02-17T16:08:36.481532Z","steps":["trace[1810660996] 'read index received' (duration: 2.828735216s)","trace[1810660996] 'applied index is now lower than readState.Index' (duration: 1.277273092s)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:36.481623Z","caller":"traceutil/trace.go:171","msg":"trace[1099190939] transaction","detail":"{read_only:false; number_of_response:1; response_revision:513; }","duration":"2.493559377s","start":"2026-02-17T16:08:33.988057Z","end":"2026-02-17T16:08:36.481617Z","steps":["trace[1099190939] 'process raft request' (duration: 2.49340489s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.4817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:33.988034Z","time spent":"2.493607149s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":47,"response count":0,"response size":513,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:36.481932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.106402425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T16:08:36.481996Z","caller":"traceutil/trace.go:171","msg":"trace[807831986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"4.10651483s","start":"2026-02-17T16:08:32.375472Z","end":"2026-02-17T16:08:36.481987Z","steps":["trace[807831986] 'agreement among raft nodes before linearized reading' (duration: 4.106350293s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.482021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:32.375458Z","time spent":"4.106557532s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-17T16:08:36.803783Z","caller":"traceutil/trace.go:171","msg":"trace[481080370] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"444.642364ms","start":"2026-02-17T16:08:36.359124Z","end":"2026-02-17T16:08:36.803767Z","steps":["trace[481080370] 'process raft request' (duration: 444.54053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.803882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.359104Z","time spent":"444.729418ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:08:36.804008Z","caller":"traceutil/trace.go:171","msg":"trace[987847214] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:536; }","duration":"322.39426ms","start":"2026-02-17T16:08:36.481587Z","end":"2026-02-17T16:08:36.803981Z","steps":["trace[987847214] 'read index received' (duration: 322.384779ms)","trace[987847214] 'applied index is now lower than readState.Index' (duration: 7.761µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:36.804182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470564258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:36.804215Z","caller":"traceutil/trace.go:171","msg":"trace[1155610534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"1.470660711s","start":"2026-02-17T16:08:35.333545Z","end":"2026-02-17T16:08:36.804205Z","steps":["trace[1155610534] 'agreement among raft nodes before linearized reading' (duration: 1.470573748s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.804238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:35.333529Z","time spent":"1.470704124s","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:36.80426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.519146301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:08:36.804281Z","caller":"traceutil/trace.go:171","msg":"trace[1178603672] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:514; }","duration":"1.519200533s","start":"2026-02-17T16:08:35.285072Z","end":"2026-02-17T16:08:36.804273Z","steps":["trace[1178603672] 'agreement among raft nodes before linearized reading' (duration: 1.519155871s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.804304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:35.285052Z","time spent":"1.519247826s","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "} {"level":"warn","ts":"2026-02-17T16:08:36.804214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.428197059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:08:36.804345Z","caller":"traceutil/trace.go:171","msg":"trace[1231204482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"4.428338536s","start":"2026-02-17T16:08:32.375983Z","end":"2026-02-17T16:08:36.804322Z","steps":["trace[1231204482] 'agreement among raft nodes before linearized reading' (duration: 4.428072074s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:36.804367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:32.375978Z","time spent":"4.428382917s","remote":"127.0.0.1:42504","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-17T16:08:37.122145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.45878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:37.122301Z","caller":"traceutil/trace.go:171","msg":"trace[423830916] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:536; }","duration":"313.929751ms","start":"2026-02-17T16:08:36.808359Z","end":"2026-02-17T16:08:37.122289Z","steps":["trace[423830916] 'read index received' (duration: 163.283793ms)","trace[423830916] 'applied index is now lower than readState.Index' (duration: 150.645088ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:37.122365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.80569Z","time spent":"316.671042ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T16:08:37.122546Z","caller":"traceutil/trace.go:171","msg":"trace[1405909552] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"311.757524ms","start":"2026-02-17T16:08:36.810783Z","end":"2026-02-17T16:08:37.12254Z","steps":["trace[1405909552] 'process raft request' (duration: 311.479362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.122581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.810774Z","time spent":"311.790526ms","remote":"127.0.0.1:42504","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-17T16:08:37.122707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.34716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.189514720228036a\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-02-17T16:08:37.122727Z","caller":"traceutil/trace.go:171","msg":"trace[1807968950] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.189514720228036a; range_end:; response_count:1; response_revision:516; }","duration":"314.388881ms","start":"2026-02-17T16:08:36.808332Z","end":"2026-02-17T16:08:37.122721Z","steps":["trace[1807968950] 'agreement among raft nodes before linearized reading' (duration: 314.307258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.122743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.80832Z","time spent":"314.420242ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.189514720228036a\" "} {"level":"info","ts":"2026-02-17T16:08:37.122762Z","caller":"traceutil/trace.go:171","msg":"trace[1290173858] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"630.301933ms","start":"2026-02-17T16:08:36.492397Z","end":"2026-02-17T16:08:37.122699Z","steps":["trace[1290173858] 'process raft request' (duration: 479.235906ms)","trace[1290173858] 'compare' (duration: 150.377867ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:37.122829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.320005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:37.122845Z","caller":"traceutil/trace.go:171","msg":"trace[1089937057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"311.952553ms","start":"2026-02-17T16:08:36.810888Z","end":"2026-02-17T16:08:37.12284Z","steps":["trace[1089937057] 'agreement among raft nodes before linearized reading' (duration: 311.926012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.12286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.810884Z","time spent":"311.972365ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:37.122912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:36.49238Z","time spent":"630.45118ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:37.480997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.36648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:37.481165Z","caller":"traceutil/trace.go:171","msg":"trace[716071438] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"355.603632ms","start":"2026-02-17T16:08:37.125542Z","end":"2026-02-17T16:08:37.481146Z","steps":["trace[716071438] 'process raft request' (duration: 96.780511ms)","trace[716071438] 'compare' (duration: 258.170521ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:37.481244Z","caller":"traceutil/trace.go:171","msg":"trace[1999344653] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"348.126516ms","start":"2026-02-17T16:08:37.1331Z","end":"2026-02-17T16:08:37.481226Z","steps":["trace[1999344653] 'process raft request' (duration: 348.034492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.481281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.125529Z","time spent":"355.689886ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:37.481313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.133062Z","time spent":"348.217391ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:37.481459Z","caller":"traceutil/trace.go:171","msg":"trace[1239241671] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"350.480332ms","start":"2026-02-17T16:08:37.13097Z","end":"2026-02-17T16:08:37.481451Z","steps":["trace[1239241671] 'read index received' (duration: 91.584489ms)","trace[1239241671] 'applied index is now lower than readState.Index' (duration: 258.894993ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:37.481586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.614518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:37.481606Z","caller":"traceutil/trace.go:171","msg":"trace[1587317833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"351.116581ms","start":"2026-02-17T16:08:37.130484Z","end":"2026-02-17T16:08:37.4816Z","steps":["trace[1587317833] 'agreement among raft nodes before linearized reading' (duration: 351.030217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.481622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.13047Z","time spent":"351.148722ms","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:37.481652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.543357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6684"} {"level":"info","ts":"2026-02-17T16:08:37.481698Z","caller":"traceutil/trace.go:171","msg":"trace[725114191] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:518; }","duration":"196.61312ms","start":"2026-02-17T16:08:37.285074Z","end":"2026-02-17T16:08:37.481687Z","steps":["trace[725114191] 'agreement among raft nodes before linearized reading' (duration: 196.531406ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:37.908166Z","caller":"traceutil/trace.go:171","msg":"trace[2104378828] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"422.651259ms","start":"2026-02-17T16:08:37.485493Z","end":"2026-02-17T16:08:37.908145Z","steps":["trace[2104378828] 'process raft request' (duration: 422.540504ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.90831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.485486Z","time spent":"422.751764ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:08:37.908825Z","caller":"traceutil/trace.go:171","msg":"trace[1042985537] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:542; }","duration":"422.6724ms","start":"2026-02-17T16:08:37.486103Z","end":"2026-02-17T16:08:37.908775Z","steps":["trace[1042985537] 'read index received' (duration: 422.6678ms)","trace[1042985537] 'applied index is now lower than readState.Index' (duration: 3.62µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:37.909026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.908301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:08:37.909058Z","caller":"traceutil/trace.go:171","msg":"trace[255391786] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:519; }","duration":"422.959083ms","start":"2026-02-17T16:08:37.48609Z","end":"2026-02-17T16:08:37.909049Z","steps":["trace[255391786] 'agreement among raft nodes before linearized reading' (duration: 422.773575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:37.90909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.486085Z","time spent":"422.997745ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-17T16:08:38.283348Z","caller":"traceutil/trace.go:171","msg":"trace[131166281] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"788.377368ms","start":"2026-02-17T16:08:37.494792Z","end":"2026-02-17T16:08:38.28317Z","steps":["trace[131166281] 'process raft request' (duration: 788.170218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:38.283433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.494776Z","time spent":"788.610239ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6981,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:38.550132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.639351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:38.550223Z","caller":"traceutil/trace.go:171","msg":"trace[1752857833] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:543; }","duration":"637.316411ms","start":"2026-02-17T16:08:37.91289Z","end":"2026-02-17T16:08:38.550206Z","steps":["trace[1752857833] 'read index received' (duration: 370.304914ms)","trace[1752857833] 'applied index is now lower than readState.Index' (duration: 267.009627ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:38.5503Z","caller":"traceutil/trace.go:171","msg":"trace[1001352250] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"638.026862ms","start":"2026-02-17T16:08:37.912264Z","end":"2026-02-17T16:08:38.55029Z","steps":["trace[1001352250] 'process raft request' (duration: 487.169851ms)","trace[1001352250] 'compare' (duration: 150.268495ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:38.550349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.91225Z","time spent":"638.073685ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":777,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:38.550589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.688967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-17T16:08:38.55062Z","caller":"traceutil/trace.go:171","msg":"trace[1744282257] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:521; }","duration":"637.73706ms","start":"2026-02-17T16:08:37.912874Z","end":"2026-02-17T16:08:38.550611Z","steps":["trace[1744282257] 'agreement among raft nodes before linearized reading' (duration: 637.642456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:38.550655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:37.912866Z","time spent":"637.781832ms","remote":"127.0.0.1:42520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-02-17T16:08:38.550813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.270872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4064"} {"level":"info","ts":"2026-02-17T16:08:38.550841Z","caller":"traceutil/trace.go:171","msg":"trace[313141259] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:521; }","duration":"264.314994ms","start":"2026-02-17T16:08:38.286517Z","end":"2026-02-17T16:08:38.550832Z","steps":["trace[313141259] 'agreement among raft nodes before linearized reading' (duration: 264.261922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:38.551047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.226586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:38.55109Z","caller":"traceutil/trace.go:171","msg":"trace[1695672178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"217.290188ms","start":"2026-02-17T16:08:38.33379Z","end":"2026-02-17T16:08:38.55108Z","steps":["trace[1695672178] 'agreement among raft nodes before linearized reading' (duration: 217.233466ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:38.974509Z","caller":"traceutil/trace.go:171","msg":"trace[1641604541] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"418.172041ms","start":"2026-02-17T16:08:38.556319Z","end":"2026-02-17T16:08:38.974491Z","steps":["trace[1641604541] 'process raft request' (duration: 418.070357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:38.974617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:38.556308Z","time spent":"418.251984ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4343,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:39.349785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.64235ms","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-17T16:08:39.350078Z","caller":"traceutil/trace.go:171","msg":"trace[146610639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"213.973924ms","start":"2026-02-17T16:08:39.136079Z","end":"2026-02-17T16:08:39.350053Z","steps":["trace[146610639] 'range keys from in-memory index tree' (duration: 213.498193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:39.349853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.068843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:08:39.350372Z","caller":"traceutil/trace.go:171","msg":"trace[299681716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"213.621819ms","start":"2026-02-17T16:08:39.136737Z","end":"2026-02-17T16:08:39.350359Z","steps":["trace[299681716] 'range keys from in-memory index tree' (duration: 212.874094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:39.550082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.171014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:39.550159Z","caller":"traceutil/trace.go:171","msg":"trace[2066011694] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"195.951547ms","start":"2026-02-17T16:08:39.354191Z","end":"2026-02-17T16:08:39.550143Z","steps":["trace[2066011694] 'process raft request' (duration: 95.661617ms)","trace[2066011694] 'compare' (duration: 100.08873ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:50.004983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:50.505939Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:50.577863Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.231025237s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:08:50.578156Z","caller":"traceutil/trace.go:171","msg":"trace[1295064271] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.231407547s","start":"2026-02-17T16:08:49.346727Z","end":"2026-02-17T16:08:50.578135Z","steps":["trace[1295064271] 'process raft request' (duration: 1.23127514s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:50.578265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.346709Z","time spent":"1.231484891s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:51.346202Z","caller":"traceutil/trace.go:171","msg":"trace[1731005966] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"1.841647638s","start":"2026-02-17T16:08:49.504536Z","end":"2026-02-17T16:08:51.346184Z","steps":["trace[1731005966] 'read index received' (duration: 1.074354857s)","trace[1731005966] 'applied index is now lower than readState.Index' (duration: 767.291971ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:08:51.346456Z","caller":"traceutil/trace.go:171","msg":"trace[1751649479] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.702532084s","start":"2026-02-17T16:08:49.643918Z","end":"2026-02-17T16:08:51.34645Z","steps":["trace[1751649479] 'process raft request' (duration: 1.702162044s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.346522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.643906Z","time spent":"1.702570396s","remote":"127.0.0.1:42426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4344,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:51.346636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.842095262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:51.346658Z","caller":"traceutil/trace.go:171","msg":"trace[1368213475] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:546; }","duration":"1.842143214s","start":"2026-02-17T16:08:49.504508Z","end":"2026-02-17T16:08:51.346651Z","steps":["trace[1368213475] 'agreement among raft nodes before linearized reading' (duration: 1.842107032s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.346673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.504492Z","time spent":"1.842176926s","remote":"127.0.0.1:42474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:08:51.655304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.458006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:51.655495Z","caller":"traceutil/trace.go:171","msg":"trace[277625412] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:572; }","duration":"309.214513ms","start":"2026-02-17T16:08:51.346264Z","end":"2026-02-17T16:08:51.655479Z","steps":["trace[277625412] 'read index received' (duration: 46.458542ms)","trace[277625412] 'applied index is now lower than readState.Index' (duration: 262.755131ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:51.65557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.215634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:51.655624Z","caller":"traceutil/trace.go:171","msg":"trace[1591571273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"325.300698ms","start":"2026-02-17T16:08:51.33031Z","end":"2026-02-17T16:08:51.65561Z","steps":["trace[1591571273] 'agreement among raft nodes before linearized reading' (duration: 325.176452ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.655651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:51.330296Z","time spent":"325.349591ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:51.655719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.030081972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:08:51.65575Z","caller":"traceutil/trace.go:171","msg":"trace[341988304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"2.030157276s","start":"2026-02-17T16:08:49.625582Z","end":"2026-02-17T16:08:51.65574Z","steps":["trace[341988304] 'agreement among raft nodes before linearized reading' (duration: 2.030021319s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.655782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.625568Z","time spent":"2.030206759s","remote":"127.0.0.1:42504","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-17T16:08:51.655856Z","caller":"traceutil/trace.go:171","msg":"trace[1571870758] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"949.265836ms","start":"2026-02-17T16:08:50.70658Z","end":"2026-02-17T16:08:51.655846Z","steps":["trace[1571870758] 'process raft request' (duration: 686.183248ms)","trace[1571870758] 'compare' (duration: 262.285937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:51.655918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:50.706552Z","time spent":"949.3229ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:51.655978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03930304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:08:51.656006Z","caller":"traceutil/trace.go:171","msg":"trace[1370791664] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"928.290437ms","start":"2026-02-17T16:08:50.727709Z","end":"2026-02-17T16:08:51.656Z","steps":["trace[1370791664] 'process raft request' (duration: 927.676646ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:51.656009Z","caller":"traceutil/trace.go:171","msg":"trace[1947703287] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:548; }","duration":"1.039368953s","start":"2026-02-17T16:08:50.61663Z","end":"2026-02-17T16:08:51.655998Z","steps":["trace[1947703287] 'agreement among raft nodes before linearized reading' (duration: 1.03931051s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.656037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:50.61661Z","time spent":"1.039419466s","remote":"127.0.0.1:49264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":21,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:08:51.656181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.98336304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:08:51.656208Z","caller":"traceutil/trace.go:171","msg":"trace[1412695648] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:548; }","duration":"1.983421743s","start":"2026-02-17T16:08:49.672778Z","end":"2026-02-17T16:08:51.6562Z","steps":["trace[1412695648] 'agreement among raft nodes before linearized reading' (duration: 1.98337171s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.656235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.672762Z","time spent":"1.983465405s","remote":"127.0.0.1:49204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:08:51.656289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.01101271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:08:51.656313Z","caller":"traceutil/trace.go:171","msg":"trace[1505007152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"2.011051262s","start":"2026-02-17T16:08:49.645255Z","end":"2026-02-17T16:08:51.656306Z","steps":["trace[1505007152] 'agreement among raft nodes before linearized reading' (duration: 2.010962738s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.656041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:50.727691Z","time spent":"928.32969ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:08:51.656333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.645248Z","time spent":"2.011080933s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:08:51.656421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.014707109s","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-17T16:08:51.656436Z","caller":"traceutil/trace.go:171","msg":"trace[1983970176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"2.014810994s","start":"2026-02-17T16:08:49.64162Z","end":"2026-02-17T16:08:51.656431Z","steps":["trace[1983970176] 'agreement among raft nodes before linearized reading' (duration: 2.014762521s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:51.656451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:49.641602Z","time spent":"2.014845676s","remote":"127.0.0.1:42504","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-17T16:08:52.612042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908503,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:53.11272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908503,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:08:53.457758Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.792115566s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:08:54.335827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99991531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T16:08:54.33588Z","caller":"traceutil/trace.go:171","msg":"trace[55868208] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000008726s","start":"2026-02-17T16:08:52.335858Z","end":"2026-02-17T16:08:54.335867Z","steps":["trace[55868208] 'agreement among raft nodes before linearized reading' (duration: 1.999938632s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:54.335916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:52.335843Z","time spent":"2.000067588s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:55.703213Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.132934022s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:08:55.791368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.333287266s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:08:55.791954Z","caller":"traceutil/trace.go:171","msg":"trace[439696599] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"4.126365774s","start":"2026-02-17T16:08:51.665575Z","end":"2026-02-17T16:08:55.791941Z","steps":["trace[439696599] 'process raft request' (duration: 1.792450555s)","trace[439696599] 'compare' (duration: 2.332513764s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:55.791993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:51.665559Z","time spent":"4.126416566s","remote":"127.0.0.1:42504","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-17T16:08:55.792414Z","caller":"traceutil/trace.go:171","msg":"trace[752623738] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"4.122339686s","start":"2026-02-17T16:08:51.670069Z","end":"2026-02-17T16:08:55.792408Z","steps":["trace[752623738] 'process raft request' (duration: 4.121362323s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.792442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:51.670052Z","time spent":"4.122374298s","remote":"127.0.0.1:42504","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-17T16:08:55.810684Z","caller":"traceutil/trace.go:171","msg":"trace[908422725] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:574; }","duration":"3.698708127s","start":"2026-02-17T16:08:52.11196Z","end":"2026-02-17T16:08:55.810668Z","steps":["trace[908422725] 'read index received' (duration: 1.346076792s)","trace[908422725] 'applied index is now lower than readState.Index' (duration: 2.352630454s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:55.810993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.699023554s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:08:55.811015Z","caller":"traceutil/trace.go:171","msg":"trace[306715721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"3.699115319s","start":"2026-02-17T16:08:52.111894Z","end":"2026-02-17T16:08:55.81101Z","steps":["trace[306715721] 'agreement among raft nodes before linearized reading' (duration: 3.699023144s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:52.111874Z","time spent":"3.699153421s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.905669173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:7008"} {"level":"info","ts":"2026-02-17T16:08:55.811178Z","caller":"traceutil/trace.go:171","msg":"trace[1930475370] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:550; }","duration":"2.905710415s","start":"2026-02-17T16:08:52.905462Z","end":"2026-02-17T16:08:55.811173Z","steps":["trace[1930475370] 'agreement among raft nodes before linearized reading' (duration: 2.905664572s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.81119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:52.905447Z","time spent":"2.905740316s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":7031,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.732952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:08:55.811335Z","caller":"traceutil/trace.go:171","msg":"trace[489300021] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:550; }","duration":"525.776355ms","start":"2026-02-17T16:08:55.285555Z","end":"2026-02-17T16:08:55.811331Z","steps":["trace[489300021] 'agreement among raft nodes before linearized reading' (duration: 525.737393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:55.285534Z","time spent":"525.811237ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.12\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.408199043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:08:55.811455Z","caller":"traceutil/trace.go:171","msg":"trace[1795406430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:550; }","duration":"1.408249276s","start":"2026-02-17T16:08:54.403198Z","end":"2026-02-17T16:08:55.811447Z","steps":["trace[1795406430] 'agreement among raft nodes before linearized reading' (duration: 1.408207874s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:54.403185Z","time spent":"1.408279958s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459324066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:55.811548Z","caller":"traceutil/trace.go:171","msg":"trace[1387531179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"1.459359657s","start":"2026-02-17T16:08:54.352183Z","end":"2026-02-17T16:08:55.811543Z","steps":["trace[1387531179] 'agreement among raft nodes before linearized reading' (duration: 1.459338116s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:54.35217Z","time spent":"1.459386749s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474954037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:55.811637Z","caller":"traceutil/trace.go:171","msg":"trace[1461168758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"1.474994109s","start":"2026-02-17T16:08:54.33664Z","end":"2026-02-17T16:08:55.811634Z","steps":["trace[1461168758] 'agreement among raft nodes before linearized reading' (duration: 1.474971418s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:54.336627Z","time spent":"1.475018801s","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:08:55.811721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.300147654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:08:55.811737Z","caller":"traceutil/trace.go:171","msg":"trace[789676594] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:550; }","duration":"2.300211197s","start":"2026-02-17T16:08:53.511522Z","end":"2026-02-17T16:08:55.811733Z","steps":["trace[789676594] 'agreement among raft nodes before linearized reading' (duration: 2.300179655s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.81175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:53.511503Z","time spent":"2.300243888s","remote":"127.0.0.1:42590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":13,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:08:55.811821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.365522446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:55.811842Z","caller":"traceutil/trace.go:171","msg":"trace[914061597] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:550; }","duration":"2.365577409s","start":"2026-02-17T16:08:53.44626Z","end":"2026-02-17T16:08:55.811837Z","steps":["trace[914061597] 'agreement among raft nodes before linearized reading' (duration: 2.365548198s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.81186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:53.446242Z","time spent":"2.365611681s","remote":"127.0.0.1:42492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:08:55.811937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.887351924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:55.811954Z","caller":"traceutil/trace.go:171","msg":"trace[1504139962] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:550; }","duration":"2.887394186s","start":"2026-02-17T16:08:52.924555Z","end":"2026-02-17T16:08:55.811949Z","steps":["trace[1504139962] 'agreement among raft nodes before linearized reading' (duration: 2.887369745s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.811967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:52.92454Z","time spent":"2.887422438s","remote":"127.0.0.1:42410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-02-17T16:08:55.936584Z","caller":"traceutil/trace.go:171","msg":"trace[647417] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"111.62498ms","start":"2026-02-17T16:08:55.824942Z","end":"2026-02-17T16:08:55.936567Z","steps":["trace[647417] 'process raft request' (duration: 111.44765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.936923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.500677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.189514720228036a\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-02-17T16:08:55.936948Z","caller":"traceutil/trace.go:171","msg":"trace[32427925] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.189514720228036a; range_end:; response_count:1; response_revision:551; }","duration":"115.55059ms","start":"2026-02-17T16:08:55.821392Z","end":"2026-02-17T16:08:55.936942Z","steps":["trace[32427925] 'agreement among raft nodes before linearized reading' (duration: 115.446694ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:55.948811Z","caller":"traceutil/trace.go:171","msg":"trace[223847562] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"106.081162ms","start":"2026-02-17T16:08:55.84272Z","end":"2026-02-17T16:08:55.948801Z","steps":["trace[223847562] 'process raft request' (duration: 106.011278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:55.949047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.190678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:08:55.94907Z","caller":"traceutil/trace.go:171","msg":"trace[2048041317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"106.24538ms","start":"2026-02-17T16:08:55.842818Z","end":"2026-02-17T16:08:55.949064Z","steps":["trace[2048041317] 'agreement among raft nodes before linearized reading' (duration: 106.194007ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:56.711485Z","caller":"traceutil/trace.go:171","msg":"trace[1963276268] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"350.281345ms","start":"2026-02-17T16:08:56.361189Z","end":"2026-02-17T16:08:56.71147Z","steps":["trace[1963276268] 'process raft request' (duration: 281.428741ms)","trace[1963276268] 'compare' (duration: 68.425731ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:56.711567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:56.361174Z","time spent":"350.349298ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16897,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:57.548964Z","caller":"traceutil/trace.go:171","msg":"trace[250565287] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"105.215944ms","start":"2026-02-17T16:08:57.443727Z","end":"2026-02-17T16:08:57.548943Z","steps":["trace[250565287] 'process raft request' (duration: 105.079947ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:58.725784Z","caller":"traceutil/trace.go:171","msg":"trace[1759486394] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"725.46592ms","start":"2026-02-17T16:08:58.000296Z","end":"2026-02-17T16:08:58.725762Z","steps":["trace[1759486394] 'process raft request' (duration: 725.337482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:58.725925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:58.000285Z","time spent":"725.565304ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4163,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:08:58.955542Z","caller":"traceutil/trace.go:171","msg":"trace[469058552] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"597.534537ms","start":"2026-02-17T16:08:58.357998Z","end":"2026-02-17T16:08:58.955532Z","steps":["trace[469058552] 'process raft request' (duration: 597.445922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:58.955628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:58.357981Z","time spent":"597.605981ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:08:58.955684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.242753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:08:58.955708Z","caller":"traceutil/trace.go:171","msg":"trace[844380863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:562; }","duration":"357.273095ms","start":"2026-02-17T16:08:58.598428Z","end":"2026-02-17T16:08:58.955701Z","steps":["trace[844380863] 'agreement among raft nodes before linearized reading' (duration: 357.149238ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:08:58.955542Z","caller":"traceutil/trace.go:171","msg":"trace[1973946288] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"357.090535ms","start":"2026-02-17T16:08:58.598435Z","end":"2026-02-17T16:08:58.955526Z","steps":["trace[1973946288] 'read index received' (duration: 128.026049ms)","trace[1973946288] 'applied index is now lower than readState.Index' (duration: 229.063616ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:08:58.955845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.530528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ftc72\" ","response":"range_response_count:1 size:16912"} {"level":"warn","ts":"2026-02-17T16:08:58.955728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:58.598378Z","time spent":"357.343879ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-17T16:08:58.955867Z","caller":"traceutil/trace.go:171","msg":"trace[139799097] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ftc72; range_end:; response_count:1; response_revision:562; }","duration":"226.58208ms","start":"2026-02-17T16:08:58.729278Z","end":"2026-02-17T16:08:58.955861Z","steps":["trace[139799097] 'agreement among raft nodes before linearized reading' (duration: 226.513856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:00.226614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.997201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:00.22668Z","caller":"traceutil/trace.go:171","msg":"trace[595231446] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"274.069046ms","start":"2026-02-17T16:08:59.952599Z","end":"2026-02-17T16:09:00.226669Z","steps":["trace[595231446] 'read index received' (duration: 64.925977ms)","trace[595231446] 'applied index is now lower than readState.Index' (duration: 209.142389ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:00.226794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.195623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:09:00.22682Z","caller":"traceutil/trace.go:171","msg":"trace[1838633655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"274.246046ms","start":"2026-02-17T16:08:59.952566Z","end":"2026-02-17T16:09:00.226812Z","steps":["trace[1838633655] 'agreement among raft nodes before linearized reading' (duration: 274.1374ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:00.227149Z","caller":"traceutil/trace.go:171","msg":"trace[2123315149] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"328.160308ms","start":"2026-02-17T16:08:59.898914Z","end":"2026-02-17T16:09:00.227075Z","steps":["trace[2123315149] 'process raft request' (duration: 118.651598ms)","trace[2123315149] 'compare' (duration: 208.927817ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:00.227243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:08:59.898899Z","time spent":"328.276594ms","remote":"127.0.0.1:42504","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-17T16:09:00.483698Z","caller":"traceutil/trace.go:171","msg":"trace[454026839] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"203.97184ms","start":"2026-02-17T16:09:00.2797Z","end":"2026-02-17T16:09:00.483672Z","steps":["trace[454026839] 'read index received' (duration: 201.62473ms)","trace[454026839] 'applied index is now lower than readState.Index' (duration: 2.34613ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:00.484077Z","caller":"traceutil/trace.go:171","msg":"trace[1841776385] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"204.532002ms","start":"2026-02-17T16:09:00.279531Z","end":"2026-02-17T16:09:00.484063Z","steps":["trace[1841776385] 'process raft request' (duration: 201.846403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:00.484593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.876131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:09:00.48464Z","caller":"traceutil/trace.go:171","msg":"trace[419577347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"204.949315ms","start":"2026-02-17T16:09:00.27968Z","end":"2026-02-17T16:09:00.484629Z","steps":["trace[419577347] 'agreement among raft nodes before linearized reading' (duration: 204.781595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:00.48509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.623067ms","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-17T16:09:00.48536Z","caller":"traceutil/trace.go:171","msg":"trace[1813805596] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:567; }","duration":"197.751554ms","start":"2026-02-17T16:09:00.287427Z","end":"2026-02-17T16:09:00.485179Z","steps":["trace[1813805596] 'agreement among raft nodes before linearized reading' (duration: 197.619527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:00.48588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.751367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:00.486074Z","caller":"traceutil/trace.go:171","msg":"trace[1269111361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"153.006041ms","start":"2026-02-17T16:09:00.332912Z","end":"2026-02-17T16:09:00.485918Z","steps":["trace[1269111361] 'agreement among raft nodes before linearized reading' (duration: 152.769338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.059042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.895815ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:09:01.059108Z","caller":"traceutil/trace.go:171","msg":"trace[2044774049] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"491.335408ms","start":"2026-02-17T16:09:00.567763Z","end":"2026-02-17T16:09:01.059098Z","steps":["trace[2044774049] 'read index received' (duration: 184.333967ms)","trace[2044774049] 'applied index is now lower than readState.Index' (duration: 307.000541ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:01.059176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.405202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-17T16:09:01.059197Z","caller":"traceutil/trace.go:171","msg":"trace[889590187] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:568; }","duration":"491.437895ms","start":"2026-02-17T16:09:00.567753Z","end":"2026-02-17T16:09:01.059191Z","steps":["trace[889590187] 'agreement among raft nodes before linearized reading' (duration: 491.383382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.059217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.567748Z","time spent":"491.464606ms","remote":"127.0.0.1:42450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" "} {"level":"info","ts":"2026-02-17T16:09:01.614646Z","caller":"traceutil/trace.go:171","msg":"trace[1618653306] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"134.526015ms","start":"2026-02-17T16:09:01.480105Z","end":"2026-02-17T16:09:01.614631Z","steps":["trace[1618653306] 'process raft request' (duration: 134.431149ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:01.900894Z","caller":"traceutil/trace.go:171","msg":"trace[1885642873] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"329.152351ms","start":"2026-02-17T16:09:01.571631Z","end":"2026-02-17T16:09:01.900784Z","steps":["trace[1885642873] 'process raft request' (duration: 258.735461ms)","trace[1885642873] 'compare' (duration: 69.739142ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:01.900982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.571617Z","time spent":"329.326471ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.901465Z","caller":"traceutil/trace.go:171","msg":"trace[227847550] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"221.599919ms","start":"2026-02-17T16:09:01.679854Z","end":"2026-02-17T16:09:01.901454Z","steps":["trace[227847550] 'process raft request' (duration: 220.505147ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.065449Z","caller":"traceutil/trace.go:171","msg":"trace[1028094409] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"152.833995ms","start":"2026-02-17T16:09:01.912584Z","end":"2026-02-17T16:09:02.065418Z","steps":["trace[1028094409] 'process raft request' (duration: 152.506707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.530878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.25056ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:02.531886Z","caller":"traceutil/trace.go:171","msg":"trace[1188279161] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:601; }","duration":"465.812294ms","start":"2026-02-17T16:09:02.066051Z","end":"2026-02-17T16:09:02.531864Z","steps":["trace[1188279161] 'read index received' (duration: 358.443871ms)","trace[1188279161] 'applied index is now lower than readState.Index' (duration: 107.367103ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:02.532086Z","caller":"traceutil/trace.go:171","msg":"trace[115294596] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"507.982285ms","start":"2026-02-17T16:09:02.024055Z","end":"2026-02-17T16:09:02.532037Z","steps":["trace[115294596] 'process raft request' (duration: 400.498515ms)","trace[115294596] 'compare' (duration: 105.669837ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:02.532207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.024021Z","time spent":"508.111472ms","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.532671Z","caller":"traceutil/trace.go:171","msg":"trace[156133506] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"493.395182ms","start":"2026-02-17T16:09:02.03926Z","end":"2026-02-17T16:09:02.532655Z","steps":["trace[156133506] 'process raft request' (duration: 491.719437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.533708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.039245Z","time spent":"494.393488ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:02.533814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.645751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" ","response":"range_response_count:1 size:3833"} {"level":"info","ts":"2026-02-17T16:09:02.533867Z","caller":"traceutil/trace.go:171","msg":"trace[1461670495] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-77cccfdc44; range_end:; response_count:1; response_revision:574; }","duration":"518.037232ms","start":"2026-02-17T16:09:02.01582Z","end":"2026-02-17T16:09:02.533857Z","steps":["trace[1461670495] 'agreement among raft nodes before linearized reading' (duration: 517.957268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.533917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.015802Z","time spent":"518.106656ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3856,"request content":"key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" "} {"level":"warn","ts":"2026-02-17T16:09:02.534197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.436535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-7fcd8d6ffd\" ","response":"range_response_count:1 size:4332"} {"level":"info","ts":"2026-02-17T16:09:02.534234Z","caller":"traceutil/trace.go:171","msg":"trace[1946501028] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-7fcd8d6ffd; range_end:; response_count:1; response_revision:574; }","duration":"518.472787ms","start":"2026-02-17T16:09:02.015751Z","end":"2026-02-17T16:09:02.534224Z","steps":["trace[1946501028] 'agreement among raft nodes before linearized reading' (duration: 518.361661ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.534376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.015731Z","time spent":"518.635476ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":4355,"request content":"key:\"/registry/replicasets/kube-system/cilium-operator-7fcd8d6ffd\" "} {"level":"warn","ts":"2026-02-17T16:09:02.534741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.489681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/local-path-storage/local-path-provisioner-6f56467975\" ","response":"range_response_count:1 size:3225"} {"level":"info","ts":"2026-02-17T16:09:02.534776Z","caller":"traceutil/trace.go:171","msg":"trace[1598321299] range","detail":"{range_begin:/registry/replicasets/local-path-storage/local-path-provisioner-6f56467975; range_end:; response_count:1; response_revision:574; }","duration":"520.533834ms","start":"2026-02-17T16:09:02.014233Z","end":"2026-02-17T16:09:02.534767Z","steps":["trace[1598321299] 'agreement among raft nodes before linearized reading' (duration: 520.442189ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.534843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.01423Z","time spent":"520.604268ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":3248,"request content":"key:\"/registry/replicasets/local-path-storage/local-path-provisioner-6f56467975\" "} {"level":"warn","ts":"2026-02-17T16:09:02.535098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.866482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" ","response":"range_response_count:1 size:3797"} {"level":"info","ts":"2026-02-17T16:09:02.535133Z","caller":"traceutil/trace.go:171","msg":"trace[1260368564] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-5dd5756b68; range_end:; response_count:1; response_revision:574; }","duration":"520.913335ms","start":"2026-02-17T16:09:02.014211Z","end":"2026-02-17T16:09:02.535124Z","steps":["trace[1260368564] 'agreement among raft nodes before linearized reading' (duration: 520.835511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.535198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.014205Z","time spent":"520.984939ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3820,"request content":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" "} {"level":"warn","ts":"2026-02-17T16:09:02.535537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.274222ms","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-17T16:09:02.535573Z","caller":"traceutil/trace.go:171","msg":"trace[2127375869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"304.338086ms","start":"2026-02-17T16:09:02.231224Z","end":"2026-02-17T16:09:02.535562Z","steps":["trace[2127375869] 'agreement among raft nodes before linearized reading' (duration: 304.23215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.535696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.231144Z","time spent":"304.513995ms","remote":"127.0.0.1:42504","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-17T16:09:02.536864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.276271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ftc72\" ","response":"range_response_count:1 size:17167"} {"level":"info","ts":"2026-02-17T16:09:02.536901Z","caller":"traceutil/trace.go:171","msg":"trace[1920972510] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ftc72; range_end:; response_count:1; response_revision:574; }","duration":"171.339695ms","start":"2026-02-17T16:09:02.365552Z","end":"2026-02-17T16:09:02.536892Z","steps":["trace[1920972510] 'agreement among raft nodes before linearized reading' (duration: 171.242489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.537776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.959997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:02.537842Z","caller":"traceutil/trace.go:171","msg":"trace[197262229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"204.051532ms","start":"2026-02-17T16:09:02.333779Z","end":"2026-02-17T16:09:02.537831Z","steps":["trace[197262229] 'agreement among raft nodes before linearized reading' (duration: 203.969248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.962361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.361575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:02.962529Z","caller":"traceutil/trace.go:171","msg":"trace[778348630] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"378.991711ms","start":"2026-02-17T16:09:02.583521Z","end":"2026-02-17T16:09:02.962513Z","steps":["trace[778348630] 'read index received' (duration: 215.330999ms)","trace[778348630] 'applied index is now lower than readState.Index' (duration: 163.647891ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:02.962752Z","caller":"traceutil/trace.go:171","msg":"trace[2117708264] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"404.65808ms","start":"2026-02-17T16:09:02.558082Z","end":"2026-02-17T16:09:02.96274Z","steps":["trace[2117708264] 'process raft request' (duration: 240.84505ms)","trace[2117708264] 'compare' (duration: 163.072769ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:02.962837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.558073Z","time spent":"404.729114ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17314,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:02.963065Z","caller":"traceutil/trace.go:171","msg":"trace[540443083] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"404.254447ms","start":"2026-02-17T16:09:02.558802Z","end":"2026-02-17T16:09:02.963056Z","steps":["trace[540443083] 'process raft request' (duration: 403.642993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.963127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.558796Z","time spent":"404.30201ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:02.963329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.204347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4649"} {"level":"info","ts":"2026-02-17T16:09:02.963367Z","caller":"traceutil/trace.go:171","msg":"trace[1714297806] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:577; }","duration":"406.24571ms","start":"2026-02-17T16:09:02.557111Z","end":"2026-02-17T16:09:02.963357Z","steps":["trace[1714297806] 'agreement among raft nodes before linearized reading' (duration: 406.127393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.963401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.557109Z","time spent":"406.285732ms","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4672,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-02-17T16:09:02.963576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.463292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3692"} {"level":"info","ts":"2026-02-17T16:09:02.963612Z","caller":"traceutil/trace.go:171","msg":"trace[1150331821] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:577; }","duration":"406.500844ms","start":"2026-02-17T16:09:02.557101Z","end":"2026-02-17T16:09:02.963601Z","steps":["trace[1150331821] 'agreement among raft nodes before linearized reading' (duration: 406.418499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.963641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.557099Z","time spent":"406.537226ms","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3715,"request content":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-02-17T16:09:02.963767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.665294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-02-17T16:09:02.963821Z","caller":"traceutil/trace.go:171","msg":"trace[1381070587] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:577; }","duration":"406.724577ms","start":"2026-02-17T16:09:02.557088Z","end":"2026-02-17T16:09:02.963812Z","steps":["trace[1381070587] 'agreement among raft nodes before linearized reading' (duration: 406.650363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.96385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.557084Z","time spent":"406.760619ms","remote":"127.0.0.1:49214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4196,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-17T16:09:02.964026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.135795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:09:02.964059Z","caller":"traceutil/trace.go:171","msg":"trace[1212863076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"128.169147ms","start":"2026-02-17T16:09:02.835882Z","end":"2026-02-17T16:09:02.964051Z","steps":["trace[1212863076] 'agreement among raft nodes before linearized reading' (duration: 128.087843ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.144352Z","caller":"traceutil/trace.go:171","msg":"trace[319127282] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"109.77203ms","start":"2026-02-17T16:09:03.03456Z","end":"2026-02-17T16:09:03.144332Z","steps":["trace[319127282] 'process raft request' (duration: 107.730124ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.145471Z","caller":"traceutil/trace.go:171","msg":"trace[2029914920] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"109.2517ms","start":"2026-02-17T16:09:03.03621Z","end":"2026-02-17T16:09:03.145462Z","steps":["trace[2029914920] 'process raft request' (duration: 108.066403ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.339774Z","caller":"traceutil/trace.go:171","msg":"trace[1133367026] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"195.853133ms","start":"2026-02-17T16:09:03.143901Z","end":"2026-02-17T16:09:03.339754Z","steps":["trace[1133367026] 'process raft request' (duration: 195.818971ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.34004Z","caller":"traceutil/trace.go:171","msg":"trace[407924586] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"196.229734ms","start":"2026-02-17T16:09:03.143803Z","end":"2026-02-17T16:09:03.340033Z","steps":["trace[407924586] 'process raft request' (duration: 185.809792ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.340123Z","caller":"traceutil/trace.go:171","msg":"trace[720166821] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"196.260256ms","start":"2026-02-17T16:09:03.143857Z","end":"2026-02-17T16:09:03.340118Z","steps":["trace[720166821] 'process raft request' (duration: 195.829921ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:04.504825Z","caller":"traceutil/trace.go:171","msg":"trace[5864050] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"127.844465ms","start":"2026-02-17T16:09:04.376958Z","end":"2026-02-17T16:09:04.504803Z","steps":["trace[5864050] 'process raft request' (duration: 127.735149ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:04.564099Z","caller":"traceutil/trace.go:171","msg":"trace[1905684163] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"178.375626ms","start":"2026-02-17T16:09:04.385693Z","end":"2026-02-17T16:09:04.564069Z","steps":["trace[1905684163] 'process raft request' (duration: 178.181145ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:04.690095Z","caller":"traceutil/trace.go:171","msg":"trace[1134638635] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"100.786436ms","start":"2026-02-17T16:09:04.589293Z","end":"2026-02-17T16:09:04.69008Z","steps":["trace[1134638635] 'process raft request' (duration: 97.921482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:05.252592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.626395ms","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-17T16:09:05.252636Z","caller":"traceutil/trace.go:171","msg":"trace[262982678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"104.73056ms","start":"2026-02-17T16:09:05.147894Z","end":"2026-02-17T16:09:05.252625Z","steps":["trace[262982678] 'range keys from in-memory index tree' (duration: 104.464015ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:05.398189Z","caller":"traceutil/trace.go:171","msg":"trace[915476845] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"112.387241ms","start":"2026-02-17T16:09:05.285788Z","end":"2026-02-17T16:09:05.398175Z","steps":["trace[915476845] 'read index received' (duration: 112.256993ms)","trace[915476845] 'applied index is now lower than readState.Index' (duration: 129.758µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:05.398316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.517419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:09:05.398332Z","caller":"traceutil/trace.go:171","msg":"trace[1658489185] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:595; }","duration":"112.567871ms","start":"2026-02-17T16:09:05.285759Z","end":"2026-02-17T16:09:05.398327Z","steps":["trace[1658489185] 'agreement among raft nodes before linearized reading' (duration: 112.469556ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:05.398396Z","caller":"traceutil/trace.go:171","msg":"trace[198001009] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"143.194365ms","start":"2026-02-17T16:09:05.255191Z","end":"2026-02-17T16:09:05.398385Z","steps":["trace[198001009] 'process raft request' (duration: 142.891527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:05.712174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.301214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:05.712315Z","caller":"traceutil/trace.go:171","msg":"trace[1387785888] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"297.15157ms","start":"2026-02-17T16:09:05.415136Z","end":"2026-02-17T16:09:05.712287Z","steps":["trace[1387785888] 'process raft request' (duration: 51.638243ms)","trace[1387785888] 'compare' (duration: 245.173027ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:06.577599Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624908658,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:06.989934Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.187602883s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T16:09:07.353938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.808112ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:07.354017Z","caller":"traceutil/trace.go:171","msg":"trace[837100750] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"1.277084573s","start":"2026-02-17T16:09:06.076921Z","end":"2026-02-17T16:09:07.354006Z","steps":["trace[837100750] 'read index received' (duration: 913.115562ms)","trace[837100750] 'applied index is now lower than readState.Index' (duration: 363.968341ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.354063Z","caller":"traceutil/trace.go:171","msg":"trace[1852082162] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.626299907s","start":"2026-02-17T16:09:05.727757Z","end":"2026-02-17T16:09:07.354057Z","steps":["trace[1852082162] 'process raft request' (duration: 1.262319616s)","trace[1852082162] 'compare' (duration: 363.716406ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:07.354087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:05.727737Z","time spent":"1.626337969s","remote":"127.0.0.1:42318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:07.354254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277330077s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T16:09:07.354267Z","caller":"traceutil/trace.go:171","msg":"trace[2087357037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"1.2773917s","start":"2026-02-17T16:09:06.076871Z","end":"2026-02-17T16:09:07.354263Z","steps":["trace[2087357037] 'agreement among raft nodes before linearized reading' (duration: 1.277305725s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.35428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.076849Z","time spent":"1.277428263s","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T16:09:07.354354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020159667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.354366Z","caller":"traceutil/trace.go:171","msg":"trace[1736868877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"1.02020686s","start":"2026-02-17T16:09:06.334155Z","end":"2026-02-17T16:09:07.354362Z","steps":["trace[1736868877] 'agreement among raft nodes before linearized reading' (duration: 1.020186969s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.354376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.334136Z","time spent":"1.020238293s","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:09:07.354493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.318687ms","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-17T16:09:07.354505Z","caller":"traceutil/trace.go:171","msg":"trace[561639621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"287.367611ms","start":"2026-02-17T16:09:07.067134Z","end":"2026-02-17T16:09:07.354502Z","steps":["trace[561639621] 'agreement among raft nodes before linearized reading' (duration: 287.329399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.354576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.65854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:09:07.354588Z","caller":"traceutil/trace.go:171","msg":"trace[1913597913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"660.705173ms","start":"2026-02-17T16:09:06.693879Z","end":"2026-02-17T16:09:07.354584Z","steps":["trace[1913597913] 'agreement among raft nodes before linearized reading' (duration: 660.671041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.354599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.693858Z","time spent":"660.738266ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:09:07.354679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.62449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ftc72\" ","response":"range_response_count:1 size:17666"} {"level":"info","ts":"2026-02-17T16:09:07.35471Z","caller":"traceutil/trace.go:171","msg":"trace[2123852514] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ftc72; range_end:; response_count:1; response_revision:598; }","duration":"969.682194ms","start":"2026-02-17T16:09:06.385022Z","end":"2026-02-17T16:09:07.354705Z","steps":["trace[2123852514] 'agreement among raft nodes before linearized reading' (duration: 969.61938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.354727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.384993Z","time spent":"969.729126ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17689,"request content":"key:\"/registry/pods/kube-system/cilium-ftc72\" "} {"level":"warn","ts":"2026-02-17T16:09:07.354807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010760754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.35482Z","caller":"traceutil/trace.go:171","msg":"trace[553164895] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:598; }","duration":"1.010776084s","start":"2026-02-17T16:09:06.34404Z","end":"2026-02-17T16:09:07.354816Z","steps":["trace[553164895] 'agreement among raft nodes before linearized reading' (duration: 1.010752473s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.354835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.343989Z","time spent":"1.010841498s","remote":"127.0.0.1:42320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-02-17T16:09:07.565211Z","caller":"traceutil/trace.go:171","msg":"trace[1997235348] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"199.677039ms","start":"2026-02-17T16:09:07.365496Z","end":"2026-02-17T16:09:07.565173Z","steps":["trace[1997235348] 'process raft request' (duration: 199.338859ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.56534Z","caller":"traceutil/trace.go:171","msg":"trace[1058117223] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:630; }","duration":"195.340536ms","start":"2026-02-17T16:09:07.369976Z","end":"2026-02-17T16:09:07.565317Z","steps":["trace[1058117223] 'read index received' (duration: 26.747489ms)","trace[1058117223] 'applied index is now lower than readState.Index' (duration: 168.591877ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.570562Z","caller":"traceutil/trace.go:171","msg":"trace[1282646469] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"198.119748ms","start":"2026-02-17T16:09:07.372412Z","end":"2026-02-17T16:09:07.570531Z","steps":["trace[1282646469] 'process raft request' (duration: 192.8279ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.571235Z","caller":"traceutil/trace.go:171","msg":"trace[638253157] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"202.759319ms","start":"2026-02-17T16:09:07.368456Z","end":"2026-02-17T16:09:07.571215Z","steps":["trace[638253157] 'process raft request' (duration: 196.60315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.57266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.663694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.572708Z","caller":"traceutil/trace.go:171","msg":"trace[1712723919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"202.761909ms","start":"2026-02-17T16:09:07.369936Z","end":"2026-02-17T16:09:07.572698Z","steps":["trace[1712723919] 'agreement among raft nodes before linearized reading' (duration: 202.660543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.572848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.955726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:999"} {"level":"info","ts":"2026-02-17T16:09:07.572871Z","caller":"traceutil/trace.go:171","msg":"trace[1516042673] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:603; }","duration":"199.989187ms","start":"2026-02-17T16:09:07.372876Z","end":"2026-02-17T16:09:07.572865Z","steps":["trace[1516042673] 'agreement among raft nodes before linearized reading' (duration: 199.947265ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.57305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.99842ms","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-17T16:09:07.573074Z","caller":"traceutil/trace.go:171","msg":"trace[846363910] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:603; }","duration":"123.043192ms","start":"2026-02-17T16:09:07.450025Z","end":"2026-02-17T16:09:07.573068Z","steps":["trace[846363910] 'agreement among raft nodes before linearized reading' (duration: 123.002019ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.573311Z","caller":"traceutil/trace.go:171","msg":"trace[912188081] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"202.10067ms","start":"2026-02-17T16:09:07.371133Z","end":"2026-02-17T16:09:07.573234Z","steps":["trace[912188081] 'process raft request' (duration: 194.03493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.586847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.236637ms","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-17T16:09:07.587177Z","caller":"traceutil/trace.go:171","msg":"trace[1400985325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"185.608939ms","start":"2026-02-17T16:09:07.401554Z","end":"2026-02-17T16:09:07.587163Z","steps":["trace[1400985325] 'agreement among raft nodes before linearized reading' (duration: 171.590692ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.832883Z","caller":"traceutil/trace.go:171","msg":"trace[1061058963] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"244.716164ms","start":"2026-02-17T16:09:07.588131Z","end":"2026-02-17T16:09:07.832847Z","steps":["trace[1061058963] 'process raft request' (duration: 197.621819ms)","trace[1061058963] 'compare' (duration: 46.800458ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.833432Z","caller":"traceutil/trace.go:171","msg":"trace[2070669399] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:634; }","duration":"227.867713ms","start":"2026-02-17T16:09:07.605553Z","end":"2026-02-17T16:09:07.833421Z","steps":["trace[2070669399] 'read index received' (duration: 180.205665ms)","trace[2070669399] 'applied index is now lower than readState.Index' (duration: 47.661198ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.833617Z","caller":"traceutil/trace.go:171","msg":"trace[1348080101] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"242.271072ms","start":"2026-02-17T16:09:07.591335Z","end":"2026-02-17T16:09:07.833606Z","steps":["trace[1348080101] 'process raft request' (duration: 241.476385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.833782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.211523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.833845Z","caller":"traceutil/trace.go:171","msg":"trace[243526649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:605; }","duration":"228.279756ms","start":"2026-02-17T16:09:07.605527Z","end":"2026-02-17T16:09:07.833807Z","steps":["trace[243526649] 'agreement among raft nodes before linearized reading' (duration: 228.211582ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:08.551698Z","caller":"traceutil/trace.go:171","msg":"trace[2025701843] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"113.621252ms","start":"2026-02-17T16:09:08.438055Z","end":"2026-02-17T16:09:08.551676Z","steps":["trace[2025701843] 'process raft request' (duration: 93.139391ms)","trace[2025701843] 'compare' (duration: 20.404866ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:08.673253Z","caller":"traceutil/trace.go:171","msg":"trace[959701616] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"123.409837ms","start":"2026-02-17T16:09:08.549826Z","end":"2026-02-17T16:09:08.673236Z","steps":["trace[959701616] 'process raft request' (duration: 110.945916ms)","trace[959701616] 'compare' (duration: 12.390856ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:09.162638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.328692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:09.162824Z","caller":"traceutil/trace.go:171","msg":"trace[1550313164] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"212.542438ms","start":"2026-02-17T16:09:08.950272Z","end":"2026-02-17T16:09:09.162814Z","steps":["trace[1550313164] 'process raft request' (duration: 212.494385ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:09.163034Z","caller":"traceutil/trace.go:171","msg":"trace[1941769327] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"291.411683ms","start":"2026-02-17T16:09:08.871616Z","end":"2026-02-17T16:09:09.163028Z","steps":["trace[1941769327] 'process raft request' (duration: 184.643526ms)","trace[1941769327] 'compare' (duration: 106.210074ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.269893Z","caller":"traceutil/trace.go:171","msg":"trace[1161564286] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"188.28319ms","start":"2026-02-17T16:09:11.081586Z","end":"2026-02-17T16:09:11.269869Z","steps":["trace[1161564286] 'process raft request' (duration: 180.743701ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.360682Z","caller":"traceutil/trace.go:171","msg":"trace[1484279559] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:690; }","duration":"211.808184ms","start":"2026-02-17T16:09:11.148853Z","end":"2026-02-17T16:09:11.360661Z","steps":["trace[1484279559] 'read index received' (duration: 113.48591ms)","trace[1484279559] 'applied index is now lower than readState.Index' (duration: 98.321364ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:11.360884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.005646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-17T16:09:11.360905Z","caller":"traceutil/trace.go:171","msg":"trace[1936923151] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:659; }","duration":"212.049818ms","start":"2026-02-17T16:09:11.148847Z","end":"2026-02-17T16:09:11.360897Z","steps":["trace[1936923151] 'agreement among raft nodes before linearized reading' (duration: 211.9172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.366747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.06115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:11.366774Z","caller":"traceutil/trace.go:171","msg":"trace[2084777131] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:660; }","duration":"123.117303ms","start":"2026-02-17T16:09:11.243649Z","end":"2026-02-17T16:09:11.366766Z","steps":["trace[2084777131] 'agreement among raft nodes before linearized reading' (duration: 122.89058ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.367058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.324866ms","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-17T16:09:11.367113Z","caller":"traceutil/trace.go:171","msg":"trace[959898817] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:660; }","duration":"123.40225ms","start":"2026-02-17T16:09:11.243697Z","end":"2026-02-17T16:09:11.367099Z","steps":["trace[959898817] 'agreement among raft nodes before linearized reading' (duration: 123.296514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.367267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.536709ms","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-17T16:09:11.367286Z","caller":"traceutil/trace.go:171","msg":"trace[1123986716] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:660; }","duration":"123.56709ms","start":"2026-02-17T16:09:11.243713Z","end":"2026-02-17T16:09:11.367281Z","steps":["trace[1123986716] 'agreement among raft nodes before linearized reading' (duration: 123.530408ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.487604Z","caller":"traceutil/trace.go:171","msg":"trace[64331135] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"114.050643ms","start":"2026-02-17T16:09:11.37354Z","end":"2026-02-17T16:09:11.487591Z","steps":["trace[64331135] 'process raft request' (duration: 113.969248ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.562335Z","caller":"traceutil/trace.go:171","msg":"trace[513741879] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:694; }","duration":"156.350266ms","start":"2026-02-17T16:09:11.405967Z","end":"2026-02-17T16:09:11.562318Z","steps":["trace[513741879] 'read index received' (duration: 81.82019ms)","trace[513741879] 'applied index is now lower than readState.Index' (duration: 74.529325ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.562547Z","caller":"traceutil/trace.go:171","msg":"trace[1214150515] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"188.695846ms","start":"2026-02-17T16:09:11.373844Z","end":"2026-02-17T16:09:11.562539Z","steps":["trace[1214150515] 'process raft request' (duration: 188.324084ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.562665Z","caller":"traceutil/trace.go:171","msg":"trace[177259049] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"188.823043ms","start":"2026-02-17T16:09:11.373833Z","end":"2026-02-17T16:09:11.562656Z","steps":["trace[177259049] 'process raft request' (duration: 188.429179ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.562773Z","caller":"traceutil/trace.go:171","msg":"trace[572984434] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"188.878686ms","start":"2026-02-17T16:09:11.373888Z","end":"2026-02-17T16:09:11.562766Z","steps":["trace[572984434] 'process raft request' (duration: 188.403258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.562916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.956342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T16:09:11.562943Z","caller":"traceutil/trace.go:171","msg":"trace[507027499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"157.016295ms","start":"2026-02-17T16:09:11.405915Z","end":"2026-02-17T16:09:11.562932Z","steps":["trace[507027499] 'agreement among raft nodes before linearized reading' (duration: 156.92293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.833993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.99783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:11.834066Z","caller":"traceutil/trace.go:171","msg":"trace[276070913] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"271.670044ms","start":"2026-02-17T16:09:11.562384Z","end":"2026-02-17T16:09:11.834054Z","steps":["trace[276070913] 'read index received' (duration: 45.502703ms)","trace[276070913] 'applied index is now lower than readState.Index' (duration: 226.1606ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.83411Z","caller":"traceutil/trace.go:171","msg":"trace[338045939] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"340.969328ms","start":"2026-02-17T16:09:11.493133Z","end":"2026-02-17T16:09:11.834103Z","steps":["trace[338045939] 'process raft request' (duration: 114.777696ms)","trace[338045939] 'compare' (duration: 225.847641ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:11.834148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:11.493117Z","time spent":"341.00905ms","remote":"127.0.0.1:49252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:11.834373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.647348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-17T16:09:11.834395Z","caller":"traceutil/trace.go:171","msg":"trace[447401062] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:665; }","duration":"286.689931ms","start":"2026-02-17T16:09:11.547697Z","end":"2026-02-17T16:09:11.834387Z","steps":["trace[447401062] 'agreement among raft nodes before linearized reading' (duration: 286.570213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.834529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.296928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-tvckt\" ","response":"range_response_count:1 size:3813"} {"level":"info","ts":"2026-02-17T16:09:11.834549Z","caller":"traceutil/trace.go:171","msg":"trace[993331073] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-tvckt; range_end:; response_count:1; response_revision:665; }","duration":"341.33451ms","start":"2026-02-17T16:09:11.493209Z","end":"2026-02-17T16:09:11.834543Z","steps":["trace[993331073] 'agreement among raft nodes before linearized reading' (duration: 341.276716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.834565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:11.493205Z","time spent":"341.356291ms","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3836,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-tvckt\" "} {"level":"info","ts":"2026-02-17T16:09:11.835407Z","caller":"traceutil/trace.go:171","msg":"trace[1122976340] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"259.01215ms","start":"2026-02-17T16:09:11.576385Z","end":"2026-02-17T16:09:11.835397Z","steps":["trace[1122976340] 'process raft request' (duration: 258.791807ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.836592Z","caller":"traceutil/trace.go:171","msg":"trace[794982539] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"260.144747ms","start":"2026-02-17T16:09:11.576435Z","end":"2026-02-17T16:09:11.83658Z","steps":["trace[794982539] 'process raft request' (duration: 258.783886ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.836913Z","caller":"traceutil/trace.go:171","msg":"trace[91483155] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"260.438435ms","start":"2026-02-17T16:09:11.57647Z","end":"2026-02-17T16:09:11.836908Z","steps":["trace[91483155] 'process raft request' (duration: 258.904833ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.836889Z","caller":"traceutil/trace.go:171","msg":"trace[1305816214] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"260.387441ms","start":"2026-02-17T16:09:11.576494Z","end":"2026-02-17T16:09:11.836882Z","steps":["trace[1305816214] 'process raft request' (duration: 260.36021ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.899486Z","caller":"traceutil/trace.go:171","msg":"trace[1784679853] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"287.68661ms","start":"2026-02-17T16:09:11.611781Z","end":"2026-02-17T16:09:11.899468Z","steps":["trace[1784679853] 'process raft request' (duration: 287.565322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.899946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.768229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-17T16:09:11.900049Z","caller":"traceutil/trace.go:171","msg":"trace[501738880] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:670; }","duration":"132.887736ms","start":"2026-02-17T16:09:11.767148Z","end":"2026-02-17T16:09:11.900036Z","steps":["trace[501738880] 'agreement among raft nodes before linearized reading' (duration: 132.634431ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.900303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.465251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T16:09:11.900386Z","caller":"traceutil/trace.go:171","msg":"trace[1911286693] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:670; }","duration":"133.556487ms","start":"2026-02-17T16:09:11.766819Z","end":"2026-02-17T16:09:11.900376Z","steps":["trace[1911286693] 'agreement among raft nodes before linearized reading' (duration: 133.44499ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.900907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.085088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T16:09:11.901034Z","caller":"traceutil/trace.go:171","msg":"trace[510457959] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:670; }","duration":"134.238347ms","start":"2026-02-17T16:09:11.766783Z","end":"2026-02-17T16:09:11.901022Z","steps":["trace[510457959] 'agreement among raft nodes before linearized reading' (duration: 134.070207ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.901397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.889485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T16:09:11.901493Z","caller":"traceutil/trace.go:171","msg":"trace[676429063] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:670; }","duration":"137.014243ms","start":"2026-02-17T16:09:11.764468Z","end":"2026-02-17T16:09:11.901482Z","steps":["trace[676429063] 'agreement among raft nodes before linearized reading' (duration: 136.866634ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.901889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.776342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-17T16:09:11.902005Z","caller":"traceutil/trace.go:171","msg":"trace[1776526386] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:670; }","duration":"153.90981ms","start":"2026-02-17T16:09:11.748084Z","end":"2026-02-17T16:09:11.901994Z","steps":["trace[1776526386] 'agreement among raft nodes before linearized reading' (duration: 153.721169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.902477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.199172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:09:11.902556Z","caller":"traceutil/trace.go:171","msg":"trace[156237200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:670; }","duration":"257.301637ms","start":"2026-02-17T16:09:11.645244Z","end":"2026-02-17T16:09:11.902545Z","steps":["trace[156237200] 'agreement among raft nodes before linearized reading' (duration: 257.155058ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.903312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.901596ms","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-17T16:09:11.909789Z","caller":"traceutil/trace.go:171","msg":"trace[1779472571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:670; }","duration":"283.413265ms","start":"2026-02-17T16:09:11.626357Z","end":"2026-02-17T16:09:11.90977Z","steps":["trace[1779472571] 'agreement among raft nodes before linearized reading' (duration: 276.866955ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.078688Z","caller":"traceutil/trace.go:171","msg":"trace[36311489] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"179.230576ms","start":"2026-02-17T16:09:11.899442Z","end":"2026-02-17T16:09:12.078673Z","steps":["trace[36311489] 'read index received' (duration: 169.001852ms)","trace[36311489] 'applied index is now lower than readState.Index' (duration: 10.228224ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:12.078818Z","caller":"traceutil/trace.go:171","msg":"trace[1288511357] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"237.832081ms","start":"2026-02-17T16:09:11.84098Z","end":"2026-02-17T16:09:12.078812Z","steps":["trace[1288511357] 'process raft request' (duration: 227.187593ms)","trace[1288511357] 'compare' (duration: 10.450396ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:12.078999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.737487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:09:12.079027Z","caller":"traceutil/trace.go:171","msg":"trace[547900421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:671; }","duration":"231.795362ms","start":"2026-02-17T16:09:11.847227Z","end":"2026-02-17T16:09:12.079022Z","steps":["trace[547900421] 'agreement among raft nodes before linearized reading' (duration: 231.680085ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.137569Z","caller":"traceutil/trace.go:171","msg":"trace[1385464559] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"147.555966ms","start":"2026-02-17T16:09:11.989996Z","end":"2026-02-17T16:09:12.137552Z","steps":["trace[1385464559] 'process raft request' (duration: 147.45135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.138498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.610764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:09:12.138577Z","caller":"traceutil/trace.go:171","msg":"trace[1529465301] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"228.77124ms","start":"2026-02-17T16:09:11.909786Z","end":"2026-02-17T16:09:12.138557Z","steps":["trace[1529465301] 'process raft request' (duration: 227.411799ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.138585Z","caller":"traceutil/trace.go:171","msg":"trace[1524216268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:674; }","duration":"108.734981ms","start":"2026-02-17T16:09:12.029831Z","end":"2026-02-17T16:09:12.138566Z","steps":["trace[1524216268] 'agreement among raft nodes before linearized reading' (duration: 108.498157ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.13874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.669535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-tvckt\" ","response":"range_response_count:1 size:4696"} {"level":"info","ts":"2026-02-17T16:09:12.138767Z","caller":"traceutil/trace.go:171","msg":"trace[838450467] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-tvckt; range_end:; response_count:1; response_revision:674; }","duration":"228.703516ms","start":"2026-02-17T16:09:11.910055Z","end":"2026-02-17T16:09:12.138759Z","steps":["trace[838450467] 'agreement among raft nodes before linearized reading' (duration: 228.657184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.139049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.10407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-5m469\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-17T16:09:12.139079Z","caller":"traceutil/trace.go:171","msg":"trace[1013431323] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-5m469; range_end:; response_count:1; response_revision:674; }","duration":"229.154824ms","start":"2026-02-17T16:09:11.909915Z","end":"2026-02-17T16:09:12.13907Z","steps":["trace[1013431323] 'agreement among raft nodes before linearized reading' (duration: 229.054488ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.139204Z","caller":"traceutil/trace.go:171","msg":"trace[45114336] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"226.464403ms","start":"2026-02-17T16:09:11.912728Z","end":"2026-02-17T16:09:12.139192Z","steps":["trace[45114336] 'process raft request' (duration: 224.57498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.139248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.480923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-flff6\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T16:09:12.139275Z","caller":"traceutil/trace.go:171","msg":"trace[417775753] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-flff6; range_end:; response_count:1; response_revision:674; }","duration":"229.514645ms","start":"2026-02-17T16:09:11.909753Z","end":"2026-02-17T16:09:12.139267Z","steps":["trace[417775753] 'agreement among raft nodes before linearized reading' (duration: 229.43325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.13943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.700056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-fb7tc\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T16:09:12.139471Z","caller":"traceutil/trace.go:171","msg":"trace[1572272832] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-fb7tc; range_end:; response_count:1; response_revision:674; }","duration":"229.75997ms","start":"2026-02-17T16:09:11.909692Z","end":"2026-02-17T16:09:12.139452Z","steps":["trace[1572272832] 'agreement among raft nodes before linearized reading' (duration: 229.681395ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.271252Z","caller":"traceutil/trace.go:171","msg":"trace[2001554475] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"100.536579ms","start":"2026-02-17T16:09:12.170681Z","end":"2026-02-17T16:09:12.271218Z","steps":["trace[2001554475] 'process raft request' (duration: 100.386ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.431424Z","caller":"traceutil/trace.go:171","msg":"trace[1986580217] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:708; }","duration":"245.055937ms","start":"2026-02-17T16:09:12.186307Z","end":"2026-02-17T16:09:12.431363Z","steps":["trace[1986580217] 'read index received' (duration: 84.70773ms)","trace[1986580217] 'applied index is now lower than readState.Index' (duration: 160.347497ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:12.431669Z","caller":"traceutil/trace.go:171","msg":"trace[1758764737] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"245.412889ms","start":"2026-02-17T16:09:12.186246Z","end":"2026-02-17T16:09:12.431659Z","steps":["trace[1758764737] 'process raft request' (duration: 209.393088ms)","trace[1758764737] 'compare' (duration: 35.573304ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:12.431889Z","caller":"traceutil/trace.go:171","msg":"trace[1119873793] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"245.487633ms","start":"2026-02-17T16:09:12.186377Z","end":"2026-02-17T16:09:12.431865Z","steps":["trace[1119873793] 'process raft request' (duration: 244.93696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.432268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.94379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-17T16:09:12.433816Z","caller":"traceutil/trace.go:171","msg":"trace[1486407524] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:678; }","duration":"247.517694ms","start":"2026-02-17T16:09:12.186288Z","end":"2026-02-17T16:09:12.433806Z","steps":["trace[1486407524] 'agreement among raft nodes before linearized reading' (duration: 245.7824ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:12.440616Z","caller":"traceutil/trace.go:171","msg":"trace[413175211] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"119.517687ms","start":"2026-02-17T16:09:12.321079Z","end":"2026-02-17T16:09:12.440597Z","steps":["trace[413175211] 'process raft request' (duration: 119.312595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.440918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.643635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:09:12.441002Z","caller":"traceutil/trace.go:171","msg":"trace[553832801] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:679; }","duration":"100.755243ms","start":"2026-02-17T16:09:12.340233Z","end":"2026-02-17T16:09:12.440989Z","steps":["trace[553832801] 'agreement among raft nodes before linearized reading' (duration: 100.623155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:12.44095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.187229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:12.441658Z","caller":"traceutil/trace.go:171","msg":"trace[79331328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"107.928653ms","start":"2026-02-17T16:09:12.33372Z","end":"2026-02-17T16:09:12.441649Z","steps":["trace[79331328] 'agreement among raft nodes before linearized reading' (duration: 107.193678ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:14.330183Z","caller":"traceutil/trace.go:171","msg":"trace[193895110] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:723; }","duration":"182.163511ms","start":"2026-02-17T16:09:14.148Z","end":"2026-02-17T16:09:14.330164Z","steps":["trace[193895110] 'read index received' (duration: 182.020483ms)","trace[193895110] 'applied index is now lower than readState.Index' (duration: 142.428µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:14.330393Z","caller":"traceutil/trace.go:171","msg":"trace[1001534892] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"225.406993ms","start":"2026-02-17T16:09:14.104979Z","end":"2026-02-17T16:09:14.330386Z","steps":["trace[1001534892] 'process raft request' (duration: 225.089574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.330608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.592257ms","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-17T16:09:14.33063Z","caller":"traceutil/trace.go:171","msg":"trace[976251735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:690; }","duration":"182.651201ms","start":"2026-02-17T16:09:14.147972Z","end":"2026-02-17T16:09:14.330623Z","steps":["trace[976251735] 'agreement among raft nodes before linearized reading' (duration: 182.556225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.33075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.836722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:09:14.330767Z","caller":"traceutil/trace.go:171","msg":"trace[1867577100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:690; }","duration":"181.865174ms","start":"2026-02-17T16:09:14.148897Z","end":"2026-02-17T16:09:14.330762Z","steps":["trace[1867577100] 'agreement among raft nodes before linearized reading' (duration: 181.816321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.331022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.137525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:09:14.331043Z","caller":"traceutil/trace.go:171","msg":"trace[1452018058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:690; }","duration":"158.159366ms","start":"2026-02-17T16:09:14.172877Z","end":"2026-02-17T16:09:14.331036Z","steps":["trace[1452018058] 'agreement among raft nodes before linearized reading' (duration: 158.097992ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:15.848331Z","caller":"traceutil/trace.go:171","msg":"trace[1473118907] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"166.135611ms","start":"2026-02-17T16:09:15.682174Z","end":"2026-02-17T16:09:15.84831Z","steps":["trace[1473118907] 'process raft request' (duration: 121.96752ms)","trace[1473118907] 'compare' (duration: 44.083726ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:15.902146Z","caller":"traceutil/trace.go:171","msg":"trace[1863538432] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:732; }","duration":"166.410048ms","start":"2026-02-17T16:09:15.73572Z","end":"2026-02-17T16:09:15.90213Z","steps":["trace[1863538432] 'read index received' (duration: 68.428919ms)","trace[1863538432] 'applied index is now lower than readState.Index' (duration: 97.978739ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:15.90248Z","caller":"traceutil/trace.go:171","msg":"trace[1658032092] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"168.223508ms","start":"2026-02-17T16:09:15.73425Z","end":"2026-02-17T16:09:15.902474Z","steps":["trace[1658032092] 'process raft request' (duration: 167.808043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:15.902771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.039567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ftc72\" ","response":"range_response_count:1 size:18246"} {"level":"info","ts":"2026-02-17T16:09:15.903005Z","caller":"traceutil/trace.go:171","msg":"trace[1645574273] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ftc72; range_end:; response_count:1; response_revision:699; }","duration":"167.299592ms","start":"2026-02-17T16:09:15.735698Z","end":"2026-02-17T16:09:15.902998Z","steps":["trace[1645574273] 'agreement among raft nodes before linearized reading' (duration: 166.985743ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:16.133482Z","caller":"traceutil/trace.go:171","msg":"trace[832646862] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"223.113473ms","start":"2026-02-17T16:09:15.910352Z","end":"2026-02-17T16:09:16.133466Z","steps":["trace[832646862] 'process raft request' (duration: 222.122412ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:16.152784Z","caller":"traceutil/trace.go:171","msg":"trace[1487758559] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"226.662585ms","start":"2026-02-17T16:09:15.926107Z","end":"2026-02-17T16:09:16.152769Z","steps":["trace[1487758559] 'process raft request' (duration: 226.350305ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:16.152838Z","caller":"traceutil/trace.go:171","msg":"trace[767947318] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"229.353959ms","start":"2026-02-17T16:09:15.923465Z","end":"2026-02-17T16:09:16.152819Z","steps":["trace[767947318] 'process raft request' (duration: 228.912552ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:16.330932Z","caller":"traceutil/trace.go:171","msg":"trace[1993376567] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"164.80349ms","start":"2026-02-17T16:09:16.166115Z","end":"2026-02-17T16:09:16.330919Z","steps":["trace[1993376567] 'process raft request' (duration: 71.829568ms)","trace[1993376567] 'compare' (duration: 92.883647ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:16.3417Z","caller":"traceutil/trace.go:171","msg":"trace[1896073509] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"164.390226ms","start":"2026-02-17T16:09:16.177293Z","end":"2026-02-17T16:09:16.341683Z","steps":["trace[1896073509] 'process raft request' (duration: 163.869294ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:16.40768Z","caller":"traceutil/trace.go:171","msg":"trace[566766768] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"105.552312ms","start":"2026-02-17T16:09:16.302112Z","end":"2026-02-17T16:09:16.407664Z","steps":["trace[566766768] 'process raft request' (duration: 105.095154ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:18.697557Z","caller":"traceutil/trace.go:171","msg":"trace[598679119] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"157.714651ms","start":"2026-02-17T16:09:18.539824Z","end":"2026-02-17T16:09:18.697539Z","steps":["trace[598679119] 'process raft request' (duration: 157.676289ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:18.697725Z","caller":"traceutil/trace.go:171","msg":"trace[1488394126] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"167.995546ms","start":"2026-02-17T16:09:18.529722Z","end":"2026-02-17T16:09:18.697717Z","steps":["trace[1488394126] 'process raft request' (duration: 137.427656ms)","trace[1488394126] 'compare' (duration: 30.163125ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:18.69779Z","caller":"traceutil/trace.go:171","msg":"trace[812488170] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:758; }","duration":"164.439167ms","start":"2026-02-17T16:09:18.533341Z","end":"2026-02-17T16:09:18.697781Z","steps":["trace[812488170] 'read index received' (duration: 133.817504ms)","trace[812488170] 'applied index is now lower than readState.Index' (duration: 30.620983ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:18.697887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.211318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:09:18.697912Z","caller":"traceutil/trace.go:171","msg":"trace[421545257] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:725; }","duration":"172.284352ms","start":"2026-02-17T16:09:18.52562Z","end":"2026-02-17T16:09:18.697904Z","steps":["trace[421545257] 'agreement among raft nodes before linearized reading' (duration: 172.189166ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:18.931994Z","caller":"traceutil/trace.go:171","msg":"trace[1075700826] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"139.621622ms","start":"2026-02-17T16:09:18.792356Z","end":"2026-02-17T16:09:18.931977Z","steps":["trace[1075700826] 'process raft request' (duration: 44.689632ms)","trace[1075700826] 'compare' (duration: 94.796442ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:18.934063Z","caller":"traceutil/trace.go:171","msg":"trace[767750406] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"141.583153ms","start":"2026-02-17T16:09:18.792473Z","end":"2026-02-17T16:09:18.934056Z","steps":["trace[767750406] 'process raft request' (duration: 141.518459ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:18.934201Z","caller":"traceutil/trace.go:171","msg":"trace[1930919218] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"139.10724ms","start":"2026-02-17T16:09:18.795089Z","end":"2026-02-17T16:09:18.934196Z","steps":["trace[1930919218] 'process raft request' (duration: 138.9424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:19.182597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.914859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:19.182773Z","caller":"traceutil/trace.go:171","msg":"trace[606097952] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"162.182294ms","start":"2026-02-17T16:09:19.02058Z","end":"2026-02-17T16:09:19.182762Z","steps":["trace[606097952] 'process raft request' (duration: 162.095799ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.182987Z","caller":"traceutil/trace.go:171","msg":"trace[1546986384] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"165.618838ms","start":"2026-02-17T16:09:19.017362Z","end":"2026-02-17T16:09:19.182981Z","steps":["trace[1546986384] 'process raft request' (duration: 64.196098ms)","trace[1546986384] 'compare' (duration: 100.825613ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:19.378258Z","caller":"traceutil/trace.go:171","msg":"trace[285739268] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:771; }","duration":"179.583235ms","start":"2026-02-17T16:09:19.198653Z","end":"2026-02-17T16:09:19.378237Z","steps":["trace[285739268] 'read index received' (duration: 28.386073ms)","trace[285739268] 'applied index is now lower than readState.Index' (duration: 151.196252ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:19.378512Z","caller":"traceutil/trace.go:171","msg":"trace[680184304] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"186.328744ms","start":"2026-02-17T16:09:19.192171Z","end":"2026-02-17T16:09:19.3785Z","steps":["trace[680184304] 'process raft request' (duration: 185.556196ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.37878Z","caller":"traceutil/trace.go:171","msg":"trace[187399740] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"185.512204ms","start":"2026-02-17T16:09:19.193259Z","end":"2026-02-17T16:09:19.378771Z","steps":["trace[187399740] 'process raft request' (duration: 184.831572ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.378973Z","caller":"traceutil/trace.go:171","msg":"trace[1192431745] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"180.755748ms","start":"2026-02-17T16:09:19.198208Z","end":"2026-02-17T16:09:19.378964Z","steps":["trace[1192431745] 'process raft request' (duration: 179.931737ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.381507Z","caller":"traceutil/trace.go:171","msg":"trace[816406766] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"182.87837ms","start":"2026-02-17T16:09:19.198614Z","end":"2026-02-17T16:09:19.381492Z","steps":["trace[816406766] 'process raft request' (duration: 179.569565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:19.382292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.626237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-tvckt\" ","response":"range_response_count:1 size:4811"} {"level":"info","ts":"2026-02-17T16:09:19.38234Z","caller":"traceutil/trace.go:171","msg":"trace[1325176216] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-tvckt; range_end:; response_count:1; response_revision:740; }","duration":"183.865501ms","start":"2026-02-17T16:09:19.198463Z","end":"2026-02-17T16:09:19.382328Z","steps":["trace[1325176216] 'agreement among raft nodes before linearized reading' (duration: 183.720312ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.633224Z","caller":"traceutil/trace.go:171","msg":"trace[451296344] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"241.224694ms","start":"2026-02-17T16:09:19.391975Z","end":"2026-02-17T16:09:19.633199Z","steps":["trace[451296344] 'process raft request' (duration: 172.536467ms)","trace[451296344] 'compare' (duration: 68.594831ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:19.651841Z","caller":"traceutil/trace.go:171","msg":"trace[1202018668] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"247.398918ms","start":"2026-02-17T16:09:19.404394Z","end":"2026-02-17T16:09:19.651793Z","steps":["trace[1202018668] 'process raft request' (duration: 247.314063ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.655723Z","caller":"traceutil/trace.go:171","msg":"trace[897994551] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"261.482733ms","start":"2026-02-17T16:09:19.394226Z","end":"2026-02-17T16:09:19.655709Z","steps":["trace[897994551] 'process raft request' (duration: 257.155755ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.656038Z","caller":"traceutil/trace.go:171","msg":"trace[902229512] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"254.459987ms","start":"2026-02-17T16:09:19.401569Z","end":"2026-02-17T16:09:19.656029Z","steps":["trace[902229512] 'process raft request' (duration: 249.975439ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:19.657398Z","caller":"traceutil/trace.go:171","msg":"trace[1434211366] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"253.032128ms","start":"2026-02-17T16:09:19.404357Z","end":"2026-02-17T16:09:19.657389Z","steps":["trace[1434211366] 'process raft request' (duration: 247.27475ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:24.833963Z","caller":"traceutil/trace.go:171","msg":"trace[882161080] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"135.801785ms","start":"2026-02-17T16:09:24.698131Z","end":"2026-02-17T16:09:24.833933Z","steps":["trace[882161080] 'read index received' (duration: 135.710389ms)","trace[882161080] 'applied index is now lower than readState.Index' (duration: 90.486µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:24.834187Z","caller":"traceutil/trace.go:171","msg":"trace[1376789519] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"241.461266ms","start":"2026-02-17T16:09:24.592707Z","end":"2026-02-17T16:09:24.834168Z","steps":["trace[1376789519] 'process raft request' (duration: 241.133995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:24.834267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.120155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:24.834931Z","caller":"traceutil/trace.go:171","msg":"trace[1637154549] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:775; }","duration":"136.834831ms","start":"2026-02-17T16:09:24.698088Z","end":"2026-02-17T16:09:24.834923Z","steps":["trace[1637154549] 'agreement among raft nodes before linearized reading' (duration: 136.142767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.832264Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255200624909014,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T16:09:26.981917Z","caller":"traceutil/trace.go:171","msg":"trace[872222941] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"649.656605ms","start":"2026-02-17T16:09:26.332245Z","end":"2026-02-17T16:09:26.981901Z","steps":["trace[872222941] 'read index received' (duration: 649.533397ms)","trace[872222941] 'applied index is now lower than readState.Index' (duration: 122.628µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:26.982016Z","caller":"traceutil/trace.go:171","msg":"trace[737929925] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"776.029328ms","start":"2026-02-17T16:09:26.205981Z","end":"2026-02-17T16:09:26.98201Z","steps":["trace[737929925] 'process raft request' (duration: 775.811354ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.982079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.205941Z","time spent":"776.089791ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:26.982216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.876633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:26.982286Z","caller":"traceutil/trace.go:171","msg":"trace[202292173] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:780; }","duration":"358.978649ms","start":"2026-02-17T16:09:26.623288Z","end":"2026-02-17T16:09:26.982267Z","steps":["trace[202292173] 'agreement among raft nodes before linearized reading' (duration: 358.867912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.982326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.623276Z","time spent":"359.038793ms","remote":"127.0.0.1:42564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:09:26.982386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.140816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:26.982406Z","caller":"traceutil/trace.go:171","msg":"trace[387517114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"650.185889ms","start":"2026-02-17T16:09:26.332214Z","end":"2026-02-17T16:09:26.9824Z","steps":["trace[387517114] 'agreement among raft nodes before linearized reading' (duration: 650.159327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.982418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.3322Z","time spent":"650.215321ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:09:26.982721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.370396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T16:09:26.98274Z","caller":"traceutil/trace.go:171","msg":"trace[192044192] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:780; }","duration":"144.411688ms","start":"2026-02-17T16:09:26.838323Z","end":"2026-02-17T16:09:26.982735Z","steps":["trace[192044192] 'agreement among raft nodes before linearized reading' (duration: 144.367065ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:27.384671Z","caller":"traceutil/trace.go:171","msg":"trace[1384761201] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"397.835366ms","start":"2026-02-17T16:09:26.986781Z","end":"2026-02-17T16:09:27.384616Z","steps":["trace[1384761201] 'process raft request' (duration: 397.728869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.385529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.986768Z","time spent":"398.021748ms","remote":"127.0.0.1:42504","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-17T16:09:27.387179Z","caller":"traceutil/trace.go:171","msg":"trace[61434842] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:819; }","duration":"400.293515ms","start":"2026-02-17T16:09:26.986872Z","end":"2026-02-17T16:09:27.387166Z","steps":["trace[61434842] 'read index received' (duration: 400.288784ms)","trace[61434842] 'applied index is now lower than readState.Index' (duration: 3.841µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:27.387737Z","caller":"traceutil/trace.go:171","msg":"trace[363892556] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"398.280026ms","start":"2026-02-17T16:09:26.989431Z","end":"2026-02-17T16:09:27.387711Z","steps":["trace[363892556] 'process raft request' (duration: 398.219652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.388012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.989418Z","time spent":"398.473008ms","remote":"127.0.0.1:42504","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-17T16:09:27.388652Z","caller":"traceutil/trace.go:171","msg":"trace[44423330] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"400.38634ms","start":"2026-02-17T16:09:26.988253Z","end":"2026-02-17T16:09:27.388639Z","steps":["trace[44423330] 'process raft request' (duration: 399.171982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.388717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.988237Z","time spent":"400.445874ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:27.388999Z","caller":"traceutil/trace.go:171","msg":"trace[443727361] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"400.232251ms","start":"2026-02-17T16:09:26.988721Z","end":"2026-02-17T16:09:27.388954Z","steps":["trace[443727361] 'process raft request' (duration: 398.896825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.389059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.988709Z","time spent":"400.316796ms","remote":"127.0.0.1:42504","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-17T16:09:27.389424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.341466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:27.389457Z","caller":"traceutil/trace.go:171","msg":"trace[701002976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"402.604032ms","start":"2026-02-17T16:09:26.986844Z","end":"2026-02-17T16:09:27.389448Z","steps":["trace[701002976] 'agreement among raft nodes before linearized reading' (duration: 400.381599ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.389524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.986828Z","time spent":"402.667446ms","remote":"127.0.0.1:42254","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-17T16:09:28.132881Z","caller":"traceutil/trace.go:171","msg":"trace[1678190785] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"139.417146ms","start":"2026-02-17T16:09:27.993445Z","end":"2026-02-17T16:09:28.132862Z","steps":["trace[1678190785] 'process raft request' (duration: 135.927081ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:31.666927Z","caller":"traceutil/trace.go:171","msg":"trace[1544044120] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"187.596157ms","start":"2026-02-17T16:09:31.479299Z","end":"2026-02-17T16:09:31.666895Z","steps":["trace[1544044120] 'process raft request' (duration: 94.003397ms)","trace[1544044120] 'compare' (duration: 93.476702ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:31.668662Z","caller":"traceutil/trace.go:171","msg":"trace[40472957] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"188.25353ms","start":"2026-02-17T16:09:31.480384Z","end":"2026-02-17T16:09:31.668638Z","steps":["trace[40472957] 'process raft request' (duration: 188.224899ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:31.668913Z","caller":"traceutil/trace.go:171","msg":"trace[900499156] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"188.624104ms","start":"2026-02-17T16:09:31.480283Z","end":"2026-02-17T16:09:31.668907Z","steps":["trace[900499156] 'process raft request' (duration: 188.244329ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:40.050977Z","caller":"traceutil/trace.go:171","msg":"trace[1238909914] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"233.800086ms","start":"2026-02-17T16:09:39.817155Z","end":"2026-02-17T16:09:40.050955Z","steps":["trace[1238909914] 'process raft request' (duration: 150.572202ms)","trace[1238909914] 'compare' (duration: 83.135747ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:43.976896Z","caller":"traceutil/trace.go:171","msg":"trace[1157598793] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"142.442854ms","start":"2026-02-17T16:09:43.834435Z","end":"2026-02-17T16:09:43.976878Z","steps":["trace[1157598793] 'process raft request' (duration: 122.472477ms)","trace[1157598793] 'compare' (duration: 19.892851ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:46.167672Z","caller":"traceutil/trace.go:171","msg":"trace[1093039054] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"183.762482ms","start":"2026-02-17T16:09:45.983895Z","end":"2026-02-17T16:09:46.167657Z","steps":["trace[1093039054] 'process raft request' (duration: 183.511525ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:55.394876Z","caller":"traceutil/trace.go:171","msg":"trace[1438773895] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:906; }","duration":"105.458052ms","start":"2026-02-17T16:09:55.2894Z","end":"2026-02-17T16:09:55.394858Z","steps":["trace[1438773895] 'read index received' (duration: 105.270768ms)","trace[1438773895] 'applied index is now lower than readState.Index' (duration: 186.603µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:55.395053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.636153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T16:09:55.395063Z","caller":"traceutil/trace.go:171","msg":"trace[917818503] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"136.785287ms","start":"2026-02-17T16:09:55.258259Z","end":"2026-02-17T16:09:55.395044Z","steps":["trace[917818503] 'process raft request' (duration: 136.469394ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:55.395078Z","caller":"traceutil/trace.go:171","msg":"trace[474349269] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:864; }","duration":"105.705408ms","start":"2026-02-17T16:09:55.289363Z","end":"2026-02-17T16:09:55.395069Z","steps":["trace[474349269] 'agreement among raft nodes before linearized reading' (duration: 105.58161ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:03.410174Z","caller":"traceutil/trace.go:171","msg":"trace[1672111648] transaction","detail":"{read_only:false; number_of_response:1; response_revision:904; }","duration":"218.406567ms","start":"2026-02-17T16:10:03.191746Z","end":"2026-02-17T16:10:03.410152Z","steps":["trace[1672111648] 'process raft request' (duration: 218.190052ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.040392Z","caller":"traceutil/trace.go:171","msg":"trace[1010730025] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"138.249786ms","start":"2026-02-17T16:10:03.902124Z","end":"2026-02-17T16:10:04.040374Z","steps":["trace[1010730025] 'process raft request' (duration: 138.16285ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.069032Z","caller":"traceutil/trace.go:171","msg":"trace[1588355000] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"137.528398ms","start":"2026-02-17T16:10:03.931493Z","end":"2026-02-17T16:10:04.069022Z","steps":["trace[1588355000] 'process raft request' (duration: 137.293791ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.558044Z","caller":"traceutil/trace.go:171","msg":"trace[629971183] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"183.491594ms","start":"2026-02-17T16:10:04.374498Z","end":"2026-02-17T16:10:04.55799Z","steps":["trace[629971183] 'process raft request' (duration: 150.346575ms)","trace[629971183] 'compare' (duration: 32.860839ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:09.189659Z","caller":"traceutil/trace.go:171","msg":"trace[39883533] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"612.030184ms","start":"2026-02-17T16:10:08.577614Z","end":"2026-02-17T16:10:09.189644Z","steps":["trace[39883533] 'process raft request' (duration: 611.919356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:09.189881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:08.577603Z","time spent":"612.189815ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:10:16.862142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.366452ms","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-17T16:10:16.86221Z","caller":"traceutil/trace.go:171","msg":"trace[1666899067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:961; }","duration":"709.463549ms","start":"2026-02-17T16:10:16.152731Z","end":"2026-02-17T16:10:16.862195Z","steps":["trace[1666899067] 'range keys from in-memory index tree' (duration: 709.251813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:16.862252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:16.152718Z","time spent":"709.526294ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:10:16.862495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.53605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:10:16.862532Z","caller":"traceutil/trace.go:171","msg":"trace[1122004791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:961; }","duration":"529.605565ms","start":"2026-02-17T16:10:16.332918Z","end":"2026-02-17T16:10:16.862523Z","steps":["trace[1122004791] 'range keys from in-memory index tree' (duration: 529.471665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:16.862558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:16.3329Z","time spent":"529.651659ms","remote":"127.0.0.1:42244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:10:16.862956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.540691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T16:10:16.862995Z","caller":"traceutil/trace.go:171","msg":"trace[1935116052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:961; }","duration":"374.615376ms","start":"2026-02-17T16:10:16.488371Z","end":"2026-02-17T16:10:16.862986Z","steps":["trace[1935116052] 'range keys from in-memory index tree' (duration: 374.408241ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:16.863028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:16.48835Z","time spent":"374.670921ms","remote":"127.0.0.1:42504","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-17T16:10:17.069767Z","caller":"traceutil/trace.go:171","msg":"trace[2080624328] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"196.335926ms","start":"2026-02-17T16:10:16.87341Z","end":"2026-02-17T16:10:17.069746Z","steps":["trace[2080624328] 'process raft request' (duration: 187.023015ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:20.281347Z","caller":"traceutil/trace.go:171","msg":"trace[252189383] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"211.009646ms","start":"2026-02-17T16:10:20.070119Z","end":"2026-02-17T16:10:20.281128Z","steps":["trace[252189383] 'process raft request' (duration: 210.863325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:20.841232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.736018ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:10:20.841334Z","caller":"traceutil/trace.go:171","msg":"trace[922610998] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"114.541358ms","start":"2026-02-17T16:10:20.726774Z","end":"2026-02-17T16:10:20.841315Z","steps":["trace[922610998] 'read index received' (duration: 3.661579ms)","trace[922610998] 'applied index is now lower than readState.Index' (duration: 110.878069ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:10:20.841821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.031903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329940"} {"level":"info","ts":"2026-02-17T16:10:20.841863Z","caller":"traceutil/trace.go:171","msg":"trace[1169626545] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:975; }","duration":"115.083027ms","start":"2026-02-17T16:10:20.726769Z","end":"2026-02-17T16:10:20.841852Z","steps":["trace[1169626545] 'agreement among raft nodes before linearized reading' (duration: 114.744692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:21.473813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.809171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-17T16:10:21.473911Z","caller":"traceutil/trace.go:171","msg":"trace[1991099557] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:978; }","duration":"121.011206ms","start":"2026-02-17T16:10:21.35288Z","end":"2026-02-17T16:10:21.473892Z","steps":["trace[1991099557] 'range keys from in-memory index tree' (duration: 120.392831ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:29.082069Z","caller":"traceutil/trace.go:171","msg":"trace[1710598273] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"103.094689ms","start":"2026-02-17T16:10:28.978951Z","end":"2026-02-17T16:10:29.082046Z","steps":["trace[1710598273] 'process raft request' (duration: 102.877853ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:33.375606Z","caller":"traceutil/trace.go:171","msg":"trace[550786710] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"110.385086ms","start":"2026-02-17T16:10:33.265195Z","end":"2026-02-17T16:10:33.37558Z","steps":["trace[550786710] 'process raft request' (duration: 33.365656ms)","trace[550786710] 'compare' (duration: 76.858038ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:10:34.224173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.55395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-02-17T16:10:34.224648Z","caller":"traceutil/trace.go:171","msg":"trace[425160231] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1014; }","duration":"140.062397ms","start":"2026-02-17T16:10:34.084566Z","end":"2026-02-17T16:10:34.224628Z","steps":["trace[425160231] 'range keys from in-memory index tree' (duration: 139.465273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:34.224516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.842679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"} {"level":"info","ts":"2026-02-17T16:10:34.224999Z","caller":"traceutil/trace.go:171","msg":"trace[716843017] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:1014; }","duration":"115.216057ms","start":"2026-02-17T16:10:34.10961Z","end":"2026-02-17T16:10:34.224826Z","steps":["trace[716843017] 'range keys from in-memory index tree' (duration: 114.58643ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:41.758952Z","caller":"traceutil/trace.go:171","msg":"trace[119164156] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"136.487051ms","start":"2026-02-17T16:10:41.622443Z","end":"2026-02-17T16:10:41.75893Z","steps":["trace[119164156] 'process raft request' (duration: 136.186208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:51.738729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.055184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:10:51.738782Z","caller":"traceutil/trace.go:171","msg":"trace[674442584] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1062; }","duration":"100.152722ms","start":"2026-02-17T16:10:51.638618Z","end":"2026-02-17T16:10:51.738771Z","steps":["trace[674442584] 'count revisions from in-memory index tree' (duration: 99.994651ms)"],"step_count":1}