{"level":"warn","ts":"2026-02-17T19:16:46.998852Z","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-17T19:16:46.999044Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-17T19:16:46.99916Z","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-17T19:16:46.999217Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-02-17T19:16:46.999278Z","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-17T19:16:47.00005Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-02-17T19:16:47.000197Z","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://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-17T19:16:47.006707Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.202031ms"} {"level":"info","ts":"2026-02-17T19:16:47.020133Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-02-17T19:16:47.020275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T19:16:47.020347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-02-17T19:16:47.020392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T19:16:47.020433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-02-17T19:16:47.0205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-02-17T19:16:47.028916Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T19:16:47.032357Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T19:16:47.035005Z","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-17T19:16:47.037646Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T19:16:47.053696Z","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-17T19:16:47.054216Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T19:16:47.054298Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T19:16:47.054426Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-02-17T19:16:47.054533Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-02-17T19:16:47.055431Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T19:16:47.059132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-02-17T19:16:47.059192Z","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-17T19:16:47.059453Z","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-17T19:16:47.059521Z","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-17T19:16:47.059665Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-02-17T19:16:48.023883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T19:16:48.023999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T19:16:48.024029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-02-17T19:16:48.024088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-02-17T19:16:48.024108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-02-17T19:16:48.024159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-02-17T19:16:48.02418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-02-17T19:16:48.025896Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T19:16:48.026055Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:48.026162Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:16:48.026456Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:16:48.026978Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T19:16:48.027029Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T19:16:48.027094Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:48.027171Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:48.02725Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:48.02843Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-02-17T19:16:48.032919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-17T19:16:51.145659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.606399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:16:51.145875Z","caller":"traceutil/trace.go:171","msg":"trace[1454034293] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"253.35671ms","start":"2026-02-17T19:16:50.892412Z","end":"2026-02-17T19:16:51.145769Z","steps":["trace[1454034293] 'process raft request' (duration: 79.651792ms)","trace[1454034293] 'compare' (duration: 172.430227ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:52.499156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084817394,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:16:53.659399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081228264s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:16:53.659567Z","caller":"traceutil/trace.go:171","msg":"trace[1522793091] linearizableReadLoop","detail":"{readStateIndex:214; appliedIndex:213; }","duration":"1.660762936s","start":"2026-02-17T19:16:51.998787Z","end":"2026-02-17T19:16:53.65955Z","steps":["trace[1522793091] 'read index received' (duration: 579.192939ms)","trace[1522793091] 'applied index is now lower than readState.Index' (duration: 1.081568197s)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:16:53.659926Z","caller":"traceutil/trace.go:171","msg":"trace[783972738] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"1.95246632s","start":"2026-02-17T19:16:51.707438Z","end":"2026-02-17T19:16:53.659905Z","steps":["trace[783972738] 'process raft request' (duration: 870.53014ms)","trace[783972738] 'compare' (duration: 1.080368127s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:53.660053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:51.707416Z","time spent":"1.952588251s","remote":"127.0.0.1:59008","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-17T19:16:53.660348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.661556752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3180"} {"level":"info","ts":"2026-02-17T19:16:53.660422Z","caller":"traceutil/trace.go:171","msg":"trace[878421244] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:209; }","duration":"1.661679943s","start":"2026-02-17T19:16:51.998728Z","end":"2026-02-17T19:16:53.660408Z","steps":["trace[878421244] 'agreement among raft nodes before linearized reading' (duration: 1.661571732s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:53.66048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:51.998692Z","time spent":"1.661776554s","remote":"127.0.0.1:58900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3203,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T19:16:53.660688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.285722051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:16:53.660752Z","caller":"traceutil/trace.go:171","msg":"trace[934444146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"1.285821732s","start":"2026-02-17T19:16:52.37492Z","end":"2026-02-17T19:16:53.660741Z","steps":["trace[934444146] 'agreement among raft nodes before linearized reading' (duration: 1.285741911s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:53.660884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:52.374901Z","time spent":"1.285895003s","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T19:16:53.661126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155736731s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2898"} {"level":"info","ts":"2026-02-17T19:16:53.66119Z","caller":"traceutil/trace.go:171","msg":"trace[2082757577] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:209; }","duration":"1.155835321s","start":"2026-02-17T19:16:52.505344Z","end":"2026-02-17T19:16:53.661179Z","steps":["trace[2082757577] 'agreement among raft nodes before linearized reading' (duration: 1.15574442s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:53.661241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:52.505327Z","time spent":"1.155903472s","remote":"127.0.0.1:58912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2921,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-17T19:16:54.021007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.34612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:16:54.021074Z","caller":"traceutil/trace.go:171","msg":"trace[574718172] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:225; }","duration":"155.453211ms","start":"2026-02-17T19:16:53.865604Z","end":"2026-02-17T19:16:54.021058Z","steps":["trace[574718172] 'range keys from in-memory index tree' (duration: 155.266609ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:54.030963Z","caller":"traceutil/trace.go:171","msg":"trace[268530661] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"132.511238ms","start":"2026-02-17T19:16:53.898438Z","end":"2026-02-17T19:16:54.030949Z","steps":["trace[268530661] 'process raft request' (duration: 132.386347ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:54.216005Z","caller":"traceutil/trace.go:171","msg":"trace[907625733] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"112.897409ms","start":"2026-02-17T19:16:54.103063Z","end":"2026-02-17T19:16:54.21596Z","steps":["trace[907625733] 'process raft request' (duration: 43.9541ms)","trace[907625733] 'compare' (duration: 68.681297ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:16:54.216457Z","caller":"traceutil/trace.go:171","msg":"trace[1673491281] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"110.955403ms","start":"2026-02-17T19:16:54.105482Z","end":"2026-02-17T19:16:54.216438Z","steps":["trace[1673491281] 'process raft request' (duration: 110.383339ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:54.356406Z","caller":"traceutil/trace.go:171","msg":"trace[31079763] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"133.742105ms","start":"2026-02-17T19:16:54.222649Z","end":"2026-02-17T19:16:54.356391Z","steps":["trace[31079763] 'process raft request' (duration: 114.574852ms)","trace[31079763] 'compare' (duration: 18.985441ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:16:54.356362Z","caller":"traceutil/trace.go:171","msg":"trace[32069716] linearizableReadLoop","detail":"{readStateIndex:238; appliedIndex:237; }","duration":"129.3312ms","start":"2026-02-17T19:16:54.227006Z","end":"2026-02-17T19:16:54.356337Z","steps":["trace[32069716] 'read index received' (duration: 110.209428ms)","trace[32069716] 'applied index is now lower than readState.Index' (duration: 19.120662ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:54.357239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.219317ms","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-17T19:16:54.357288Z","caller":"traceutil/trace.go:171","msg":"trace[1652811232] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:232; }","duration":"130.293998ms","start":"2026-02-17T19:16:54.22698Z","end":"2026-02-17T19:16:54.357273Z","steps":["trace[1652811232] 'agreement among raft nodes before linearized reading' (duration: 130.061666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:08.998842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144899651s","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-17T19:17:08.998953Z","caller":"traceutil/trace.go:171","msg":"trace[309736295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:452; }","duration":"1.145025101s","start":"2026-02-17T19:17:07.85387Z","end":"2026-02-17T19:17:08.998896Z","steps":["trace[309736295] 'range keys from in-memory index tree' (duration: 1.144744569s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:08.999066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:07.853853Z","time spent":"1.145202933s","remote":"127.0.0.1:59008","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-17T19:17:08.999431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145055721s","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-17T19:17:08.999478Z","caller":"traceutil/trace.go:171","msg":"trace[541892811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:452; }","duration":"1.145123172s","start":"2026-02-17T19:17:07.854346Z","end":"2026-02-17T19:17:08.99947Z","steps":["trace[541892811] 'range keys from in-memory index tree' (duration: 1.144999341s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:08.999661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:07.854337Z","time spent":"1.145315133s","remote":"127.0.0.1:59008","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-17T19:17:08.999857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13702619s","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-17T19:17:08.999885Z","caller":"traceutil/trace.go:171","msg":"trace[1460272304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:452; }","duration":"1.137248182s","start":"2026-02-17T19:17:07.86263Z","end":"2026-02-17T19:17:08.999878Z","steps":["trace[1460272304] 'range keys from in-memory index tree' (duration: 1.136907469s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:08.999945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:07.862608Z","time spent":"1.137329832s","remote":"127.0.0.1:59008","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-17T19:17:13.998147Z","caller":"traceutil/trace.go:171","msg":"trace[1857162609] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"213.849034ms","start":"2026-02-17T19:17:13.784274Z","end":"2026-02-17T19:17:13.998123Z","steps":["trace[1857162609] 'process raft request' (duration: 213.740653ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:15.183769Z","caller":"traceutil/trace.go:171","msg":"trace[1203573602] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"152.073823ms","start":"2026-02-17T19:17:15.031677Z","end":"2026-02-17T19:17:15.183751Z","steps":["trace[1203573602] 'process raft request' (duration: 151.983092ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:15.184143Z","caller":"traceutil/trace.go:171","msg":"trace[252715696] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:482; }","duration":"149.957526ms","start":"2026-02-17T19:17:15.034177Z","end":"2026-02-17T19:17:15.184135Z","steps":["trace[252715696] 'read index received' (duration: 149.954676ms)","trace[252715696] 'applied index is now lower than readState.Index' (duration: 2.27µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:15.184204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.012387ms","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-17T19:17:15.184228Z","caller":"traceutil/trace.go:171","msg":"trace[1997522454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:467; }","duration":"150.046737ms","start":"2026-02-17T19:17:15.034176Z","end":"2026-02-17T19:17:15.184222Z","steps":["trace[1997522454] 'agreement among raft nodes before linearized reading' (duration: 149.994007ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:15.192234Z","caller":"traceutil/trace.go:171","msg":"trace[1732522154] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"157.861276ms","start":"2026-02-17T19:17:15.034358Z","end":"2026-02-17T19:17:15.192219Z","steps":["trace[1732522154] 'process raft request' (duration: 157.791905ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:18.399953Z","caller":"traceutil/trace.go:171","msg":"trace[1277662216] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"104.495838ms","start":"2026-02-17T19:17:18.295402Z","end":"2026-02-17T19:17:18.399897Z","steps":["trace[1277662216] 'process raft request' (duration: 104.230566ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:18.400143Z","caller":"traceutil/trace.go:171","msg":"trace[488363902] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"104.277326ms","start":"2026-02-17T19:17:18.295843Z","end":"2026-02-17T19:17:18.40012Z","steps":["trace[488363902] 'process raft request' (duration: 103.834473ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:18.400374Z","caller":"traceutil/trace.go:171","msg":"trace[1679650150] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"105.014922ms","start":"2026-02-17T19:17:18.295324Z","end":"2026-02-17T19:17:18.400339Z","steps":["trace[1679650150] 'process raft request' (duration: 37.315152ms)","trace[1679650150] 'compare' (duration: 66.816813ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:18.400795Z","caller":"traceutil/trace.go:171","msg":"trace[228057816] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"105.387914ms","start":"2026-02-17T19:17:18.295373Z","end":"2026-02-17T19:17:18.400761Z","steps":["trace[228057816] 'process raft request' (duration: 104.202365ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:19.218602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.623324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:19.218719Z","caller":"traceutil/trace.go:171","msg":"trace[1141100234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"454.802816ms","start":"2026-02-17T19:17:18.763896Z","end":"2026-02-17T19:17:19.218698Z","steps":["trace[1141100234] 'range keys from in-memory index tree' (duration: 454.538224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:19.218788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:18.763881Z","time spent":"454.897017ms","remote":"127.0.0.1:58712","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-17T19:17:19.349217Z","caller":"traceutil/trace.go:171","msg":"trace[1125126861] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"124.403127ms","start":"2026-02-17T19:17:19.224802Z","end":"2026-02-17T19:17:19.349205Z","steps":["trace[1125126861] 'process raft request' (duration: 123.903813ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:19.348813Z","caller":"traceutil/trace.go:171","msg":"trace[616757096] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:525; }","duration":"114.095688ms","start":"2026-02-17T19:17:19.234699Z","end":"2026-02-17T19:17:19.348795Z","steps":["trace[616757096] 'read index received' (duration: 66.200268ms)","trace[616757096] 'applied index is now lower than readState.Index' (duration: 47.89477ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:19.349951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.244207ms","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-17T19:17:19.349975Z","caller":"traceutil/trace.go:171","msg":"trace[1182191000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"115.311348ms","start":"2026-02-17T19:17:19.234655Z","end":"2026-02-17T19:17:19.349966Z","steps":["trace[1182191000] 'agreement among raft nodes before linearized reading' (duration: 115.220788ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:20.395401Z","caller":"traceutil/trace.go:171","msg":"trace[1106119068] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"331.921104ms","start":"2026-02-17T19:17:20.063462Z","end":"2026-02-17T19:17:20.395383Z","steps":["trace[1106119068] 'process raft request' (duration: 331.780193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:20.395685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:20.063448Z","time spent":"332.161046ms","remote":"127.0.0.1:59008","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-17T19:17:21.191871Z","caller":"traceutil/trace.go:171","msg":"trace[640094430] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:529; }","duration":"911.199354ms","start":"2026-02-17T19:17:20.280638Z","end":"2026-02-17T19:17:21.191838Z","steps":["trace[640094430] 'read index received' (duration: 114.656612ms)","trace[640094430] 'applied index is now lower than readState.Index' (duration: 796.541252ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:21.192029Z","caller":"traceutil/trace.go:171","msg":"trace[628589598] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"963.485457ms","start":"2026-02-17T19:17:20.228509Z","end":"2026-02-17T19:17:21.191995Z","steps":["trace[628589598] 'process raft request' (duration: 881.143919ms)","trace[628589598] 'compare' (duration: 81.100619ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:21.192083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.417315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-17T19:17:21.192125Z","caller":"traceutil/trace.go:171","msg":"trace[2101503198] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:515; }","duration":"911.477156ms","start":"2026-02-17T19:17:20.280634Z","end":"2026-02-17T19:17:21.192111Z","steps":["trace[2101503198] 'agreement among raft nodes before linearized reading' (duration: 911.369545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:21.192161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:20.280596Z","time spent":"911.556237ms","remote":"127.0.0.1:58900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T19:17:21.192182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:20.22846Z","time spent":"963.635978ms","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:21.192384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.610925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:21.192414Z","caller":"traceutil/trace.go:171","msg":"trace[1512810477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"425.695595ms","start":"2026-02-17T19:17:20.76671Z","end":"2026-02-17T19:17:21.192406Z","steps":["trace[1512810477] 'agreement among raft nodes before linearized reading' (duration: 425.651485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:21.192439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:20.766681Z","time spent":"425.752346ms","remote":"127.0.0.1:58712","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-17T19:17:22.782092Z","caller":"traceutil/trace.go:171","msg":"trace[168832287] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"381.238227ms","start":"2026-02-17T19:17:22.400827Z","end":"2026-02-17T19:17:22.782065Z","steps":["trace[168832287] 'process raft request' (duration: 381.088426ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:22.78226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:22.400809Z","time spent":"381.360758ms","remote":"127.0.0.1:59008","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-17T19:17:25.60773Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084818039,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:25.814848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.59627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:25.815107Z","caller":"traceutil/trace.go:171","msg":"trace[503882047] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"177.240954ms","start":"2026-02-17T19:17:25.637844Z","end":"2026-02-17T19:17:25.815085Z","steps":["trace[503882047] 'process raft request' (duration: 177.184263ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:25.815354Z","caller":"traceutil/trace.go:171","msg":"trace[1713212087] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"782.329132ms","start":"2026-02-17T19:17:25.033013Z","end":"2026-02-17T19:17:25.815342Z","steps":["trace[1713212087] 'process raft request' (duration: 645.086407ms)","trace[1713212087] 'compare' (duration: 136.311848ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:25.815405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.033006Z","time spent":"782.372642ms","remote":"127.0.0.1:58928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:25.815637Z","caller":"traceutil/trace.go:171","msg":"trace[48938720] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"773.341695ms","start":"2026-02-17T19:17:25.042282Z","end":"2026-02-17T19:17:25.815624Z","steps":["trace[48938720] 'process raft request' (duration: 772.68372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:25.8157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.042265Z","time spent":"773.405835ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12733,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:25.816308Z","caller":"traceutil/trace.go:171","msg":"trace[1157215192] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:544; }","duration":"709.644209ms","start":"2026-02-17T19:17:25.10665Z","end":"2026-02-17T19:17:25.816294Z","steps":["trace[1157215192] 'read index received' (duration: 571.459567ms)","trace[1157215192] 'applied index is now lower than readState.Index' (duration: 138.183282ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:25.816644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.012961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:25.816675Z","caller":"traceutil/trace.go:171","msg":"trace[207630169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"710.096332ms","start":"2026-02-17T19:17:25.106569Z","end":"2026-02-17T19:17:25.816665Z","steps":["trace[207630169] 'agreement among raft nodes before linearized reading' (duration: 710.036911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:25.816704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.106514Z","time spent":"710.184533ms","remote":"127.0.0.1:58712","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-17T19:17:25.816914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.747638ms","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-17T19:17:25.816944Z","caller":"traceutil/trace.go:171","msg":"trace[876232513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"465.819589ms","start":"2026-02-17T19:17:25.351117Z","end":"2026-02-17T19:17:25.816936Z","steps":["trace[876232513] 'agreement among raft nodes before linearized reading' (duration: 465.705618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:25.81697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.351097Z","time spent":"465.866989ms","remote":"127.0.0.1:59008","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-17T19:17:25.817686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.511293ms","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-17T19:17:25.817783Z","caller":"traceutil/trace.go:171","msg":"trace[287708075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"324.672975ms","start":"2026-02-17T19:17:25.493096Z","end":"2026-02-17T19:17:25.817769Z","steps":["trace[287708075] 'agreement among raft nodes before linearized reading' (duration: 324.500744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:25.818033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.493075Z","time spent":"324.934267ms","remote":"127.0.0.1:59008","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-17T19:17:25.818569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.515971ms","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-17T19:17:25.818655Z","caller":"traceutil/trace.go:171","msg":"trace[514283821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"325.648421ms","start":"2026-02-17T19:17:25.492988Z","end":"2026-02-17T19:17:25.818636Z","steps":["trace[514283821] 'agreement among raft nodes before linearized reading' (duration: 324.729455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:25.818885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.49297Z","time spent":"325.900514ms","remote":"127.0.0.1:59008","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":"info","ts":"2026-02-17T19:17:26.035089Z","caller":"traceutil/trace.go:171","msg":"trace[822663518] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"207.790741ms","start":"2026-02-17T19:17:25.827274Z","end":"2026-02-17T19:17:26.035065Z","steps":["trace[822663518] 'process raft request' (duration: 119.023539ms)","trace[822663518] 'compare' (duration: 88.586181ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:26.035553Z","caller":"traceutil/trace.go:171","msg":"trace[1763028498] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"205.172352ms","start":"2026-02-17T19:17:25.830263Z","end":"2026-02-17T19:17:26.035436Z","steps":["trace[1763028498] 'process raft request' (duration: 204.766539ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.036023Z","caller":"traceutil/trace.go:171","msg":"trace[691198709] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"205.680215ms","start":"2026-02-17T19:17:25.830336Z","end":"2026-02-17T19:17:26.036016Z","steps":["trace[691198709] 'process raft request' (duration: 205.035851ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.037612Z","caller":"traceutil/trace.go:171","msg":"trace[1295539590] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"127.33004ms","start":"2026-02-17T19:17:25.909232Z","end":"2026-02-17T19:17:26.036562Z","steps":["trace[1295539590] 'process raft request' (duration: 126.665905ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.23932Z","caller":"traceutil/trace.go:171","msg":"trace[590441481] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"191.226045ms","start":"2026-02-17T19:17:26.048061Z","end":"2026-02-17T19:17:26.239287Z","steps":["trace[590441481] 'process raft request' (duration: 95.3036ms)","trace[590441481] 'compare' (duration: 95.785564ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:26.393243Z","caller":"traceutil/trace.go:171","msg":"trace[1546649203] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"143.895192ms","start":"2026-02-17T19:17:26.249324Z","end":"2026-02-17T19:17:26.393219Z","steps":["trace[1546649203] 'process raft request' (duration: 142.19406ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.652553Z","caller":"traceutil/trace.go:171","msg":"trace[1642209443] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"163.847352ms","start":"2026-02-17T19:17:26.488252Z","end":"2026-02-17T19:17:26.652099Z","steps":["trace[1642209443] 'process raft request' (duration: 89.83046ms)","trace[1642209443] 'compare' (duration: 73.67487ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:26.653467Z","caller":"traceutil/trace.go:171","msg":"trace[1823105853] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:561; }","duration":"153.168502ms","start":"2026-02-17T19:17:26.500284Z","end":"2026-02-17T19:17:26.653453Z","steps":["trace[1823105853] 'read index received' (duration: 77.80519ms)","trace[1823105853] 'applied index is now lower than readState.Index' (duration: 75.362522ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:26.653651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.339673ms","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-17T19:17:26.653705Z","caller":"traceutil/trace.go:171","msg":"trace[1076232422] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:549; }","duration":"153.429624ms","start":"2026-02-17T19:17:26.500264Z","end":"2026-02-17T19:17:26.653693Z","steps":["trace[1076232422] 'agreement among raft nodes before linearized reading' (duration: 153.237913ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.654595Z","caller":"traceutil/trace.go:171","msg":"trace[220452559] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"165.450134ms","start":"2026-02-17T19:17:26.489129Z","end":"2026-02-17T19:17:26.654579Z","steps":["trace[220452559] 'process raft request' (duration: 164.142774ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.654965Z","caller":"traceutil/trace.go:171","msg":"trace[1546950201] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"165.787006ms","start":"2026-02-17T19:17:26.489165Z","end":"2026-02-17T19:17:26.654952Z","steps":["trace[1546950201] 'process raft request' (duration: 164.173054ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.655115Z","caller":"traceutil/trace.go:171","msg":"trace[1913726242] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"165.906857ms","start":"2026-02-17T19:17:26.489198Z","end":"2026-02-17T19:17:26.655105Z","steps":["trace[1913726242] 'process raft request' (duration: 164.185125ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.655304Z","caller":"traceutil/trace.go:171","msg":"trace[395537049] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"161.556395ms","start":"2026-02-17T19:17:26.493737Z","end":"2026-02-17T19:17:26.655293Z","steps":["trace[395537049] 'process raft request' (duration: 159.680491ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:26.837528Z","caller":"traceutil/trace.go:171","msg":"trace[1259527791] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"102.791736ms","start":"2026-02-17T19:17:26.734705Z","end":"2026-02-17T19:17:26.837496Z","steps":["trace[1259527791] 'process raft request' (duration: 37.878012ms)","trace[1259527791] 'compare' (duration: 64.541931ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:31.04239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.237321ms","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-17T19:17:31.042462Z","caller":"traceutil/trace.go:171","msg":"trace[244769338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"132.364662ms","start":"2026-02-17T19:17:30.910082Z","end":"2026-02-17T19:17:31.042446Z","steps":["trace[244769338] 'range keys from in-memory index tree' (duration: 132.0817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.042601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.71986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cl8b7\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-17T19:17:31.042664Z","caller":"traceutil/trace.go:171","msg":"trace[1063941172] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cl8b7; range_end:; response_count:1; response_revision:562; }","duration":"572.822371ms","start":"2026-02-17T19:17:30.469826Z","end":"2026-02-17T19:17:31.042648Z","steps":["trace[1063941172] 'range keys from in-memory index tree' (duration: 572.528249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.04271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:30.469812Z","time spent":"572.892041ms","remote":"127.0.0.1:58912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-cl8b7\" "} {"level":"warn","ts":"2026-02-17T19:17:32.15065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084818101,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:32.243981Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.17794848s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T19:17:32.244689Z","caller":"traceutil/trace.go:171","msg":"trace[468429330] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.178706956s","start":"2026-02-17T19:17:31.065952Z","end":"2026-02-17T19:17:32.244658Z","steps":["trace[468429330] 'process raft request' (duration: 1.178585675s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.244851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.065937Z","time spent":"1.178817537s","remote":"127.0.0.1:59008","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-17T19:17:32.405264Z","caller":"traceutil/trace.go:171","msg":"trace[895990565] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.32918717s","start":"2026-02-17T19:17:31.076052Z","end":"2026-02-17T19:17:32.405239Z","steps":["trace[895990565] 'process raft request' (duration: 1.328933028s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.405408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.076038Z","time spent":"1.329291221s","remote":"127.0.0.1:58912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:32.405426Z","caller":"traceutil/trace.go:171","msg":"trace[697971733] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:581; }","duration":"755.13948ms","start":"2026-02-17T19:17:31.650258Z","end":"2026-02-17T19:17:32.405397Z","steps":["trace[697971733] 'read index received' (duration: 595.062574ms)","trace[697971733] 'applied index is now lower than readState.Index' (duration: 160.075666ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:32.40566Z","caller":"traceutil/trace.go:171","msg":"trace[757326764] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"755.244231ms","start":"2026-02-17T19:17:31.650401Z","end":"2026-02-17T19:17:32.405645Z","steps":["trace[757326764] 'process raft request' (duration: 754.714237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.405772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.650393Z","time spent":"755.297421ms","remote":"127.0.0.1:59008","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-17T19:17:32.405871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.613613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T19:17:32.405895Z","caller":"traceutil/trace.go:171","msg":"trace[1155945454] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:565; }","duration":"755.663364ms","start":"2026-02-17T19:17:31.650223Z","end":"2026-02-17T19:17:32.405886Z","steps":["trace[1155945454] 'agreement among raft nodes before linearized reading' (duration: 755.578194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.405915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.650199Z","time spent":"755.712675ms","remote":"127.0.0.1:58758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"warn","ts":"2026-02-17T19:17:32.40578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.325759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:32.405978Z","caller":"traceutil/trace.go:171","msg":"trace[1140781451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"638.56013ms","start":"2026-02-17T19:17:31.767406Z","end":"2026-02-17T19:17:32.405966Z","steps":["trace[1140781451] 'agreement among raft nodes before linearized reading' (duration: 638.349718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.406017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.767388Z","time spent":"638.61915ms","remote":"127.0.0.1:58712","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-17T19:17:32.406051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.754571ms","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-17T19:17:32.406071Z","caller":"traceutil/trace.go:171","msg":"trace[890910819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:565; }","duration":"260.798212ms","start":"2026-02-17T19:17:32.145267Z","end":"2026-02-17T19:17:32.406065Z","steps":["trace[890910819] 'agreement among raft nodes before linearized reading' (duration: 260.741201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.406193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.027143ms","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-17T19:17:32.40621Z","caller":"traceutil/trace.go:171","msg":"trace[785337744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:565; }","duration":"261.084594ms","start":"2026-02-17T19:17:32.14512Z","end":"2026-02-17T19:17:32.406205Z","steps":["trace[785337744] 'agreement among raft nodes before linearized reading' (duration: 261.036763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.406309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.017648ms","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-17T19:17:32.406334Z","caller":"traceutil/trace.go:171","msg":"trace[1419907720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"309.080409ms","start":"2026-02-17T19:17:32.097247Z","end":"2026-02-17T19:17:32.406328Z","steps":["trace[1419907720] 'agreement among raft nodes before linearized reading' (duration: 308.973978ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.406355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.097231Z","time spent":"309.115939ms","remote":"127.0.0.1:59008","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-17T19:17:32.911046Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084818106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:33.411204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084818106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:33.911947Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526860084818106,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:34.294299Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.80695178s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T19:17:34.410007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999772956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T19:17:34.410088Z","caller":"traceutil/trace.go:171","msg":"trace[90742291] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999887407s","start":"2026-02-17T19:17:32.410183Z","end":"2026-02-17T19:17:34.41007Z","steps":["trace[90742291] 'agreement among raft nodes before linearized reading' (duration: 1.999783636s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:34.410121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.410173Z","time spent":"1.999942317s","remote":"127.0.0.1:58722","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 19:17:34 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T19:17:36.251321Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.956844092s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T19:17:36.414626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000614333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:36.414725Z","caller":"traceutil/trace.go:171","msg":"trace[893816098] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000753584s","start":"2026-02-17T19:17:34.413948Z","end":"2026-02-17T19:17:36.414701Z","steps":["trace[893816098] 'agreement among raft nodes before linearized reading' (duration: 2.000628013s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.414779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:34.413942Z","time spent":"2.000827655s","remote":"127.0.0.1:58712","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-17T19:17:36.423358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.701579765s","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-17T19:17:36.42346Z","caller":"traceutil/trace.go:171","msg":"trace[1615551572] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:565; }","duration":"2.701695986s","start":"2026-02-17T19:17:33.721749Z","end":"2026-02-17T19:17:36.423445Z","steps":["trace[1615551572] 'range keys from in-memory index tree' (duration: 2.701566345s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.424523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.129969889s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-17T19:17:36.424756Z","caller":"traceutil/trace.go:171","msg":"trace[2138931492] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:583; }","duration":"4.014544924s","start":"2026-02-17T19:17:32.4102Z","end":"2026-02-17T19:17:36.424745Z","steps":["trace[2138931492] 'read index received' (duration: 1.884355873s)","trace[2138931492] 'applied index is now lower than readState.Index' (duration: 2.130188491s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:36.424812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.40902Z","time spent":"4.015790342s","remote":"127.0.0.1:58758","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T19:17:36.425036Z","caller":"traceutil/trace.go:171","msg":"trace[757884733] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"4.014669165s","start":"2026-02-17T19:17:32.410359Z","end":"2026-02-17T19:17:36.425028Z","steps":["trace[757884733] 'process raft request' (duration: 4.014219351s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.425111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.41035Z","time spent":"4.014703415s","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:36.425202Z","caller":"traceutil/trace.go:171","msg":"trace[790653566] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"4.006989008s","start":"2026-02-17T19:17:32.418205Z","end":"2026-02-17T19:17:36.425194Z","steps":["trace[790653566] 'process raft request' (duration: 4.006500884s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.425246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.418194Z","time spent":"4.007021438s","remote":"127.0.0.1:59008","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-17T19:17:36.425341Z","caller":"traceutil/trace.go:171","msg":"trace[505009887] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"4.006253082s","start":"2026-02-17T19:17:32.419081Z","end":"2026-02-17T19:17:36.425334Z","steps":["trace[505009887] 'process raft request' (duration: 4.005646578s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.425393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.41906Z","time spent":"4.006301482s","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:36.635439Z","caller":"traceutil/trace.go:171","msg":"trace[2108851742] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"206.827686ms","start":"2026-02-17T19:17:36.42859Z","end":"2026-02-17T19:17:36.635418Z","steps":["trace[2108851742] 'process raft request' (duration: 206.785815ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:36.635732Z","caller":"traceutil/trace.go:171","msg":"trace[415923522] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"421.174367ms","start":"2026-02-17T19:17:36.214552Z","end":"2026-02-17T19:17:36.635726Z","steps":["trace[415923522] 'process raft request' (duration: 420.707293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.635847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:36.214535Z","time spent":"421.209357ms","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:36.63584Z","caller":"traceutil/trace.go:171","msg":"trace[1492714973] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"2.223025673s","start":"2026-02-17T19:17:34.412752Z","end":"2026-02-17T19:17:36.635777Z","steps":["trace[1492714973] 'process raft request' (duration: 2.190149631s)","trace[1492714973] 'compare' (duration: 32.190347ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:36.635978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:34.412734Z","time spent":"2.223173564s","remote":"127.0.0.1:58798","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-17T19:17:36.635942Z","caller":"traceutil/trace.go:171","msg":"trace[1987948033] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:587; }","duration":"211.160987ms","start":"2026-02-17T19:17:36.424773Z","end":"2026-02-17T19:17:36.635934Z","steps":["trace[1987948033] 'read index received' (duration: 178.138764ms)","trace[1987948033] 'applied index is now lower than readState.Index' (duration: 33.021393ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:36.63614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.386913795s","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-17T19:17:36.636162Z","caller":"traceutil/trace.go:171","msg":"trace[810561254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"2.386978705s","start":"2026-02-17T19:17:34.249176Z","end":"2026-02-17T19:17:36.636155Z","steps":["trace[810561254] 'agreement among raft nodes before linearized reading' (duration: 2.386866584s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.63618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:34.249161Z","time spent":"2.387014735s","remote":"127.0.0.1:59008","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-17T19:17:36.636317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.478939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:36.636359Z","caller":"traceutil/trace.go:171","msg":"trace[1485068493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"219.559529ms","start":"2026-02-17T19:17:36.416788Z","end":"2026-02-17T19:17:36.636347Z","steps":["trace[1485068493] 'agreement among raft nodes before linearized reading' (duration: 219.484809ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:41.296394Z","caller":"traceutil/trace.go:171","msg":"trace[1936110696] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"291.464071ms","start":"2026-02-17T19:17:41.004905Z","end":"2026-02-17T19:17:41.296369Z","steps":["trace[1936110696] 'process raft request' (duration: 284.616761ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:50.105883Z","caller":"traceutil/trace.go:171","msg":"trace[1217954347] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"188.311146ms","start":"2026-02-17T19:17:49.917552Z","end":"2026-02-17T19:17:50.105863Z","steps":["trace[1217954347] 'process raft request' (duration: 158.437097ms)","trace[1217954347] 'compare' (duration: 29.797698ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:50.11099Z","caller":"traceutil/trace.go:171","msg":"trace[2027533945] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"165.415608ms","start":"2026-02-17T19:17:49.945561Z","end":"2026-02-17T19:17:50.110977Z","steps":["trace[2027533945] 'process raft request' (duration: 165.383958ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:50.111219Z","caller":"traceutil/trace.go:171","msg":"trace[1647177028] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"193.478204ms","start":"2026-02-17T19:17:49.917733Z","end":"2026-02-17T19:17:50.111211Z","steps":["trace[1647177028] 'process raft request' (duration: 193.147401ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:57.158329Z","caller":"traceutil/trace.go:171","msg":"trace[515676171] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"295.123018ms","start":"2026-02-17T19:17:56.863168Z","end":"2026-02-17T19:17:57.158291Z","steps":["trace[515676171] 'process raft request' (duration: 294.964847ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:57.120737Z","caller":"traceutil/trace.go:171","msg":"trace[1729413888] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"175.499771ms","start":"2026-02-17T19:18:56.945171Z","end":"2026-02-17T19:18:57.120671Z","steps":["trace[1729413888] 'process raft request' (duration: 174.897897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:57.120936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.186425ms","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-17T19:18:57.12098Z","caller":"traceutil/trace.go:171","msg":"trace[1622914120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:978; }","duration":"169.268086ms","start":"2026-02-17T19:18:56.9517Z","end":"2026-02-17T19:18:57.120968Z","steps":["trace[1622914120] 'agreement among raft nodes before linearized reading' (duration: 168.997704ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:57.120864Z","caller":"traceutil/trace.go:171","msg":"trace[1605159179] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1016; }","duration":"168.963884ms","start":"2026-02-17T19:18:56.951728Z","end":"2026-02-17T19:18:57.120692Z","steps":["trace[1605159179] 'read index received' (duration: 168.955424ms)","trace[1605159179] 'applied index is now lower than readState.Index' (duration: 6.98µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:57.129125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.474791ms","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-17T19:18:57.129289Z","caller":"traceutil/trace.go:171","msg":"trace[1495450329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:978; }","duration":"150.669102ms","start":"2026-02-17T19:18:56.978606Z","end":"2026-02-17T19:18:57.129275Z","steps":["trace[1495450329] 'agreement among raft nodes before linearized reading' (duration: 150.419471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.036737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.269736119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T19:19:09.037076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.857878613s","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-17T19:19:09.037174Z","caller":"traceutil/trace.go:171","msg":"trace[1390081908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1007; }","duration":"3.270148102s","start":"2026-02-17T19:19:05.766957Z","end":"2026-02-17T19:19:09.037105Z","steps":["trace[1390081908] 'range keys from in-memory index tree' (duration: 3.269687329s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.037451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.852990867s","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-17T19:19:09.037496Z","caller":"traceutil/trace.go:171","msg":"trace[641553227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1007; }","duration":"3.853055078s","start":"2026-02-17T19:19:05.184429Z","end":"2026-02-17T19:19:09.037484Z","steps":["trace[641553227] 'range keys from in-memory index tree' (duration: 3.852826016s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.037573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:05.184416Z","time spent":"3.853145909s","remote":"127.0.0.1:59008","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-17T19:19:09.037766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:05.766945Z","time spent":"3.270453834s","remote":"127.0.0.1:58712","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-17T19:19:09.038968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.549846831s","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-17T19:19:09.039003Z","caller":"traceutil/trace.go:171","msg":"trace[1503066278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1007; }","duration":"3.549913481s","start":"2026-02-17T19:19:05.489081Z","end":"2026-02-17T19:19:09.038994Z","steps":["trace[1503066278] 'range keys from in-memory index tree' (duration: 3.54970512s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.039935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:05.489061Z","time spent":"3.549956861s","remote":"127.0.0.1:59008","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-17T19:19:09.04016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.77558323s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:09.040229Z","caller":"traceutil/trace.go:171","msg":"trace[626688452] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1007; }","duration":"2.775701931s","start":"2026-02-17T19:19:06.264518Z","end":"2026-02-17T19:19:09.04022Z","steps":["trace[626688452] 'count revisions from in-memory index tree' (duration: 2.775466309s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.040375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:06.2645Z","time spent":"2.775857492s","remote":"127.0.0.1:37604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-17T19:19:09.040733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.719690639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:09.040852Z","caller":"traceutil/trace.go:171","msg":"trace[1532604159] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1007; }","duration":"2.719841249s","start":"2026-02-17T19:19:06.321002Z","end":"2026-02-17T19:19:09.040843Z","steps":["trace[1532604159] 'range keys from in-memory index tree' (duration: 2.719632957s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.040929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:06.320982Z","time spent":"2.71993901s","remote":"127.0.0.1:58876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-02-17T19:19:09.041351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.571866387s","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-17T19:19:09.041749Z","caller":"traceutil/trace.go:171","msg":"trace[703881634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1007; }","duration":"2.57228844s","start":"2026-02-17T19:19:06.469449Z","end":"2026-02-17T19:19:09.041738Z","steps":["trace[703881634] 'range keys from in-memory index tree' (duration: 2.571709546s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.041906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:06.469432Z","time spent":"2.572456661s","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T19:19:09.036756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.863884906s","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-17T19:19:09.043763Z","caller":"traceutil/trace.go:171","msg":"trace[729320889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"3.870944536s","start":"2026-02-17T19:19:05.172807Z","end":"2026-02-17T19:19:09.043752Z","steps":["trace[729320889] 'range keys from in-memory index tree' (duration: 3.863687794s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.044731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:05.172779Z","time spent":"3.871940643s","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T19:19:09.037268Z","caller":"traceutil/trace.go:171","msg":"trace[1291913758] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1007; }","duration":"3.857954854s","start":"2026-02-17T19:19:05.179167Z","end":"2026-02-17T19:19:09.037122Z","steps":["trace[1291913758] 'range keys from in-memory index tree' (duration: 3.85756437s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.045074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:05.179156Z","time spent":"3.865908351s","remote":"127.0.0.1:59008","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-17T19:19:09.102699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.031470376s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T19:19:09.102965Z","caller":"traceutil/trace.go:171","msg":"trace[2132891547] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"1.334214099s","start":"2026-02-17T19:19:07.768723Z","end":"2026-02-17T19:19:09.102937Z","steps":["trace[2132891547] 'read index received' (duration: 44.31µs)","trace[2132891547] 'applied index is now lower than readState.Index' (duration: 1.334167719s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:09.103253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.334513431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:09.103353Z","caller":"traceutil/trace.go:171","msg":"trace[1454532207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"1.334657763s","start":"2026-02-17T19:19:07.768674Z","end":"2026-02-17T19:19:09.103331Z","steps":["trace[1454532207] 'agreement among raft nodes before linearized reading' (duration: 1.334484782s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:09.1035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:07.768652Z","time spent":"1.334836894s","remote":"127.0.0.1:58722","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-17T19:19:15.573239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.524817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:19:15.573427Z","caller":"traceutil/trace.go:171","msg":"trace[1429435735] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"322.196222ms","start":"2026-02-17T19:19:15.251216Z","end":"2026-02-17T19:19:15.573412Z","steps":["trace[1429435735] 'read index received' (duration: 68.487251ms)","trace[1429435735] 'applied index is now lower than readState.Index' (duration: 253.708131ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:19:15.573735Z","caller":"traceutil/trace.go:171","msg":"trace[228702291] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"322.553376ms","start":"2026-02-17T19:19:15.251167Z","end":"2026-02-17T19:19:15.57372Z","steps":["trace[228702291] 'process raft request' (duration: 99.458404ms)","trace[228702291] 'compare' (duration: 222.378576ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:15.573819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:15.251159Z","time spent":"322.605346ms","remote":"127.0.0.1:59008","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-17T19:19:15.573855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.898169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/kubeadm:get-nodes\" ","response":"range_response_count:1 size:305"} {"level":"info","ts":"2026-02-17T19:19:15.573898Z","caller":"traceutil/trace.go:171","msg":"trace[634647560] range","detail":"{range_begin:/registry/clusterroles/kubeadm:get-nodes; range_end:; response_count:1; response_revision:1035; }","duration":"240.96933ms","start":"2026-02-17T19:19:15.332916Z","end":"2026-02-17T19:19:15.573885Z","steps":["trace[634647560] 'agreement among raft nodes before linearized reading' (duration: 240.886299ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:15.574048Z","caller":"traceutil/trace.go:171","msg":"trace[829599256] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"320.127678ms","start":"2026-02-17T19:19:15.253909Z","end":"2026-02-17T19:19:15.574037Z","steps":["trace[829599256] 'process raft request' (duration: 319.433353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:15.574104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:15.2539Z","time spent":"320.169538ms","remote":"127.0.0.1:59008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:19:15.57427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.048458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-02-17T19:19:15.574335Z","caller":"traceutil/trace.go:171","msg":"trace[1794144994] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:1035; }","duration":"323.122829ms","start":"2026-02-17T19:19:15.2512Z","end":"2026-02-17T19:19:15.574323Z","steps":["trace[1794144994] 'agreement among raft nodes before linearized reading' (duration: 323.034808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:15.574366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:15.251195Z","time spent":"323.16456ms","remote":"127.0.0.1:59106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":3498,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"warn","ts":"2026-02-17T19:19:17.354613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.711416ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T19:19:17.354798Z","caller":"traceutil/trace.go:171","msg":"trace[1223352545] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1078; }","duration":"225.866721ms","start":"2026-02-17T19:19:17.128914Z","end":"2026-02-17T19:19:17.35478Z","steps":["trace[1223352545] 'read index received' (duration: 97.934752ms)","trace[1223352545] 'applied index is now lower than readState.Index' (duration: 127.930199ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:17.355193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.260914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:19:17.35527Z","caller":"traceutil/trace.go:171","msg":"trace[1145593125] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1035; }","duration":"226.373855ms","start":"2026-02-17T19:19:17.12888Z","end":"2026-02-17T19:19:17.355253Z","steps":["trace[1145593125] 'agreement among raft nodes before linearized reading' (duration: 226.248254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.355216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.600257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium-operator\" ","response":"range_response_count:1 size:785"} {"level":"info","ts":"2026-02-17T19:19:17.356215Z","caller":"traceutil/trace.go:171","msg":"trace[1664879589] range","detail":"{range_begin:/registry/clusterrolebindings/cilium-operator; range_end:; response_count:1; response_revision:1035; }","duration":"202.624274ms","start":"2026-02-17T19:19:17.153573Z","end":"2026-02-17T19:19:17.356197Z","steps":["trace[1664879589] 'agreement among raft nodes before linearized reading' (duration: 201.570046ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.356768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.637047ms","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-17T19:19:17.357048Z","caller":"traceutil/trace.go:171","msg":"trace[1365410215] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1035; }","duration":"109.937709ms","start":"2026-02-17T19:19:17.247088Z","end":"2026-02-17T19:19:17.357026Z","steps":["trace[1365410215] 'agreement among raft nodes before linearized reading' (duration: 109.586666ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.357708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.437743ms","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-17T19:19:17.360252Z","caller":"traceutil/trace.go:171","msg":"trace[668487833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1035; }","duration":"198.023071ms","start":"2026-02-17T19:19:17.162219Z","end":"2026-02-17T19:19:17.360243Z","steps":["trace[668487833] 'agreement among raft nodes before linearized reading' (duration: 195.384702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.357759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.704452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:698"} {"level":"info","ts":"2026-02-17T19:19:17.361822Z","caller":"traceutil/trace.go:171","msg":"trace[364114403] range","detail":"{range_begin:/registry/clusterroles/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:1035; }","duration":"175.782671ms","start":"2026-02-17T19:19:17.186023Z","end":"2026-02-17T19:19:17.361806Z","steps":["trace[364114403] 'agreement among raft nodes before linearized reading' (duration: 171.709072ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:17.502934Z","caller":"traceutil/trace.go:171","msg":"trace[406850100] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"136.489479ms","start":"2026-02-17T19:19:17.366421Z","end":"2026-02-17T19:19:17.50291Z","steps":["trace[406850100] 'process raft request' (duration: 136.349588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.503407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.926668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:698"} {"level":"info","ts":"2026-02-17T19:19:17.503472Z","caller":"traceutil/trace.go:171","msg":"trace[284037098] range","detail":"{range_begin:/registry/clusterroles/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:1036; }","duration":"135.041229ms","start":"2026-02-17T19:19:17.368417Z","end":"2026-02-17T19:19:17.503458Z","steps":["trace[284037098] 'agreement among raft nodes before linearized reading' (duration: 134.758517ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:17.503027Z","caller":"traceutil/trace.go:171","msg":"trace[1959606140] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1080; }","duration":"134.559185ms","start":"2026-02-17T19:19:17.368441Z","end":"2026-02-17T19:19:17.503Z","steps":["trace[1959606140] 'read index received' (duration: 134.550605ms)","trace[1959606140] 'applied index is now lower than readState.Index' (duration: 6.73µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:17.535404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.372079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-02-17T19:19:17.535456Z","caller":"traceutil/trace.go:171","msg":"trace[863409601] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:1038; }","duration":"104.461909ms","start":"2026-02-17T19:19:17.430982Z","end":"2026-02-17T19:19:17.535444Z","steps":["trace[863409601] 'agreement among raft nodes before linearized reading' (duration: 104.367259ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:17.536187Z","caller":"traceutil/trace.go:171","msg":"trace[1806237066] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"167.699094ms","start":"2026-02-17T19:19:17.36848Z","end":"2026-02-17T19:19:17.536179Z","steps":["trace[1806237066] 'process raft request' (duration: 166.746147ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:17.536289Z","caller":"traceutil/trace.go:171","msg":"trace[778763383] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"166.941688ms","start":"2026-02-17T19:19:17.369341Z","end":"2026-02-17T19:19:17.536282Z","steps":["trace[778763383] 'process raft request' (duration: 165.988632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.692382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.526744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:cronjob-controller\" ","response":"range_response_count:1 size:835"} {"level":"info","ts":"2026-02-17T19:19:17.692462Z","caller":"traceutil/trace.go:171","msg":"trace[1684150976] range","detail":"{range_begin:/registry/clusterroles/system:controller:cronjob-controller; range_end:; response_count:1; response_revision:1038; }","duration":"110.636084ms","start":"2026-02-17T19:19:17.58181Z","end":"2026-02-17T19:19:17.692446Z","steps":["trace[1684150976] 'range keys from in-memory index tree' (duration: 110.475974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.692912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.113426ms","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-17T19:19:17.6931Z","caller":"traceutil/trace.go:171","msg":"trace[948524890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1038; }","duration":"108.300078ms","start":"2026-02-17T19:19:17.584752Z","end":"2026-02-17T19:19:17.693052Z","steps":["trace[948524890] 'range keys from in-memory index tree' (duration: 107.961045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:17.69394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.134884ms","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-17T19:19:17.694624Z","caller":"traceutil/trace.go:171","msg":"trace[2063095736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1038; }","duration":"109.512897ms","start":"2026-02-17T19:19:17.584787Z","end":"2026-02-17T19:19:17.6943Z","steps":["trace[2063095736] 'range keys from in-memory index tree' (duration: 109.079843ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:18.003436Z","caller":"traceutil/trace.go:171","msg":"trace[232719416] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"303.097365ms","start":"2026-02-17T19:19:17.700313Z","end":"2026-02-17T19:19:18.003411Z","steps":["trace[232719416] 'process raft request' (duration: 302.971964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:18.003578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:17.700296Z","time spent":"303.212017ms","remote":"127.0.0.1:59008","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-17T19:19:18.051638Z","caller":"traceutil/trace.go:171","msg":"trace[76319185] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"287.804425ms","start":"2026-02-17T19:19:17.763808Z","end":"2026-02-17T19:19:18.051613Z","steps":["trace[76319185] 'read index received' (duration: 240.480775ms)","trace[76319185] 'applied index is now lower than readState.Index' (duration: 47.32228ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:18.05207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.2476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:18.052287Z","caller":"traceutil/trace.go:171","msg":"trace[797417390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"288.509101ms","start":"2026-02-17T19:19:17.763757Z","end":"2026-02-17T19:19:18.052266Z","steps":["trace[797417390] 'agreement among raft nodes before linearized reading' (duration: 288.199279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:18.052557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.004896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:get-nodes\" ","response":"range_response_count:1 size:469"} {"level":"info","ts":"2026-02-17T19:19:18.052599Z","caller":"traceutil/trace.go:171","msg":"trace[1665281853] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:get-nodes; range_end:; response_count:1; response_revision:1040; }","duration":"260.073937ms","start":"2026-02-17T19:19:17.792513Z","end":"2026-02-17T19:19:18.052587Z","steps":["trace[1665281853] 'agreement among raft nodes before linearized reading' (duration: 260.004457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:18.052465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.27967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:cronjob-controller\" ","response":"range_response_count:1 size:835"} {"level":"info","ts":"2026-02-17T19:19:18.053128Z","caller":"traceutil/trace.go:171","msg":"trace[1577582002] range","detail":"{range_begin:/registry/clusterroles/system:controller:cronjob-controller; range_end:; response_count:1; response_revision:1040; }","duration":"271.274217ms","start":"2026-02-17T19:19:17.781839Z","end":"2026-02-17T19:19:18.053113Z","steps":["trace[1577582002] 'agreement among raft nodes before linearized reading' (duration: 270.273ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:18.054052Z","caller":"traceutil/trace.go:171","msg":"trace[857551858] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"350.407895ms","start":"2026-02-17T19:19:17.702696Z","end":"2026-02-17T19:19:18.053104Z","steps":["trace[857551858] 'process raft request' (duration: 348.583102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:18.054389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:17.702684Z","time spent":"351.605194ms","remote":"127.0.0.1:59008","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-17T19:19:18.378404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.598378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:958"} {"level":"info","ts":"2026-02-17T19:19:18.378483Z","caller":"traceutil/trace.go:171","msg":"trace[1522673541] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1040; }","duration":"229.713069ms","start":"2026-02-17T19:19:18.148752Z","end":"2026-02-17T19:19:18.378465Z","steps":["trace[1522673541] 'range keys from in-memory index tree' (duration: 229.495238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:18.378725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.624358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:get-nodes\" ","response":"range_response_count:1 size:469"} {"level":"info","ts":"2026-02-17T19:19:18.378881Z","caller":"traceutil/trace.go:171","msg":"trace[1832097141] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:get-nodes; range_end:; response_count:1; response_revision:1040; }","duration":"254.747648ms","start":"2026-02-17T19:19:18.124069Z","end":"2026-02-17T19:19:18.378816Z","steps":["trace[1832097141] 'range keys from in-memory index tree' (duration: 254.563838ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:30.255772Z","caller":"traceutil/trace.go:171","msg":"trace[766201251] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"184.566784ms","start":"2026-02-17T19:19:30.071187Z","end":"2026-02-17T19:19:30.255754Z","steps":["trace[766201251] 'read index received' (duration: 184.414433ms)","trace[766201251] 'applied index is now lower than readState.Index' (duration: 151.331µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:19:30.256182Z","caller":"traceutil/trace.go:171","msg":"trace[633735851] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"188.005228ms","start":"2026-02-17T19:19:30.06816Z","end":"2026-02-17T19:19:30.256165Z","steps":["trace[633735851] 'process raft request' (duration: 187.492625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:30.256755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.549822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-02-17T19:19:30.256849Z","caller":"traceutil/trace.go:171","msg":"trace[2067127736] range","detail":"{range_begin:/registry/configmaps/kube-public/kube-root-ca.crt; range_end:; response_count:1; response_revision:1074; }","duration":"185.660292ms","start":"2026-02-17T19:19:30.071173Z","end":"2026-02-17T19:19:30.256834Z","steps":["trace[2067127736] 'agreement among raft nodes before linearized reading' (duration: 185.526381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:30.257234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.624982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/default/\" range_end:\"/registry/roles/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:30.257529Z","caller":"traceutil/trace.go:171","msg":"trace[240043382] range","detail":"{range_begin:/registry/roles/default/; range_end:/registry/roles/default0; response_count:0; response_revision:1074; }","duration":"100.950524ms","start":"2026-02-17T19:19:30.156566Z","end":"2026-02-17T19:19:30.257517Z","steps":["trace[240043382] 'agreement among raft nodes before linearized reading' (duration: 100.632302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:30.257858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.474024ms","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-17T19:19:30.257924Z","caller":"traceutil/trace.go:171","msg":"trace[336613177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1074; }","duration":"117.555724ms","start":"2026-02-17T19:19:30.140349Z","end":"2026-02-17T19:19:30.257905Z","steps":["trace[336613177] 'agreement among raft nodes before linearized reading' (duration: 117.320882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:30.258592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.894528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-public/\" range_end:\"/registry/daemonsets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:19:30.25864Z","caller":"traceutil/trace.go:171","msg":"trace[1368242871] range","detail":"{range_begin:/registry/daemonsets/kube-public/; range_end:/registry/daemonsets/kube-public0; response_count:0; response_revision:1074; }","duration":"159.958878ms","start":"2026-02-17T19:19:30.098668Z","end":"2026-02-17T19:19:30.258627Z","steps":["trace[1368242871] 'agreement among raft nodes before linearized reading' (duration: 159.881098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:30.257562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.211572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/cluster-info\" ","response":"range_response_count:1 size:2178"} {"level":"info","ts":"2026-02-17T19:19:30.260357Z","caller":"traceutil/trace.go:171","msg":"trace[660227298] range","detail":"{range_begin:/registry/configmaps/kube-public/cluster-info; range_end:; response_count:1; response_revision:1074; }","duration":"162.046143ms","start":"2026-02-17T19:19:30.098294Z","end":"2026-02-17T19:19:30.26034Z","steps":["trace[660227298] 'agreement among raft nodes before linearized reading' (duration: 158.96907ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:40.00127Z","caller":"traceutil/trace.go:171","msg":"trace[906729090] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1147; }","duration":"207.283877ms","start":"2026-02-17T19:19:39.793952Z","end":"2026-02-17T19:19:40.001236Z","steps":["trace[906729090] 'read index received' (duration: 75.935084ms)","trace[906729090] 'applied index is now lower than readState.Index' (duration: 131.347333ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:19:40.001635Z","caller":"traceutil/trace.go:171","msg":"trace[1748794755] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"215.344295ms","start":"2026-02-17T19:19:39.786264Z","end":"2026-02-17T19:19:40.001608Z","steps":["trace[1748794755] 'process raft request' (duration: 136.994033ms)","trace[1748794755] 'compare' (duration: 77.802378ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:40.002723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.740928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-17T19:19:40.002796Z","caller":"traceutil/trace.go:171","msg":"trace[1837966000] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:1101; }","duration":"208.829208ms","start":"2026-02-17T19:19:39.793948Z","end":"2026-02-17T19:19:40.002777Z","steps":["trace[1837966000] 'agreement among raft nodes before linearized reading' (duration: 208.686707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:40.002986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.566829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-dns\" ","response":"range_response_count:1 size:1211"} {"level":"info","ts":"2026-02-17T19:19:40.003498Z","caller":"traceutil/trace.go:171","msg":"trace[816489302] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-dns; range_end:; response_count:1; response_revision:1101; }","duration":"148.114172ms","start":"2026-02-17T19:19:39.855373Z","end":"2026-02-17T19:19:40.003487Z","steps":["trace[816489302] 'agreement among raft nodes before linearized reading' (duration: 147.536168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:40.227976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.693077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-17T19:19:40.228823Z","caller":"traceutil/trace.go:171","msg":"trace[387672269] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1101; }","duration":"117.583483ms","start":"2026-02-17T19:19:40.111224Z","end":"2026-02-17T19:19:40.228808Z","steps":["trace[387672269] 'range keys from in-memory index tree' (duration: 116.569755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:40.228173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.76915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-17T19:19:40.229117Z","caller":"traceutil/trace.go:171","msg":"trace[1416409814] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:1101; }","duration":"116.722056ms","start":"2026-02-17T19:19:40.112383Z","end":"2026-02-17T19:19:40.229105Z","steps":["trace[1416409814] 'range keys from in-memory index tree' (duration: 115.727909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:42.62076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.93733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3717"} {"level":"warn","ts":"2026-02-17T19:19:42.62107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.199035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64303"} {"level":"info","ts":"2026-02-17T19:19:42.621233Z","caller":"traceutil/trace.go:171","msg":"trace[246177569] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:1108; }","duration":"151.373356ms","start":"2026-02-17T19:19:42.469841Z","end":"2026-02-17T19:19:42.621214Z","steps":["trace[246177569] 'range keys from in-memory index tree' (duration: 150.440309ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:42.620854Z","caller":"traceutil/trace.go:171","msg":"trace[1203853569] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1108; }","duration":"120.044332ms","start":"2026-02-17T19:19:42.500774Z","end":"2026-02-17T19:19:42.620818Z","steps":["trace[1203853569] 'range keys from in-memory index tree' (duration: 119.780039ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:44.082902Z","caller":"traceutil/trace.go:171","msg":"trace[2147423814] linearizableReadLoop","detail":"{readStateIndex:1159; appliedIndex:1158; }","duration":"214.327177ms","start":"2026-02-17T19:19:43.868544Z","end":"2026-02-17T19:19:44.082871Z","steps":["trace[2147423814] 'read index received' (duration: 214.158986ms)","trace[2147423814] 'applied index is now lower than readState.Index' (duration: 167.601µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:19:44.083108Z","caller":"traceutil/trace.go:171","msg":"trace[1996742510] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"240.636636ms","start":"2026-02-17T19:19:43.842463Z","end":"2026-02-17T19:19:44.0831Z","steps":["trace[1996742510] 'process raft request' (duration: 240.299124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:44.083285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.73325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:19:44.083405Z","caller":"traceutil/trace.go:171","msg":"trace[1140919738] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1110; }","duration":"214.928742ms","start":"2026-02-17T19:19:43.868469Z","end":"2026-02-17T19:19:44.083398Z","steps":["trace[1140919738] 'agreement among raft nodes before linearized reading' (duration: 214.777861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:44.083475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.437137ms","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-17T19:19:44.083492Z","caller":"traceutil/trace.go:171","msg":"trace[1545879096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1110; }","duration":"190.505397ms","start":"2026-02-17T19:19:43.892982Z","end":"2026-02-17T19:19:44.083487Z","steps":["trace[1545879096] 'agreement among raft nodes before linearized reading' (duration: 190.332026ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:46.794382Z","caller":"traceutil/trace.go:171","msg":"trace[2101436457] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"108.889671ms","start":"2026-02-17T19:19:46.685473Z","end":"2026-02-17T19:19:46.794362Z","steps":["trace[2101436457] 'process raft request' (duration: 108.69061ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:47.277792Z","caller":"traceutil/trace.go:171","msg":"trace[1826401147] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"126.775499ms","start":"2026-02-17T19:19:47.151Z","end":"2026-02-17T19:19:47.277775Z","steps":["trace[1826401147] 'read index received' (duration: 41.179695ms)","trace[1826401147] 'applied index is now lower than readState.Index' (duration: 85.595084ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:47.277924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.91053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-bqjlj\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-02-17T19:19:47.277944Z","caller":"traceutil/trace.go:171","msg":"trace[34796141] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-bqjlj; range_end:; response_count:1; response_revision:1120; }","duration":"126.94435ms","start":"2026-02-17T19:19:47.150995Z","end":"2026-02-17T19:19:47.277939Z","steps":["trace[34796141] 'agreement among raft nodes before linearized reading' (duration: 126.83631ms)"],"step_count":1}