{"level":"warn","ts":"2026-02-19T00:37:35.491877Z","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-19T00:37:35.492212Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-19T00:37:35.492414Z","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-19T00:37:35.492451Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-19T00:37:35.492496Z","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-19T00:37:35.493325Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-02-19T00:37:35.493501Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-19T00:37:35.49792Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.042709ms"} {"level":"info","ts":"2026-02-19T00:37:35.53523Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-19T00:37:35.535391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T00:37:35.535446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-19T00:37:35.535476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T00:37:35.535494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-19T00:37:35.535555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-19T00:37:35.553043Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T00:37:35.565192Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T00:37:35.57047Z","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-19T00:37:35.577814Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T00:37:35.580987Z","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-19T00:37:35.606218Z","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-19T00:37:35.606245Z","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-19T00:37:35.606119Z","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-19T00:37:35.606438Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T00:37:35.60671Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T00:37:35.606741Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T00:37:35.60616Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-19T00:37:35.606925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-19T00:37:35.607045Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-19T00:37:35.606876Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-19T00:37:36.04096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T00:37:36.041052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T00:37:36.041086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-19T00:37:36.041125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-19T00:37:36.041145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-19T00:37:36.041163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-19T00:37:36.04118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-19T00:37:36.045021Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T00:37:36.050771Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T00:37:36.051178Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T00:37:36.052947Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T00:37:36.052988Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T00:37:36.053025Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T00:37:36.053097Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T00:37:36.053132Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T00:37:36.053152Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T00:37:36.054662Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T00:37:36.070635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-19T00:37:38.275882Z","caller":"traceutil/trace.go:171","msg":"trace[169309377] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"173.726843ms","start":"2026-02-19T00:37:38.102135Z","end":"2026-02-19T00:37:38.275861Z","steps":["trace[169309377] 'process raft request' (duration: 173.684973ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.276309Z","caller":"traceutil/trace.go:171","msg":"trace[32575873] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"175.538533ms","start":"2026-02-19T00:37:38.100762Z","end":"2026-02-19T00:37:38.2763Z","steps":["trace[32575873] 'process raft request' (duration: 174.777354ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.276452Z","caller":"traceutil/trace.go:171","msg":"trace[1550390523] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"175.608443ms","start":"2026-02-19T00:37:38.100836Z","end":"2026-02-19T00:37:38.276444Z","steps":["trace[1550390523] 'process raft request' (duration: 174.865474ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.276657Z","caller":"traceutil/trace.go:171","msg":"trace[596054804] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"175.696903ms","start":"2026-02-19T00:37:38.100951Z","end":"2026-02-19T00:37:38.276648Z","steps":["trace[596054804] 'process raft request' (duration: 174.799094ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.276831Z","caller":"traceutil/trace.go:171","msg":"trace[1527919717] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"175.746133ms","start":"2026-02-19T00:37:38.101077Z","end":"2026-02-19T00:37:38.276823Z","steps":["trace[1527919717] 'process raft request' (duration: 174.699113ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.277023Z","caller":"traceutil/trace.go:171","msg":"trace[1288459054] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"174.985363ms","start":"2026-02-19T00:37:38.10203Z","end":"2026-02-19T00:37:38.277015Z","steps":["trace[1288459054] 'process raft request' (duration: 173.768233ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.277637Z","caller":"traceutil/trace.go:171","msg":"trace[153281452] linearizableReadLoop","detail":"{readStateIndex:11; appliedIndex:11; }","duration":"160.482729ms","start":"2026-02-19T00:37:38.117145Z","end":"2026-02-19T00:37:38.277628Z","steps":["trace[153281452] 'read index received' (duration: 160.476439ms)","trace[153281452] 'applied index is now lower than readState.Index' (duration: 5.32µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:38.277881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.214634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.277916Z","caller":"traceutil/trace.go:171","msg":"trace[1378182715] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:8; }","duration":"174.325024ms","start":"2026-02-19T00:37:38.103581Z","end":"2026-02-19T00:37:38.277906Z","steps":["trace[1378182715] 'agreement among raft nodes before linearized reading' (duration: 174.134124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.278121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.595783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.278145Z","caller":"traceutil/trace.go:171","msg":"trace[1585567933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:8; }","duration":"174.626433ms","start":"2026-02-19T00:37:38.103513Z","end":"2026-02-19T00:37:38.278139Z","steps":["trace[1585567933] 'agreement among raft nodes before linearized reading' (duration: 174.586373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.278337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.828713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.278371Z","caller":"traceutil/trace.go:171","msg":"trace[1694564020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:8; }","duration":"174.859253ms","start":"2026-02-19T00:37:38.103495Z","end":"2026-02-19T00:37:38.278354Z","steps":["trace[1694564020] 'agreement among raft nodes before linearized reading' (duration: 174.823113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.278575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.347022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.278599Z","caller":"traceutil/trace.go:171","msg":"trace[512850677] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:8; }","duration":"177.379592ms","start":"2026-02-19T00:37:38.101214Z","end":"2026-02-19T00:37:38.278594Z","steps":["trace[512850677] 'agreement among raft nodes before linearized reading' (duration: 177.338162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.278862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.040812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.2789Z","caller":"traceutil/trace.go:171","msg":"trace[932199606] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:8; }","duration":"178.083952ms","start":"2026-02-19T00:37:38.10081Z","end":"2026-02-19T00:37:38.278893Z","steps":["trace[932199606] 'agreement among raft nodes before linearized reading' (duration: 178.030062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.279125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.319852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.279158Z","caller":"traceutil/trace.go:171","msg":"trace[857021162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8; }","duration":"178.361042ms","start":"2026-02-19T00:37:38.100791Z","end":"2026-02-19T00:37:38.279152Z","steps":["trace[857021162] 'agreement among raft nodes before linearized reading' (duration: 178.315212ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.30557Z","caller":"traceutil/trace.go:171","msg":"trace[1752117551] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"137.756587ms","start":"2026-02-19T00:37:38.167795Z","end":"2026-02-19T00:37:38.305552Z","steps":["trace[1752117551] 'process raft request' (duration: 137.698187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.306084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.514635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.306289Z","caller":"traceutil/trace.go:171","msg":"trace[1520178694] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"140.245806ms","start":"2026-02-19T00:37:38.16602Z","end":"2026-02-19T00:37:38.306266Z","steps":["trace[1520178694] 'process raft request' (duration: 139.377326ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.306299Z","caller":"traceutil/trace.go:171","msg":"trace[908395660] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"170.666895ms","start":"2026-02-19T00:37:38.135533Z","end":"2026-02-19T00:37:38.3062Z","steps":["trace[908395660] 'agreement among raft nodes before linearized reading' (duration: 170.326865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.306998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.922311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.307441Z","caller":"traceutil/trace.go:171","msg":"trace[431344165] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"154.376781ms","start":"2026-02-19T00:37:38.153048Z","end":"2026-02-19T00:37:38.307425Z","steps":["trace[431344165] 'agreement among raft nodes before linearized reading' (duration: 153.912381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.307037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.092689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.307706Z","caller":"traceutil/trace.go:171","msg":"trace[392984422] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"157.766789ms","start":"2026-02-19T00:37:38.149927Z","end":"2026-02-19T00:37:38.307694Z","steps":["trace[392984422] 'agreement among raft nodes before linearized reading' (duration: 157.070889ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.456349Z","caller":"traceutil/trace.go:171","msg":"trace[238720505] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"125.221612ms","start":"2026-02-19T00:37:38.331102Z","end":"2026-02-19T00:37:38.456324Z","steps":["trace[238720505] 'process raft request' (duration: 95.059244ms)","trace[238720505] 'compare' (duration: 29.867268ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:38.456584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.119236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-19T00:37:38.456634Z","caller":"traceutil/trace.go:171","msg":"trace[1664358086] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"115.181506ms","start":"2026-02-19T00:37:38.341428Z","end":"2026-02-19T00:37:38.456609Z","steps":["trace[1664358086] 'agreement among raft nodes before linearized reading' (duration: 115.102356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.456782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.362586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-19T00:37:38.456808Z","caller":"traceutil/trace.go:171","msg":"trace[829148767] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"115.410636ms","start":"2026-02-19T00:37:38.341389Z","end":"2026-02-19T00:37:38.4568Z","steps":["trace[829148767] 'agreement among raft nodes before linearized reading' (duration: 115.353636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.456966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.786215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-wbn25\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-02-19T00:37:38.456996Z","caller":"traceutil/trace.go:171","msg":"trace[1677661775] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-wbn25; range_end:; response_count:1; response_revision:19; }","duration":"142.830545ms","start":"2026-02-19T00:37:38.314156Z","end":"2026-02-19T00:37:38.456987Z","steps":["trace[1677661775] 'agreement among raft nodes before linearized reading' (duration: 142.744755ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.71004Z","caller":"traceutil/trace.go:171","msg":"trace[1050765386] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"156.885411ms","start":"2026-02-19T00:37:38.553126Z","end":"2026-02-19T00:37:38.710011Z","steps":["trace[1050765386] 'process raft request' (duration: 156.802291ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.71023Z","caller":"traceutil/trace.go:171","msg":"trace[1155038462] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"178.658261ms","start":"2026-02-19T00:37:38.531518Z","end":"2026-02-19T00:37:38.710176Z","steps":["trace[1155038462] 'process raft request' (duration: 81.503919ms)","trace[1155038462] 'compare' (duration: 96.446513ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:38.71073Z","caller":"traceutil/trace.go:171","msg":"trace[1669089917] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"179.064131ms","start":"2026-02-19T00:37:38.53165Z","end":"2026-02-19T00:37:38.710714Z","steps":["trace[1669089917] 'process raft request' (duration: 178.135572ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:38.711173Z","caller":"traceutil/trace.go:171","msg":"trace[530986770] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:41; }","duration":"163.733997ms","start":"2026-02-19T00:37:38.547425Z","end":"2026-02-19T00:37:38.711159Z","steps":["trace[530986770] 'read index received' (duration: 65.584805ms)","trace[530986770] 'applied index is now lower than readState.Index' (duration: 98.148032ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:38.71144Z","caller":"traceutil/trace.go:171","msg":"trace[2122480156] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"160.182169ms","start":"2026-02-19T00:37:38.551243Z","end":"2026-02-19T00:37:38.711425Z","steps":["trace[2122480156] 'process raft request' (duration: 158.62427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.711649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.005711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.715493Z","caller":"traceutil/trace.go:171","msg":"trace[32589309] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:41; }","duration":"183.85592ms","start":"2026-02-19T00:37:38.531611Z","end":"2026-02-19T00:37:38.715467Z","steps":["trace[32589309] 'agreement among raft nodes before linearized reading' (duration: 179.978021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:38.711709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.351279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:38.716311Z","caller":"traceutil/trace.go:171","msg":"trace[1543892785] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:41; }","duration":"189.995747ms","start":"2026-02-19T00:37:38.526302Z","end":"2026-02-19T00:37:38.716298Z","steps":["trace[1543892785] 'agreement among raft nodes before linearized reading' (duration: 185.386229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.005426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.830047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-19T00:37:39.007003Z","caller":"traceutil/trace.go:171","msg":"trace[83397711] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"206.292281ms","start":"2026-02-19T00:37:38.799241Z","end":"2026-02-19T00:37:39.005533Z","steps":["trace[83397711] 'process raft request' (duration: 66.751235ms)","trace[83397711] 'compare' (duration: 138.639487ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.034043Z","caller":"traceutil/trace.go:171","msg":"trace[1566555574] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"232.225152ms","start":"2026-02-19T00:37:38.801788Z","end":"2026-02-19T00:37:39.034013Z","steps":["trace[1566555574] 'process raft request' (duration: 232.132502ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.034694Z","caller":"traceutil/trace.go:171","msg":"trace[109862856] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"234.95475ms","start":"2026-02-19T00:37:38.799726Z","end":"2026-02-19T00:37:39.034681Z","steps":["trace[109862856] 'process raft request' (duration: 234.022701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.092414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.42392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:39.092592Z","caller":"traceutil/trace.go:171","msg":"trace[355741361] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:49; }","duration":"105.67046ms","start":"2026-02-19T00:37:38.986905Z","end":"2026-02-19T00:37:39.092575Z","steps":["trace[355741361] 'agreement among raft nodes before linearized reading' (duration: 105.41449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.215362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.64808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-19T00:37:39.215597Z","caller":"traceutil/trace.go:171","msg":"trace[1888729846] linearizableReadLoop","detail":"{readStateIndex:55; appliedIndex:53; }","duration":"123.255593ms","start":"2026-02-19T00:37:39.092299Z","end":"2026-02-19T00:37:39.215555Z","steps":["trace[1888729846] 'read index received' (duration: 19.330423ms)","trace[1888729846] 'applied index is now lower than readState.Index' (duration: 103.92398ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.215788Z","caller":"traceutil/trace.go:171","msg":"trace[703042059] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"173.291274ms","start":"2026-02-19T00:37:39.042479Z","end":"2026-02-19T00:37:39.21577Z","steps":["trace[703042059] 'process raft request' (duration: 69.140554ms)","trace[703042059] 'compare' (duration: 103.41949ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.216326Z","caller":"traceutil/trace.go:171","msg":"trace[1131713425] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"173.680204ms","start":"2026-02-19T00:37:39.042631Z","end":"2026-02-19T00:37:39.216311Z","steps":["trace[1131713425] 'process raft request' (duration: 172.830944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.21658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.489932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:39.216641Z","caller":"traceutil/trace.go:171","msg":"trace[1492940402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:51; }","duration":"126.599762ms","start":"2026-02-19T00:37:39.09003Z","end":"2026-02-19T00:37:39.21663Z","steps":["trace[1492940402] 'agreement among raft nodes before linearized reading' (duration: 126.507472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.217394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.911475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:39.21746Z","caller":"traceutil/trace.go:171","msg":"trace[888525855] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:52; }","duration":"120.002585ms","start":"2026-02-19T00:37:39.097446Z","end":"2026-02-19T00:37:39.217448Z","steps":["trace[888525855] 'agreement among raft nodes before linearized reading' (duration: 119.836135ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.217745Z","caller":"traceutil/trace.go:171","msg":"trace[1925314737] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"120.989273ms","start":"2026-02-19T00:37:39.096739Z","end":"2026-02-19T00:37:39.217728Z","steps":["trace[1925314737] 'process raft request' (duration: 120.469434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:39.594536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.795129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-19T00:37:39.594956Z","caller":"traceutil/trace.go:171","msg":"trace[2047867541] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"154.888651ms","start":"2026-02-19T00:37:39.440043Z","end":"2026-02-19T00:37:39.594931Z","steps":["trace[2047867541] 'process raft request' (duration: 154.816641ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.595357Z","caller":"traceutil/trace.go:171","msg":"trace[1674044252] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"205.848071ms","start":"2026-02-19T00:37:39.389495Z","end":"2026-02-19T00:37:39.595343Z","steps":["trace[1674044252] 'process raft request' (duration: 97.161233ms)","trace[1674044252] 'compare' (duration: 107.635139ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.595431Z","caller":"traceutil/trace.go:171","msg":"trace[144702221] linearizableReadLoop","detail":"{readStateIndex:66; appliedIndex:65; }","duration":"158.563779ms","start":"2026-02-19T00:37:39.436826Z","end":"2026-02-19T00:37:39.595389Z","steps":["trace[144702221] 'read index received' (duration: 50.009871ms)","trace[144702221] 'applied index is now lower than readState.Index' (duration: 108.552318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:39.595532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.684569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cluster-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T00:37:39.59556Z","caller":"traceutil/trace.go:171","msg":"trace[1162257594] range","detail":"{range_begin:/registry/clusterroles/cluster-admin; range_end:; response_count:0; response_revision:63; }","duration":"158.768129ms","start":"2026-02-19T00:37:39.436787Z","end":"2026-02-19T00:37:39.595555Z","steps":["trace[1162257594] 'agreement among raft nodes before linearized reading' (duration: 158.700289ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.833766Z","caller":"traceutil/trace.go:171","msg":"trace[1235644966] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"221.777675ms","start":"2026-02-19T00:37:39.611968Z","end":"2026-02-19T00:37:39.833745Z","steps":["trace[1235644966] 'process raft request' (duration: 221.742175ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.834154Z","caller":"traceutil/trace.go:171","msg":"trace[2096915525] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"224.893223ms","start":"2026-02-19T00:37:39.609252Z","end":"2026-02-19T00:37:39.834145Z","steps":["trace[2096915525] 'process raft request' (duration: 138.859106ms)","trace[2096915525] 'compare' (duration: 85.425258ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.834404Z","caller":"traceutil/trace.go:171","msg":"trace[1892934832] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"222.536024ms","start":"2026-02-19T00:37:39.611861Z","end":"2026-02-19T00:37:39.834397Z","steps":["trace[1892934832] 'process raft request' (duration: 221.799235ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.968336Z","caller":"traceutil/trace.go:171","msg":"trace[1205545666] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"124.163792ms","start":"2026-02-19T00:37:39.84415Z","end":"2026-02-19T00:37:39.968314Z","steps":["trace[1205545666] 'process raft request' (duration: 124.099942ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:39.968718Z","caller":"traceutil/trace.go:171","msg":"trace[98045778] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"124.717332ms","start":"2026-02-19T00:37:39.843989Z","end":"2026-02-19T00:37:39.968706Z","steps":["trace[98045778] 'process raft request' (duration: 101.601451ms)","trace[98045778] 'compare' (duration: 22.579771ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:39.969123Z","caller":"traceutil/trace.go:171","msg":"trace[620788011] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"108.650489ms","start":"2026-02-19T00:37:39.860463Z","end":"2026-02-19T00:37:39.969114Z","steps":["trace[620788011] 'process raft request' (duration: 107.822809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:42.816777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.357174ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:37:42.817765Z","caller":"traceutil/trace.go:171","msg":"trace[1188950739] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:258; }","duration":"286.235432ms","start":"2026-02-19T00:37:42.531517Z","end":"2026-02-19T00:37:42.817752Z","steps":["trace[1188950739] 'read index received' (duration: 109.535928ms)","trace[1188950739] 'applied index is now lower than readState.Index' (duration: 176.698674ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:42.818047Z","caller":"traceutil/trace.go:171","msg":"trace[808478585] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"297.379018ms","start":"2026-02-19T00:37:42.520656Z","end":"2026-02-19T00:37:42.818035Z","steps":["trace[808478585] 'process raft request' (duration: 296.839728ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.818427Z","caller":"traceutil/trace.go:171","msg":"trace[659981978] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"297.686477ms","start":"2026-02-19T00:37:42.520729Z","end":"2026-02-19T00:37:42.818415Z","steps":["trace[659981978] 'process raft request' (duration: 296.828348ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.818654Z","caller":"traceutil/trace.go:171","msg":"trace[221120001] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"297.868997ms","start":"2026-02-19T00:37:42.520775Z","end":"2026-02-19T00:37:42.818644Z","steps":["trace[221120001] 'process raft request' (duration: 296.815238ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.81888Z","caller":"traceutil/trace.go:171","msg":"trace[1358390475] transaction","detail":"{read_only:false; number_of_response:0; response_revision:256; }","duration":"298.038027ms","start":"2026-02-19T00:37:42.520832Z","end":"2026-02-19T00:37:42.81887Z","steps":["trace[1358390475] 'process raft request' (duration: 296.786468ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.819113Z","caller":"traceutil/trace.go:171","msg":"trace[737286385] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"297.832958ms","start":"2026-02-19T00:37:42.521268Z","end":"2026-02-19T00:37:42.819101Z","steps":["trace[737286385] 'process raft request' (duration: 296.393149ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.819368Z","caller":"traceutil/trace.go:171","msg":"trace[264701314] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"228.653014ms","start":"2026-02-19T00:37:42.590704Z","end":"2026-02-19T00:37:42.819358Z","steps":["trace[264701314] 'process raft request' (duration: 226.990505ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.819665Z","caller":"traceutil/trace.go:171","msg":"trace[948155163] transaction","detail":"{read_only:false; number_of_response:0; response_revision:258; }","duration":"225.321705ms","start":"2026-02-19T00:37:42.594335Z","end":"2026-02-19T00:37:42.819656Z","steps":["trace[948155163] 'process raft request' (duration: 223.392046ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:42.819874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.331361ms","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-19T00:37:42.819922Z","caller":"traceutil/trace.go:171","msg":"trace[944102371] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:258; }","duration":"288.418281ms","start":"2026-02-19T00:37:42.531494Z","end":"2026-02-19T00:37:42.819912Z","steps":["trace[944102371] 'agreement among raft nodes before linearized reading' (duration: 288.305611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:42.820095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.635338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:42.820145Z","caller":"traceutil/trace.go:171","msg":"trace[1503233016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:258; }","duration":"244.698678ms","start":"2026-02-19T00:37:42.575439Z","end":"2026-02-19T00:37:42.820137Z","steps":["trace[1503233016] 'agreement among raft nodes before linearized reading' (duration: 244.634518ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:42.817209Z","caller":"traceutil/trace.go:171","msg":"trace[391596505] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"315.428061ms","start":"2026-02-19T00:37:42.501758Z","end":"2026-02-19T00:37:42.817186Z","steps":["trace[391596505] 'process raft request' (duration: 139.373007ms)","trace[391596505] 'compare' (duration: 175.266074ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:42.820537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.501737Z","time spent":"318.62482ms","remote":"127.0.0.1:52388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2629,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T00:37:43.177379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.901457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:37:43.177705Z","caller":"traceutil/trace.go:171","msg":"trace[1204012479] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"323.216629ms","start":"2026-02-19T00:37:42.854465Z","end":"2026-02-19T00:37:43.177681Z","steps":["trace[1204012479] 'process raft request' (duration: 101.937002ms)","trace[1204012479] 'compare' (duration: 220.769697ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:43.177819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.854405Z","time spent":"323.383059ms","remote":"127.0.0.1:51984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T00:37:43.178551Z","caller":"traceutil/trace.go:171","msg":"trace[1760136529] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"323.988399ms","start":"2026-02-19T00:37:42.854538Z","end":"2026-02-19T00:37:43.178526Z","steps":["trace[1760136529] 'process raft request' (duration: 323.072009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.178962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.854523Z","time spent":"324.097189ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:37:43.179984Z","caller":"traceutil/trace.go:171","msg":"trace[703024683] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"321.235569ms","start":"2026-02-19T00:37:42.858734Z","end":"2026-02-19T00:37:43.17997Z","steps":["trace[703024683] 'process raft request' (duration: 319.65759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.180083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.858658Z","time spent":"321.368079ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3827,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:37:43.179428Z","caller":"traceutil/trace.go:171","msg":"trace[756562809] linearizableReadLoop","detail":"{readStateIndex:278; appliedIndex:274; }","duration":"309.527744ms","start":"2026-02-19T00:37:42.869577Z","end":"2026-02-19T00:37:43.179104Z","steps":["trace[756562809] 'read index received' (duration: 86.833348ms)","trace[756562809] 'applied index is now lower than readState.Index' (duration: 222.693426ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:43.181475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.871023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:43.181594Z","caller":"traceutil/trace.go:171","msg":"trace[1934683908] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:270; }","duration":"312.052023ms","start":"2026-02-19T00:37:42.869528Z","end":"2026-02-19T00:37:43.18158Z","steps":["trace[1934683908] 'agreement among raft nodes before linearized reading' (duration: 311.766874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.181682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.869515Z","time spent":"312.154763ms","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" "} {"level":"info","ts":"2026-02-19T00:37:43.181736Z","caller":"traceutil/trace.go:171","msg":"trace[647113845] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"312.537753ms","start":"2026-02-19T00:37:42.869185Z","end":"2026-02-19T00:37:43.181722Z","steps":["trace[647113845] 'process raft request' (duration: 309.288095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.181811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:42.869171Z","time spent":"312.612473ms","remote":"127.0.0.1:52210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":302,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T00:37:43.670437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.948932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-02-19T00:37:43.670493Z","caller":"traceutil/trace.go:171","msg":"trace[880317565] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:273; }","duration":"208.057092ms","start":"2026-02-19T00:37:43.462423Z","end":"2026-02-19T00:37:43.67048Z","steps":["trace[880317565] 'range keys from in-memory index tree' (duration: 207.821292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.670456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.023983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:43.670547Z","caller":"traceutil/trace.go:171","msg":"trace[979798779] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:273; }","duration":"393.159663ms","start":"2026-02-19T00:37:43.277366Z","end":"2026-02-19T00:37:43.670526Z","steps":["trace[979798779] 'range keys from in-memory index tree' (duration: 392.982693ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.670595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:43.277361Z","time spent":"393.222913ms","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-02-19T00:37:43.670687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.73738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:43.670705Z","caller":"traceutil/trace.go:171","msg":"trace[1639246485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:273; }","duration":"320.78138ms","start":"2026-02-19T00:37:43.349916Z","end":"2026-02-19T00:37:43.670698Z","steps":["trace[1639246485] 'range keys from in-memory index tree' (duration: 320.67304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.67074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:43.349899Z","time spent":"320.83641ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-19T00:37:43.671098Z","caller":"traceutil/trace.go:171","msg":"trace[372185798] transaction","detail":"{read_only:false; number_of_response:0; response_revision:273; }","duration":"208.492012ms","start":"2026-02-19T00:37:43.4626Z","end":"2026-02-19T00:37:43.671092Z","steps":["trace[372185798] 'process raft request' (duration: 208.451432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:43.914594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.77955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:37:43.914697Z","caller":"traceutil/trace.go:171","msg":"trace[1114238347] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"143.272596ms","start":"2026-02-19T00:37:43.771402Z","end":"2026-02-19T00:37:43.914675Z","steps":["trace[1114238347] 'process raft request' (duration: 36.244457ms)","trace[1114238347] 'compare' (duration: 106.67904ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:43.916403Z","caller":"traceutil/trace.go:171","msg":"trace[1203853896] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"141.717837ms","start":"2026-02-19T00:37:43.774678Z","end":"2026-02-19T00:37:43.916396Z","steps":["trace[1203853896] 'process raft request' (duration: 141.549107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:44.348119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.439334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:37:44.348291Z","caller":"traceutil/trace.go:171","msg":"trace[911869286] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"376.166739ms","start":"2026-02-19T00:37:43.972087Z","end":"2026-02-19T00:37:44.348253Z","steps":["trace[911869286] 'process raft request' (duration: 66.629675ms)","trace[911869286] 'compare' (duration: 309.171864ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:44.348363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:43.972076Z","time spent":"376.256659ms","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T00:37:44.350218Z","caller":"traceutil/trace.go:171","msg":"trace[1790132437] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"377.833168ms","start":"2026-02-19T00:37:43.972369Z","end":"2026-02-19T00:37:44.350202Z","steps":["trace[1790132437] 'process raft request' (duration: 377.615069ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:44.350319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:43.972362Z","time spent":"377.905118ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:37:44.727632Z","caller":"traceutil/trace.go:171","msg":"trace[1042403401] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:290; }","duration":"297.542859ms","start":"2026-02-19T00:37:44.430069Z","end":"2026-02-19T00:37:44.727612Z","steps":["trace[1042403401] 'read index received' (duration: 254.060116ms)","trace[1042403401] 'applied index is now lower than readState.Index' (duration: 43.482003ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:37:44.727947Z","caller":"traceutil/trace.go:171","msg":"trace[543504834] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"358.094506ms","start":"2026-02-19T00:37:44.369845Z","end":"2026-02-19T00:37:44.72794Z","steps":["trace[543504834] 'process raft request' (duration: 314.364613ms)","trace[543504834] 'compare' (duration: 43.275203ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:44.728026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:44.369837Z","time spent":"358.127886ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4583,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:37:44.728155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.087639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-19T00:37:44.728175Z","caller":"traceutil/trace.go:171","msg":"trace[2071665915] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:282; }","duration":"298.156039ms","start":"2026-02-19T00:37:44.430011Z","end":"2026-02-19T00:37:44.728167Z","steps":["trace[2071665915] 'agreement among raft nodes before linearized reading' (duration: 298.120369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:44.728269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.548197ms","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-19T00:37:44.728282Z","caller":"traceutil/trace.go:171","msg":"trace[2138265727] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:282; }","duration":"275.624197ms","start":"2026-02-19T00:37:44.452654Z","end":"2026-02-19T00:37:44.728278Z","steps":["trace[2138265727] 'agreement among raft nodes before linearized reading' (duration: 275.596937ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:45.33121Z","caller":"traceutil/trace.go:171","msg":"trace[1294759657] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"109.585029ms","start":"2026-02-19T00:37:45.221601Z","end":"2026-02-19T00:37:45.331186Z","steps":["trace[1294759657] 'process raft request' (duration: 107.11331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.646668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.23358ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:37:46.64724Z","caller":"traceutil/trace.go:171","msg":"trace[126121121] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"300.507539ms","start":"2026-02-19T00:37:46.346703Z","end":"2026-02-19T00:37:46.64721Z","steps":["trace[126121121] 'process raft request' (duration: 111.655149ms)","trace[126121121] 'compare' (duration: 188.13048ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:46.647527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346695Z","time spent":"300.648709ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:37:46.647967Z","caller":"traceutil/trace.go:171","msg":"trace[1823686667] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"258.770604ms","start":"2026-02-19T00:37:46.389179Z","end":"2026-02-19T00:37:46.64795Z","steps":["trace[1823686667] 'process raft request' (duration: 258.375664ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:46.648398Z","caller":"traceutil/trace.go:171","msg":"trace[1481619994] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"301.625459ms","start":"2026-02-19T00:37:46.34676Z","end":"2026-02-19T00:37:46.648385Z","steps":["trace[1481619994] 'process raft request' (duration: 299.991529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.648613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346756Z","time spent":"301.677089ms","remote":"127.0.0.1:52006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:37:46.648847Z","caller":"traceutil/trace.go:171","msg":"trace[1687579640] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:314; }","duration":"283.353406ms","start":"2026-02-19T00:37:46.365479Z","end":"2026-02-19T00:37:46.648832Z","steps":["trace[1687579640] 'read index received' (duration: 92.888126ms)","trace[1687579640] 'applied index is now lower than readState.Index' (duration: 190.46317ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:37:46.649385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.376548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.650774Z","caller":"traceutil/trace.go:171","msg":"trace[2099795587] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"303.773718ms","start":"2026-02-19T00:37:46.346989Z","end":"2026-02-19T00:37:46.650763Z","steps":["trace[2099795587] 'agreement among raft nodes before linearized reading' (duration: 302.300378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.650804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346986Z","time spent":"303.808668ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-19T00:37:46.649485Z","caller":"traceutil/trace.go:171","msg":"trace[2100319129] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"302.632248ms","start":"2026-02-19T00:37:46.346842Z","end":"2026-02-19T00:37:46.649474Z","steps":["trace[2100319129] 'process raft request' (duration: 300.667869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.651188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346838Z","time spent":"304.234227ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:37:46.649529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.524008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.651498Z","caller":"traceutil/trace.go:171","msg":"trace[1143036041] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"304.416297ms","start":"2026-02-19T00:37:46.346999Z","end":"2026-02-19T00:37:46.651415Z","steps":["trace[1143036041] 'agreement among raft nodes before linearized reading' (duration: 302.507778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.651531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.34699Z","time spent":"304.532877ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-19T00:37:46.649568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.628898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.651746Z","caller":"traceutil/trace.go:171","msg":"trace[1894231128] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"304.805237ms","start":"2026-02-19T00:37:46.346933Z","end":"2026-02-19T00:37:46.651738Z","steps":["trace[1894231128] 'agreement among raft nodes before linearized reading' (duration: 302.614088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.651873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346923Z","time spent":"304.938037ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-19T00:37:46.649599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.617408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.652257Z","caller":"traceutil/trace.go:171","msg":"trace[1965754863] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"305.256417ms","start":"2026-02-19T00:37:46.346971Z","end":"2026-02-19T00:37:46.652228Z","steps":["trace[1965754863] 'agreement among raft nodes before linearized reading' (duration: 302.611358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.652289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.346969Z","time spent":"305.311757ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-19T00:37:46.649639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.719858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.653029Z","caller":"traceutil/trace.go:171","msg":"trace[68922354] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"306.114977ms","start":"2026-02-19T00:37:46.346906Z","end":"2026-02-19T00:37:46.653021Z","steps":["trace[68922354] 'agreement among raft nodes before linearized reading' (duration: 302.716658ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.653056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.34688Z","time spent":"306.167857ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-19T00:37:46.649672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.764088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4013"} {"level":"info","ts":"2026-02-19T00:37:46.653417Z","caller":"traceutil/trace.go:171","msg":"trace[817004070] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:309; }","duration":"306.516906ms","start":"2026-02-19T00:37:46.346892Z","end":"2026-02-19T00:37:46.653409Z","steps":["trace[817004070] 'agreement among raft nodes before linearized reading' (duration: 302.766818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.653563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:37:46.34689Z","time spent":"306.608206ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4037,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-19T00:37:46.65408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.249915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-19T00:37:46.65411Z","caller":"traceutil/trace.go:171","msg":"trace[1086199065] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:309; }","duration":"121.306275ms","start":"2026-02-19T00:37:46.532795Z","end":"2026-02-19T00:37:46.654101Z","steps":["trace[1086199065] 'agreement among raft nodes before linearized reading' (duration: 121.256255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.657912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.400695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-19T00:37:46.657942Z","caller":"traceutil/trace.go:171","msg":"trace[72219493] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:309; }","duration":"174.467425ms","start":"2026-02-19T00:37:46.483468Z","end":"2026-02-19T00:37:46.657936Z","steps":["trace[72219493] 'agreement among raft nodes before linearized reading' (duration: 174.423785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.659041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.68363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-19T00:37:46.659061Z","caller":"traceutil/trace.go:171","msg":"trace[31686608] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:309; }","duration":"159.70393ms","start":"2026-02-19T00:37:46.499352Z","end":"2026-02-19T00:37:46.659056Z","steps":["trace[31686608] 'agreement among raft nodes before linearized reading' (duration: 159.65911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.659342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.857816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-19T00:37:46.65936Z","caller":"traceutil/trace.go:171","msg":"trace[624675369] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:309; }","duration":"225.908876ms","start":"2026-02-19T00:37:46.433447Z","end":"2026-02-19T00:37:46.659356Z","steps":["trace[624675369] 'agreement among raft nodes before linearized reading' (duration: 225.875726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:46.659566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.385749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-19T00:37:46.662647Z","caller":"traceutil/trace.go:171","msg":"trace[1833572616] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:309; }","duration":"270.423579ms","start":"2026-02-19T00:37:46.389158Z","end":"2026-02-19T00:37:46.659582Z","steps":["trace[1833572616] 'agreement among raft nodes before linearized reading' (duration: 264.869471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:54.499478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.099647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:54.499576Z","caller":"traceutil/trace.go:171","msg":"trace[1986992072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"147.239307ms","start":"2026-02-19T00:37:54.352319Z","end":"2026-02-19T00:37:54.499558Z","steps":["trace[1986992072] 'range keys from in-memory index tree' (duration: 147.041327ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:37:55.055388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.297143ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:37:55.055494Z","caller":"traceutil/trace.go:171","msg":"trace[1134159122] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:408; }","duration":"102.418753ms","start":"2026-02-19T00:37:54.953062Z","end":"2026-02-19T00:37:55.055481Z","steps":["trace[1134159122] 'range keys from in-memory index tree' (duration: 102.227163ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:55.333476Z","caller":"traceutil/trace.go:171","msg":"trace[508690367] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"217.531601ms","start":"2026-02-19T00:37:55.115928Z","end":"2026-02-19T00:37:55.33346Z","steps":["trace[508690367] 'process raft request' (duration: 214.919273ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:37:57.312626Z","caller":"traceutil/trace.go:171","msg":"trace[741632785] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"147.211087ms","start":"2026-02-19T00:37:57.164536Z","end":"2026-02-19T00:37:57.311747Z","steps":["trace[741632785] 'process raft request' (duration: 94.923515ms)","trace[741632785] 'compare' (duration: 52.185532ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:01.398742Z","caller":"traceutil/trace.go:171","msg":"trace[2143035047] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"410.148813ms","start":"2026-02-19T00:38:00.988582Z","end":"2026-02-19T00:38:01.398731Z","steps":["trace[2143035047] 'read index received' (duration: 410.062623ms)","trace[2143035047] 'applied index is now lower than readState.Index' (duration: 85.5µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:01.398805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:00.792526Z","time spent":"606.277474ms","remote":"127.0.0.1:51948","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-19T00:38:01.39901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.365614ms","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-19T00:38:01.399033Z","caller":"traceutil/trace.go:171","msg":"trace[1249902860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:421; }","duration":"214.432594ms","start":"2026-02-19T00:38:01.184596Z","end":"2026-02-19T00:38:01.399028Z","steps":["trace[1249902860] 'agreement among raft nodes before linearized reading' (duration: 214.374214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:01.39922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.645403ms","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-19T00:38:01.399239Z","caller":"traceutil/trace.go:171","msg":"trace[2057433537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"410.700433ms","start":"2026-02-19T00:38:00.988534Z","end":"2026-02-19T00:38:01.399235Z","steps":["trace[2057433537] 'agreement among raft nodes before linearized reading' (duration: 410.667103ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:01.399253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:00.988516Z","time spent":"410.733243ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T00:38:01.909402Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757158,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T00:38:02.242849Z","caller":"traceutil/trace.go:171","msg":"trace[900195866] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"841.760201ms","start":"2026-02-19T00:38:01.40105Z","end":"2026-02-19T00:38:02.242811Z","steps":["trace[900195866] 'process raft request' (duration: 839.179082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:02.24301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:01.401042Z","time spent":"841.882701ms","remote":"127.0.0.1:51948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:02.260442Z","caller":"traceutil/trace.go:171","msg":"trace[882535011] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"857.717226ms","start":"2026-02-19T00:38:01.402715Z","end":"2026-02-19T00:38:02.260432Z","steps":["trace[882535011] 'process raft request' (duration: 857.419086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:02.260501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:01.402698Z","time spent":"857.773646ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:02.260587Z","caller":"traceutil/trace.go:171","msg":"trace[1205448640] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"856.360636ms","start":"2026-02-19T00:38:01.40422Z","end":"2026-02-19T00:38:02.26058Z","steps":["trace[1205448640] 'process raft request' (duration: 855.992246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:02.260617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:01.404214Z","time spent":"856.386836ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:02.260702Z","caller":"traceutil/trace.go:171","msg":"trace[1858079836] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"856.441996ms","start":"2026-02-19T00:38:01.404255Z","end":"2026-02-19T00:38:02.260697Z","steps":["trace[1858079836] 'process raft request' (duration: 855.985596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:02.26074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:01.404251Z","time spent":"856.464446ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:02.260826Z","caller":"traceutil/trace.go:171","msg":"trace[1156931627] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:435; }","duration":"851.586357ms","start":"2026-02-19T00:38:01.409231Z","end":"2026-02-19T00:38:02.260817Z","steps":["trace[1156931627] 'read index received' (duration: 831.011235ms)","trace[1156931627] 'applied index is now lower than readState.Index' (duration: 20.574302ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:02.260973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.739847ms","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-19T00:38:02.261002Z","caller":"traceutil/trace.go:171","msg":"trace[1609417424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:425; }","duration":"851.765687ms","start":"2026-02-19T00:38:01.409227Z","end":"2026-02-19T00:38:02.260993Z","steps":["trace[1609417424] 'agreement among raft nodes before linearized reading' (duration: 851.721957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:02.261023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:01.409204Z","time spent":"851.812537ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T00:38:04.392521Z","caller":"traceutil/trace.go:171","msg":"trace[75530922] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:441; }","duration":"119.536118ms","start":"2026-02-19T00:38:04.272962Z","end":"2026-02-19T00:38:04.392498Z","steps":["trace[75530922] 'read index received' (duration: 22.105453ms)","trace[75530922] 'applied index is now lower than readState.Index' (duration: 97.429735ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:04.39267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.688248ms","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-19T00:38:04.392704Z","caller":"traceutil/trace.go:171","msg":"trace[1564122321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:430; }","duration":"119.741218ms","start":"2026-02-19T00:38:04.272951Z","end":"2026-02-19T00:38:04.392692Z","steps":["trace[1564122321] 'agreement among raft nodes before linearized reading' (duration: 119.636778ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:04.39282Z","caller":"traceutil/trace.go:171","msg":"trace[1183927234] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"120.887057ms","start":"2026-02-19T00:38:04.271921Z","end":"2026-02-19T00:38:04.392808Z","steps":["trace[1183927234] 'process raft request' (duration: 120.533337ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:04.392967Z","caller":"traceutil/trace.go:171","msg":"trace[1304229646] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"123.726686ms","start":"2026-02-19T00:38:04.269211Z","end":"2026-02-19T00:38:04.392937Z","steps":["trace[1304229646] 'process raft request' (duration: 123.113296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.539946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.188700223s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-19T00:38:07.540071Z","caller":"traceutil/trace.go:171","msg":"trace[1044396651] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"1.240225175s","start":"2026-02-19T00:38:06.299822Z","end":"2026-02-19T00:38:07.540048Z","steps":["trace[1044396651] 'read index received' (duration: 51.524292ms)","trace[1044396651] 'applied index is now lower than readState.Index' (duration: 1.188699183s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:07.540727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240893634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-19T00:38:07.540805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.767634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:07.540833Z","caller":"traceutil/trace.go:171","msg":"trace[1024195530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:431; }","duration":"1.241044094s","start":"2026-02-19T00:38:06.299769Z","end":"2026-02-19T00:38:07.540813Z","steps":["trace[1024195530] 'agreement among raft nodes before linearized reading' (duration: 1.240713034s)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:07.540852Z","caller":"traceutil/trace.go:171","msg":"trace[1265447289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"187.822424ms","start":"2026-02-19T00:38:07.353008Z","end":"2026-02-19T00:38:07.540831Z","steps":["trace[1265447289] 'agreement among raft nodes before linearized reading' (duration: 187.775884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.540879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:06.299753Z","time spent":"1.241118434s","remote":"127.0.0.1:52150","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-19T00:38:07.54074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142878418s","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-19T00:38:07.541198Z","caller":"traceutil/trace.go:171","msg":"trace[1777956261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:431; }","duration":"1.143378448s","start":"2026-02-19T00:38:06.397812Z","end":"2026-02-19T00:38:07.541191Z","steps":["trace[1777956261] 'agreement among raft nodes before linearized reading' (duration: 1.142847348s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.541392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:06.397798Z","time spent":"1.143418948s","remote":"127.0.0.1:52150","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-19T00:38:07.541635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13863618s","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-19T00:38:07.541659Z","caller":"traceutil/trace.go:171","msg":"trace[1654600826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:431; }","duration":"1.13867112s","start":"2026-02-19T00:38:06.402982Z","end":"2026-02-19T00:38:07.541653Z","steps":["trace[1654600826] 'agreement among raft nodes before linearized reading' (duration: 1.13861651s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.541677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:06.402975Z","time spent":"1.13869784s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T00:38:07.541757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126021884s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:07.541773Z","caller":"traceutil/trace.go:171","msg":"trace[975568969] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:431; }","duration":"1.126051654s","start":"2026-02-19T00:38:06.415716Z","end":"2026-02-19T00:38:07.541768Z","steps":["trace[975568969] 'agreement among raft nodes before linearized reading' (duration: 1.126025264s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.541793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:06.415709Z","time spent":"1.126076004s","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"warn","ts":"2026-02-19T00:38:07.541992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144127668s","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-19T00:38:07.54201Z","caller":"traceutil/trace.go:171","msg":"trace[1467699174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:431; }","duration":"1.144181128s","start":"2026-02-19T00:38:06.397823Z","end":"2026-02-19T00:38:07.542004Z","steps":["trace[1467699174] 'agreement among raft nodes before linearized reading' (duration: 1.144143248s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:07.542025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:06.397805Z","time spent":"1.144217008s","remote":"127.0.0.1:52150","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-19T00:38:08.06133Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757190,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T00:38:08.162717Z","caller":"traceutil/trace.go:171","msg":"trace[2009045176] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"612.107895ms","start":"2026-02-19T00:38:07.550573Z","end":"2026-02-19T00:38:08.162681Z","steps":["trace[2009045176] 'process raft request' (duration: 611.857115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:08.16468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:07.549901Z","time spent":"614.618605ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:08.217476Z","caller":"traceutil/trace.go:171","msg":"trace[1434236308] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:447; }","duration":"656.55854ms","start":"2026-02-19T00:38:07.560893Z","end":"2026-02-19T00:38:08.217452Z","steps":["trace[1434236308] 'read index received' (duration: 603.621609ms)","trace[1434236308] 'applied index is now lower than readState.Index' (duration: 52.935671ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:08.217776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.86967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cilium\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:08.217888Z","caller":"traceutil/trace.go:171","msg":"trace[790694603] range","detail":"{range_begin:/registry/clusterroles/cilium; range_end:; response_count:0; response_revision:435; }","duration":"657.00665ms","start":"2026-02-19T00:38:07.560868Z","end":"2026-02-19T00:38:08.217874Z","steps":["trace[790694603] 'agreement among raft nodes before linearized reading' (duration: 656.80575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:08.218012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:07.560855Z","time spent":"657.14635ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":29,"request content":"key:\"/registry/clusterroles/cilium\" "} {"level":"info","ts":"2026-02-19T00:38:08.218691Z","caller":"traceutil/trace.go:171","msg":"trace[1084597337] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"655.600251ms","start":"2026-02-19T00:38:07.563069Z","end":"2026-02-19T00:38:08.218669Z","steps":["trace[1084597337] 'process raft request' (duration: 654.167731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:08.218865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:07.56306Z","time spent":"655.691901ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:08.219056Z","caller":"traceutil/trace.go:171","msg":"trace[897548299] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"655.897711ms","start":"2026-02-19T00:38:07.563148Z","end":"2026-02-19T00:38:08.219046Z","steps":["trace[897548299] 'process raft request' (duration: 654.227491ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:08.219146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:07.563144Z","time spent":"655.9345ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:08.219295Z","caller":"traceutil/trace.go:171","msg":"trace[1282607680] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"656.04584ms","start":"2026-02-19T00:38:07.563173Z","end":"2026-02-19T00:38:08.219219Z","steps":["trace[1282607680] 'process raft request' (duration: 654.240671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:08.219418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:07.56317Z","time spent":"656.14756ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:08.511798Z","caller":"traceutil/trace.go:171","msg":"trace[1877942589] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"157.585935ms","start":"2026-02-19T00:38:08.354178Z","end":"2026-02-19T00:38:08.511764Z","steps":["trace[1877942589] 'read index received' (duration: 157.031665ms)","trace[1877942589] 'applied index is now lower than readState.Index' (duration: 553.05µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:08.512215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.003885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:08.512284Z","caller":"traceutil/trace.go:171","msg":"trace[2058819667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"158.102505ms","start":"2026-02-19T00:38:08.354161Z","end":"2026-02-19T00:38:08.512263Z","steps":["trace[2058819667] 'agreement among raft nodes before linearized reading' (duration: 157.810985ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:08.51307Z","caller":"traceutil/trace.go:171","msg":"trace[404593652] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"172.75512ms","start":"2026-02-19T00:38:08.340289Z","end":"2026-02-19T00:38:08.513044Z","steps":["trace[404593652] 'process raft request' (duration: 171.16867ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:08.662282Z","caller":"traceutil/trace.go:171","msg":"trace[563234858] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"126.487586ms","start":"2026-02-19T00:38:08.535775Z","end":"2026-02-19T00:38:08.662263Z","steps":["trace[563234858] 'process raft request' (duration: 104.817954ms)","trace[563234858] 'compare' (duration: 21.136022ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:08.66252Z","caller":"traceutil/trace.go:171","msg":"trace[1657902501] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"126.540276ms","start":"2026-02-19T00:38:08.535972Z","end":"2026-02-19T00:38:08.662513Z","steps":["trace[1657902501] 'process raft request' (duration: 126.095316ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:10.273518Z","caller":"traceutil/trace.go:171","msg":"trace[1639294020] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"101.137595ms","start":"2026-02-19T00:38:10.172364Z","end":"2026-02-19T00:38:10.273502Z","steps":["trace[1639294020] 'process raft request' (duration: 100.760185ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:10.434796Z","caller":"traceutil/trace.go:171","msg":"trace[1536880963] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"152.934447ms","start":"2026-02-19T00:38:10.281845Z","end":"2026-02-19T00:38:10.43478Z","steps":["trace[1536880963] 'process raft request' (duration: 152.877317ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:10.434932Z","caller":"traceutil/trace.go:171","msg":"trace[511113764] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"156.223156ms","start":"2026-02-19T00:38:10.2787Z","end":"2026-02-19T00:38:10.434924Z","steps":["trace[511113764] 'process raft request' (duration: 130.919485ms)","trace[511113764] 'compare' (duration: 24.943701ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:10.436592Z","caller":"traceutil/trace.go:171","msg":"trace[863952152] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"152.949357ms","start":"2026-02-19T00:38:10.283624Z","end":"2026-02-19T00:38:10.436574Z","steps":["trace[863952152] 'process raft request' (duration: 151.128098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:10.70193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.70332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-19T00:38:10.702008Z","caller":"traceutil/trace.go:171","msg":"trace[1295845861] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:472; }","duration":"114.822979ms","start":"2026-02-19T00:38:10.587174Z","end":"2026-02-19T00:38:10.701997Z","steps":["trace[1295845861] 'range keys from in-memory index tree' (duration: 114.60932ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:12.441466Z","caller":"traceutil/trace.go:171","msg":"trace[209578195] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"163.369443ms","start":"2026-02-19T00:38:12.278077Z","end":"2026-02-19T00:38:12.441446Z","steps":["trace[209578195] 'read index received' (duration: 163.240913ms)","trace[209578195] 'applied index is now lower than readState.Index' (duration: 127.89µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:12.441596Z","caller":"traceutil/trace.go:171","msg":"trace[1898231189] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"462.682859ms","start":"2026-02-19T00:38:11.978896Z","end":"2026-02-19T00:38:12.441579Z","steps":["trace[1898231189] 'process raft request' (duration: 462.459579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:12.441783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.700173ms","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-19T00:38:12.444395Z","caller":"traceutil/trace.go:171","msg":"trace[477568336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"166.318062ms","start":"2026-02-19T00:38:12.278031Z","end":"2026-02-19T00:38:12.444349Z","steps":["trace[477568336] 'agreement among raft nodes before linearized reading' (duration: 163.587583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:12.44412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:11.978878Z","time spent":"465.207808ms","remote":"127.0.0.1:51984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":709,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T00:38:13.78198Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757275,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T00:38:14.282695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757275,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T00:38:14.783338Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757275,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T00:38:15.213903Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.765509661s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-19T00:38:15.355507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001337706s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-19T00:38:15.35562Z","caller":"traceutil/trace.go:171","msg":"trace[767956401] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001494186s","start":"2026-02-19T00:38:13.3541Z","end":"2026-02-19T00:38:15.355594Z","steps":["trace[767956401] 'agreement among raft nodes before linearized reading' (duration: 2.001365216s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.35589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:13.35404Z","time spent":"2.001766476s","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/19 00:38:15 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-19T00:38:15.399419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.765366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:38:15.399643Z","caller":"traceutil/trace.go:171","msg":"trace[252257335] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:491; }","duration":"2.118179206s","start":"2026-02-19T00:38:13.281447Z","end":"2026-02-19T00:38:15.399626Z","steps":["trace[252257335] 'read index received' (duration: 1.93291951s)","trace[252257335] 'applied index is now lower than readState.Index' (duration: 185.258826ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:15.400504Z","caller":"traceutil/trace.go:171","msg":"trace[139671326] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"2.952160686s","start":"2026-02-19T00:38:12.448331Z","end":"2026-02-19T00:38:15.400492Z","steps":["trace[139671326] 'process raft request' (duration: 2.766026201s)","trace[139671326] 'compare' (duration: 183.671906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:15.400558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:12.448319Z","time spent":"2.952211646s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:15.400684Z","caller":"traceutil/trace.go:171","msg":"trace[132794475] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"2.952009266s","start":"2026-02-19T00:38:12.448667Z","end":"2026-02-19T00:38:15.400676Z","steps":["trace[132794475] 'process raft request' (duration: 2.950833767s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.400715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:12.448659Z","time spent":"2.952039486s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:15.400787Z","caller":"traceutil/trace.go:171","msg":"trace[1539367578] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"2.952075016s","start":"2026-02-19T00:38:12.448705Z","end":"2026-02-19T00:38:15.40078Z","steps":["trace[1539367578] 'process raft request' (duration: 2.950837417s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.400818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:12.448701Z","time spent":"2.952099246s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:15.400895Z","caller":"traceutil/trace.go:171","msg":"trace[1905184534] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"2.950126367s","start":"2026-02-19T00:38:12.450762Z","end":"2026-02-19T00:38:15.400888Z","steps":["trace[1905184534] 'process raft request' (duration: 2.948802578s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.400941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:12.450752Z","time spent":"2.950170897s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:15.401014Z","caller":"traceutil/trace.go:171","msg":"trace[265351951] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"2.183263043s","start":"2026-02-19T00:38:13.217743Z","end":"2026-02-19T00:38:15.401006Z","steps":["trace[265351951] 'process raft request' (duration: 2.181856024s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.401045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:13.217727Z","time spent":"2.183302003s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:38:15.401124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.119677755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:15.401143Z","caller":"traceutil/trace.go:171","msg":"trace[1975052298] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:480; }","duration":"2.119696465s","start":"2026-02-19T00:38:13.281439Z","end":"2026-02-19T00:38:15.401135Z","steps":["trace[1975052298] 'agreement among raft nodes before linearized reading' (duration: 2.119660835s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:15.401162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:13.281404Z","time spent":"2.119753065s","remote":"127.0.0.1:52002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-19T00:38:17.848884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.188979269s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-19T00:38:17.849068Z","caller":"traceutil/trace.go:171","msg":"trace[1590280795] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:520; }","duration":"496.148229ms","start":"2026-02-19T00:38:17.352858Z","end":"2026-02-19T00:38:17.849006Z","steps":["trace[1590280795] 'read index received' (duration: 23.27µs)","trace[1590280795] 'applied index is now lower than readState.Index' (duration: 496.123529ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:17.850059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.171119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:17.850139Z","caller":"traceutil/trace.go:171","msg":"trace[1515995972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"497.288429ms","start":"2026-02-19T00:38:17.352826Z","end":"2026-02-19T00:38:17.850114Z","steps":["trace[1515995972] 'agreement among raft nodes before linearized reading' (duration: 497.146589ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:17.850179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:17.352811Z","time spent":"497.361489ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T00:38:17.850492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.814836ms","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-19T00:38:17.850512Z","caller":"traceutil/trace.go:171","msg":"trace[200648516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:504; }","duration":"443.857606ms","start":"2026-02-19T00:38:17.406648Z","end":"2026-02-19T00:38:17.850505Z","steps":["trace[200648516] 'agreement among raft nodes before linearized reading' (duration: 443.763346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:17.85053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:17.406636Z","time spent":"443.890406ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T00:38:17.850713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.018259ms","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-19T00:38:17.850734Z","caller":"traceutil/trace.go:171","msg":"trace[1765418879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"435.086099ms","start":"2026-02-19T00:38:17.41564Z","end":"2026-02-19T00:38:17.850726Z","steps":["trace[1765418879] 'agreement among raft nodes before linearized reading' (duration: 435.031179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:17.850759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:17.41561Z","time spent":"435.145819ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T00:38:17.850871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.685818ms","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-19T00:38:17.850888Z","caller":"traceutil/trace.go:171","msg":"trace[252647903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"439.721488ms","start":"2026-02-19T00:38:17.41116Z","end":"2026-02-19T00:38:17.850882Z","steps":["trace[252647903] 'agreement among raft nodes before linearized reading' (duration: 439.665608ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:17.850908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:17.411151Z","time spent":"439.753058ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:17.851024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.779137ms","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-19T00:38:17.851041Z","caller":"traceutil/trace.go:171","msg":"trace[2082051300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"440.815687ms","start":"2026-02-19T00:38:17.41022Z","end":"2026-02-19T00:38:17.851036Z","steps":["trace[2082051300] 'agreement among raft nodes before linearized reading' (duration: 440.768107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:17.851058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:17.41021Z","time spent":"440.844027ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T00:38:24.289144Z","caller":"traceutil/trace.go:171","msg":"trace[1519774487] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"400.636613ms","start":"2026-02-19T00:38:23.888488Z","end":"2026-02-19T00:38:24.289125Z","steps":["trace[1519774487] 'process raft request' (duration: 400.531763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:24.289252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:23.888476Z","time spent":"400.719673ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:24.293716Z","caller":"traceutil/trace.go:171","msg":"trace[566626405] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"397.802744ms","start":"2026-02-19T00:38:23.895894Z","end":"2026-02-19T00:38:24.293697Z","steps":["trace[566626405] 'read index received' (duration: 393.680956ms)","trace[566626405] 'applied index is now lower than readState.Index' (duration: 4.121088ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:24.293917Z","caller":"traceutil/trace.go:171","msg":"trace[846541232] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"405.297061ms","start":"2026-02-19T00:38:23.888612Z","end":"2026-02-19T00:38:24.293909Z","steps":["trace[846541232] 'process raft request' (duration: 404.998201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:24.293992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:23.888607Z","time spent":"405.334001ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:38:24.29416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.261064ms","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-19T00:38:24.294184Z","caller":"traceutil/trace.go:171","msg":"trace[347888212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"398.300734ms","start":"2026-02-19T00:38:23.895877Z","end":"2026-02-19T00:38:24.294178Z","steps":["trace[347888212] 'agreement among raft nodes before linearized reading' (duration: 398.222474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:24.294208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:23.895871Z","time spent":"398.333024ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:24.294311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.067159ms","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-19T00:38:24.294332Z","caller":"traceutil/trace.go:171","msg":"trace[531043777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"382.108659ms","start":"2026-02-19T00:38:23.912218Z","end":"2026-02-19T00:38:24.294327Z","steps":["trace[531043777] 'agreement among raft nodes before linearized reading' (duration: 382.057699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:24.294348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:23.912201Z","time spent":"382.143469ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T00:38:25.293327Z","caller":"traceutil/trace.go:171","msg":"trace[1856094344] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"724.486653ms","start":"2026-02-19T00:38:24.568812Z","end":"2026-02-19T00:38:25.293298Z","steps":["trace[1856094344] 'process raft request' (duration: 723.772053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:25.293445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:24.568789Z","time spent":"724.591233ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:38:26.798695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757377,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T00:38:26.915432Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.370345892s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T00:38:26.916136Z","caller":"traceutil/trace.go:171","msg":"trace[703014989] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.371019352s","start":"2026-02-19T00:38:25.545035Z","end":"2026-02-19T00:38:26.916054Z","steps":["trace[703014989] 'process raft request' (duration: 1.370834422s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:26.916269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:25.545019Z","time spent":"1.371173052s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:38:27.803056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.43432ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-19T00:38:27.803129Z","caller":"traceutil/trace.go:171","msg":"trace[195777425] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:544; }","duration":"1.504922336s","start":"2026-02-19T00:38:26.29819Z","end":"2026-02-19T00:38:27.803113Z","steps":["trace[195777425] 'read index received' (duration: 617.599849ms)","trace[195777425] 'applied index is now lower than readState.Index' (duration: 887.321237ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:38:27.803329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492818581s","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-19T00:38:27.803354Z","caller":"traceutil/trace.go:171","msg":"trace[1283002411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"1.492868341s","start":"2026-02-19T00:38:26.310477Z","end":"2026-02-19T00:38:27.803345Z","steps":["trace[1283002411] 'agreement among raft nodes before linearized reading' (duration: 1.492763031s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:27.803374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:26.310466Z","time spent":"1.492903461s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:27.803557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.449937925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:27.803599Z","caller":"traceutil/trace.go:171","msg":"trace[1358429630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"1.450009005s","start":"2026-02-19T00:38:26.353583Z","end":"2026-02-19T00:38:27.803592Z","steps":["trace[1358429630] 'agreement among raft nodes before linearized reading' (duration: 1.449957885s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:27.80362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:26.353568Z","time spent":"1.450046845s","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T00:38:27.803795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492846121s","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-19T00:38:27.803815Z","caller":"traceutil/trace.go:171","msg":"trace[1550504872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"1.492900731s","start":"2026-02-19T00:38:26.310909Z","end":"2026-02-19T00:38:27.80381Z","steps":["trace[1550504872] 'agreement among raft nodes before linearized reading' (duration: 1.492846081s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:27.803829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:26.310902Z","time spent":"1.492925111s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T00:38:27.80398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.493295581s","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-19T00:38:27.804Z","caller":"traceutil/trace.go:171","msg":"trace[803023003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:527; }","duration":"1.493335051s","start":"2026-02-19T00:38:26.31066Z","end":"2026-02-19T00:38:27.803995Z","steps":["trace[803023003] 'agreement among raft nodes before linearized reading' (duration: 1.493283621s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:27.804016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:26.31065Z","time spent":"1.493363721s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:27.804248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.506056426s","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-19T00:38:27.804286Z","caller":"traceutil/trace.go:171","msg":"trace[1500304281] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:527; }","duration":"1.506130486s","start":"2026-02-19T00:38:26.29815Z","end":"2026-02-19T00:38:27.80428Z","steps":["trace[1500304281] 'agreement among raft nodes before linearized reading' (duration: 1.505054586s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:27.804302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:26.29813Z","time spent":"1.506167726s","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T00:38:30.324609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540755700757416,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T00:38:30.327438Z","caller":"traceutil/trace.go:171","msg":"trace[388991362] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"543.875625ms","start":"2026-02-19T00:38:29.783546Z","end":"2026-02-19T00:38:30.327422Z","steps":["trace[388991362] 'process raft request' (duration: 543.799865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.327621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.783528Z","time spent":"544.029495ms","remote":"127.0.0.1:51956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T00:38:30.333763Z","caller":"traceutil/trace.go:171","msg":"trace[1385436718] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:565; }","duration":"509.850277ms","start":"2026-02-19T00:38:29.823882Z","end":"2026-02-19T00:38:30.333732Z","steps":["trace[1385436718] 'read index received' (duration: 504.088829ms)","trace[1385436718] 'applied index is now lower than readState.Index' (duration: 5.761048ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:30.335856Z","caller":"traceutil/trace.go:171","msg":"trace[780190014] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"549.616683ms","start":"2026-02-19T00:38:29.786227Z","end":"2026-02-19T00:38:30.335844Z","steps":["trace[780190014] 'process raft request' (duration: 547.148904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.336054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.786218Z","time spent":"549.795903ms","remote":"127.0.0.1:51956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T00:38:30.336561Z","caller":"traceutil/trace.go:171","msg":"trace[115474275] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"548.632713ms","start":"2026-02-19T00:38:29.787919Z","end":"2026-02-19T00:38:30.336552Z","steps":["trace[115474275] 'process raft request' (duration: 545.598784ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.336697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.787911Z","time spent":"548.765573ms","remote":"127.0.0.1:51956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T00:38:30.337412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.522336ms","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-19T00:38:30.337489Z","caller":"traceutil/trace.go:171","msg":"trace[515771742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"513.628536ms","start":"2026-02-19T00:38:29.823852Z","end":"2026-02-19T00:38:30.337481Z","steps":["trace[515771742] 'agreement among raft nodes before linearized reading' (duration: 513.494196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.337603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.823839Z","time spent":"513.756436ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T00:38:30.337808Z","caller":"traceutil/trace.go:171","msg":"trace[1366848644] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"464.451142ms","start":"2026-02-19T00:38:29.873346Z","end":"2026-02-19T00:38:30.337797Z","steps":["trace[1366848644] 'process raft request' (duration: 460.250783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.340039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.87333Z","time spent":"464.652022ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:30.340287Z","caller":"traceutil/trace.go:171","msg":"trace[1006808054] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"424.362106ms","start":"2026-02-19T00:38:29.915916Z","end":"2026-02-19T00:38:30.340278Z","steps":["trace[1006808054] 'process raft request' (duration: 417.706358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.340479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.9159Z","time spent":"424.514326ms","remote":"127.0.0.1:51956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T00:38:30.340696Z","caller":"traceutil/trace.go:171","msg":"trace[1781413099] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"223.637934ms","start":"2026-02-19T00:38:30.11705Z","end":"2026-02-19T00:38:30.340688Z","steps":["trace[1781413099] 'process raft request' (duration: 216.646036ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:30.341178Z","caller":"traceutil/trace.go:171","msg":"trace[666891961] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"546.407674ms","start":"2026-02-19T00:38:29.790624Z","end":"2026-02-19T00:38:30.337031Z","steps":["trace[666891961] 'process raft request' (duration: 542.919065ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.341499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.972684ms","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-19T00:38:30.347736Z","caller":"traceutil/trace.go:171","msg":"trace[390012687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"523.191292ms","start":"2026-02-19T00:38:29.824519Z","end":"2026-02-19T00:38:30.34771Z","steps":["trace[390012687] 'agreement among raft nodes before linearized reading' (duration: 516.919904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.347807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.824504Z","time spent":"523.278362ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T00:38:30.341664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.247312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk\" ","response":"range_response_count:1 size:4822"} {"level":"info","ts":"2026-02-19T00:38:30.347941Z","caller":"traceutil/trace.go:171","msg":"trace[228897529] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk; range_end:; response_count:1; response_revision:554; }","duration":"323.55929ms","start":"2026-02-19T00:38:30.024376Z","end":"2026-02-19T00:38:30.347936Z","steps":["trace[228897529] 'agreement among raft nodes before linearized reading' (duration: 317.249202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.347965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:30.024359Z","time spent":"323.60108ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4846,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk\" "} {"level":"warn","ts":"2026-02-19T00:38:30.345212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.900275ms","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-19T00:38:30.348065Z","caller":"traceutil/trace.go:171","msg":"trace[382917502] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"518.764094ms","start":"2026-02-19T00:38:29.829296Z","end":"2026-02-19T00:38:30.34806Z","steps":["trace[382917502] 'agreement among raft nodes before linearized reading' (duration: 512.379916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.348086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.829291Z","time spent":"518.790814ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T00:38:30.34526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.154393ms","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-19T00:38:30.348181Z","caller":"traceutil/trace.go:171","msg":"trace[859400830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"523.082772ms","start":"2026-02-19T00:38:29.825093Z","end":"2026-02-19T00:38:30.348176Z","steps":["trace[859400830] 'agreement among raft nodes before linearized reading' (duration: 520.140003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:30.348197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.825089Z","time spent":"523.103432ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:30.347651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:29.790617Z","time spent":"557.00548ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:37.122779Z","caller":"traceutil/trace.go:171","msg":"trace[226276506] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"522.622902ms","start":"2026-02-19T00:38:36.600111Z","end":"2026-02-19T00:38:37.122734Z","steps":["trace[226276506] 'process raft request' (duration: 522.444542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:37.123053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:36.600096Z","time spent":"522.855072ms","remote":"127.0.0.1:44674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2322,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:37.218379Z","caller":"traceutil/trace.go:171","msg":"trace[1249386314] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"235.2682ms","start":"2026-02-19T00:38:36.983093Z","end":"2026-02-19T00:38:37.218361Z","steps":["trace[1249386314] 'process raft request' (duration: 232.779351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:37.812606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.707994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:37.813823Z","caller":"traceutil/trace.go:171","msg":"trace[769936326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"461.930354ms","start":"2026-02-19T00:38:37.351879Z","end":"2026-02-19T00:38:37.813809Z","steps":["trace[769936326] 'range keys from in-memory index tree' (duration: 460.663164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:37.813857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:37.351842Z","time spent":"462.008384ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T00:38:37.813472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.182665ms","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-19T00:38:37.813999Z","caller":"traceutil/trace.go:171","msg":"trace[1332294415] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:644; }","duration":"368.758235ms","start":"2026-02-19T00:38:37.445236Z","end":"2026-02-19T00:38:37.813994Z","steps":["trace[1332294415] 'count revisions from in-memory index tree' (duration: 368.120855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:37.814022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:37.445221Z","time spent":"368.793995ms","remote":"127.0.0.1:52360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-02-19T00:38:38.679825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.17561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:38:38.679982Z","caller":"traceutil/trace.go:171","msg":"trace[1406560498] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"255.179614ms","start":"2026-02-19T00:38:38.424791Z","end":"2026-02-19T00:38:38.67997Z","steps":["trace[1406560498] 'process raft request' (duration: 19.796044ms)","trace[1406560498] 'compare' (duration: 235.05632ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:38.711339Z","caller":"traceutil/trace.go:171","msg":"trace[1442944758] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"278.182546ms","start":"2026-02-19T00:38:38.43314Z","end":"2026-02-19T00:38:38.711322Z","steps":["trace[1442944758] 'process raft request' (duration: 278.090336ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:49.172352Z","caller":"traceutil/trace.go:171","msg":"trace[176942914] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:760; }","duration":"399.923156ms","start":"2026-02-19T00:38:48.772411Z","end":"2026-02-19T00:38:49.172334Z","steps":["trace[176942914] 'read index received' (duration: 399.750126ms)","trace[176942914] 'applied index is now lower than readState.Index' (duration: 170.16µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:38:49.172458Z","caller":"traceutil/trace.go:171","msg":"trace[1786256984] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"453.141388ms","start":"2026-02-19T00:38:48.719308Z","end":"2026-02-19T00:38:49.172449Z","steps":["trace[1786256984] 'process raft request' (duration: 452.886728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:49.172533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:48.719299Z","time spent":"453.178818ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T00:38:49.172605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.713395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:38:49.17267Z","caller":"traceutil/trace.go:171","msg":"trace[78705466] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:735; }","duration":"372.815815ms","start":"2026-02-19T00:38:48.799838Z","end":"2026-02-19T00:38:49.172653Z","steps":["trace[78705466] 'agreement among raft nodes before linearized reading' (duration: 372.690575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:49.172716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:48.799826Z","time spent":"372.880675ms","remote":"127.0.0.1:52046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-02-19T00:38:49.172831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.429196ms","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-19T00:38:49.172856Z","caller":"traceutil/trace.go:171","msg":"trace[283227313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:735; }","duration":"400.502616ms","start":"2026-02-19T00:38:48.772346Z","end":"2026-02-19T00:38:49.172849Z","steps":["trace[283227313] 'agreement among raft nodes before linearized reading' (duration: 400.418616ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:49.172874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:48.772326Z","time spent":"400.544876ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T00:38:49.712648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.017837ms","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-19T00:38:49.712776Z","caller":"traceutil/trace.go:171","msg":"trace[527305899] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:735; }","duration":"397.179747ms","start":"2026-02-19T00:38:49.315578Z","end":"2026-02-19T00:38:49.712757Z","steps":["trace[527305899] 'range keys from in-memory index tree' (duration: 396.998797ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:38:49.829705Z","caller":"traceutil/trace.go:171","msg":"trace[303856667] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"652.442151ms","start":"2026-02-19T00:38:49.177237Z","end":"2026-02-19T00:38:49.829679Z","steps":["trace[303856667] 'process raft request' (duration: 652.306061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:38:49.829835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:38:49.177222Z","time spent":"652.549151ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T00:38:50.505965Z","caller":"traceutil/trace.go:171","msg":"trace[2112984093] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"110.642283ms","start":"2026-02-19T00:38:50.395301Z","end":"2026-02-19T00:38:50.505943Z","steps":["trace[2112984093] 'process raft request' (duration: 46.210775ms)","trace[2112984093] 'compare' (duration: 63.955609ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:39:50.317513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.912067ms","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-19T00:39:50.317608Z","caller":"traceutil/trace.go:171","msg":"trace[224857342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:947; }","duration":"191.051227ms","start":"2026-02-19T00:39:50.12654Z","end":"2026-02-19T00:39:50.317591Z","steps":["trace[224857342] 'range keys from in-memory index tree' (duration: 190.753887ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.775464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.671128ms","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-19T00:39:51.77552Z","caller":"traceutil/trace.go:171","msg":"trace[1758875601] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:949; }","duration":"670.785118ms","start":"2026-02-19T00:39:51.104725Z","end":"2026-02-19T00:39:51.77551Z","steps":["trace[1758875601] 'range keys from in-memory index tree' (duration: 670.486818ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.77554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.104712Z","time spent":"670.823208ms","remote":"127.0.0.1:52150","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-19T00:39:51.775701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.204929ms","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-19T00:39:51.775724Z","caller":"traceutil/trace.go:171","msg":"trace[1717599892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:949; }","duration":"669.237519ms","start":"2026-02-19T00:39:51.106482Z","end":"2026-02-19T00:39:51.775719Z","steps":["trace[1717599892] 'range keys from in-memory index tree' (duration: 669.149399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.776325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.030861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-19T00:39:51.776349Z","caller":"traceutil/trace.go:171","msg":"trace[527941036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:949; }","duration":"662.136321ms","start":"2026-02-19T00:39:51.114208Z","end":"2026-02-19T00:39:51.776344Z","steps":["trace[527941036] 'range keys from in-memory index tree' (duration: 661.863271ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.776377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.114188Z","time spent":"662.185231ms","remote":"127.0.0.1:52150","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-19T00:39:51.776748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.865484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T00:39:51.776773Z","caller":"traceutil/trace.go:171","msg":"trace[1313652272] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:949; }","duration":"533.964524ms","start":"2026-02-19T00:39:51.242802Z","end":"2026-02-19T00:39:51.776766Z","steps":["trace[1313652272] 'count revisions from in-memory index tree' (duration: 533.811654ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.776828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.242787Z","time spent":"534.007954ms","remote":"127.0.0.1:44696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-19T00:39:51.775736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.106478Z","time spent":"669.255289ms","remote":"127.0.0.1:52150","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-19T00:39:51.77741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.627251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:39:51.777461Z","caller":"traceutil/trace.go:171","msg":"trace[96410251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:949; }","duration":"423.721021ms","start":"2026-02-19T00:39:51.353726Z","end":"2026-02-19T00:39:51.777447Z","steps":["trace[96410251] 'range keys from in-memory index tree' (duration: 423.498671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.777484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.353709Z","time spent":"423.77067ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T00:39:51.777963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.066596ms","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-19T00:39:51.777979Z","caller":"traceutil/trace.go:171","msg":"trace[1791698689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:949; }","duration":"315.142026ms","start":"2026-02-19T00:39:51.462831Z","end":"2026-02-19T00:39:51.777973Z","steps":["trace[1791698689] 'range keys from in-memory index tree' (duration: 314.970726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:39:51.777993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T00:39:51.462816Z","time spent":"315.172946ms","remote":"127.0.0.1:52150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T00:40:12.261655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.093549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T00:40:12.261872Z","caller":"traceutil/trace.go:171","msg":"trace[1061928618] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"196.056485ms","start":"2026-02-19T00:40:12.065791Z","end":"2026-02-19T00:40:12.261848Z","steps":["trace[1061928618] 'process raft request' (duration: 73.690786ms)","trace[1061928618] 'compare' (duration: 121.967319ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:40:12.263467Z","caller":"traceutil/trace.go:171","msg":"trace[2071443092] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"196.661705ms","start":"2026-02-19T00:40:12.066788Z","end":"2026-02-19T00:40:12.26345Z","steps":["trace[2071443092] 'process raft request' (duration: 196.517095ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:12.263756Z","caller":"traceutil/trace.go:171","msg":"trace[1089863700] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1057; }","duration":"166.668026ms","start":"2026-02-19T00:40:12.097068Z","end":"2026-02-19T00:40:12.263736Z","steps":["trace[1089863700] 'read index received' (duration: 4.973049ms)","trace[1089863700] 'applied index is now lower than readState.Index' (duration: 161.693767ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:40:12.264141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.066365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/\" range_end:\"/registry/roles/kube-public0\" limit:500 ","response":"range_response_count:2 size:1073"} {"level":"warn","ts":"2026-02-19T00:40:12.264528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.517707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:1000"} {"level":"info","ts":"2026-02-19T00:40:12.264625Z","caller":"traceutil/trace.go:171","msg":"trace[957654749] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1014; }","duration":"159.634387ms","start":"2026-02-19T00:40:12.104976Z","end":"2026-02-19T00:40:12.26461Z","steps":["trace[957654749] 'agreement among raft nodes before linearized reading' (duration: 159.496297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:12.265049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.156963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/kube-system/\" range_end:\"/registry/jobs/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:40:12.265203Z","caller":"traceutil/trace.go:171","msg":"trace[1794126551] range","detail":"{range_begin:/registry/jobs/kube-system/; range_end:/registry/jobs/kube-system0; response_count:0; response_revision:1014; }","duration":"142.324363ms","start":"2026-02-19T00:40:12.122866Z","end":"2026-02-19T00:40:12.26519Z","steps":["trace[1794126551] 'agreement among raft nodes before linearized reading' (duration: 142.151113ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:12.264191Z","caller":"traceutil/trace.go:171","msg":"trace[1044635310] range","detail":"{range_begin:/registry/roles/kube-public/; range_end:/registry/roles/kube-public0; response_count:2; response_revision:1014; }","duration":"167.145135ms","start":"2026-02-19T00:40:12.097035Z","end":"2026-02-19T00:40:12.26418Z","steps":["trace[1044635310] 'agreement among raft nodes before linearized reading' (duration: 167.043645ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:14.312729Z","caller":"traceutil/trace.go:171","msg":"trace[1661279778] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"163.257286ms","start":"2026-02-19T00:40:14.149452Z","end":"2026-02-19T00:40:14.312709Z","steps":["trace[1661279778] 'read index received' (duration: 108.960724ms)","trace[1661279778] 'applied index is now lower than readState.Index' (duration: 54.295432ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:40:14.31305Z","caller":"traceutil/trace.go:171","msg":"trace[894723800] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"174.057963ms","start":"2026-02-19T00:40:14.138977Z","end":"2026-02-19T00:40:14.313034Z","steps":["trace[894723800] 'process raft request' (duration: 119.480721ms)","trace[894723800] 'compare' (duration: 54.003652ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:40:14.313365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.872946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk\" ","response":"range_response_count:1 size:4628"} {"level":"info","ts":"2026-02-19T00:40:14.313448Z","caller":"traceutil/trace.go:171","msg":"trace[1515138173] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk; range_end:; response_count:1; response_revision:1017; }","duration":"164.007166ms","start":"2026-02-19T00:40:14.149428Z","end":"2026-02-19T00:40:14.313435Z","steps":["trace[1515138173] 'agreement among raft nodes before linearized reading' (duration: 163.820876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:14.313689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.170134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jsk67\" ","response":"range_response_count:1 size:18062"} {"level":"info","ts":"2026-02-19T00:40:14.313767Z","caller":"traceutil/trace.go:171","msg":"trace[327785269] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jsk67; range_end:; response_count:1; response_revision:1017; }","duration":"139.249434ms","start":"2026-02-19T00:40:14.174508Z","end":"2026-02-19T00:40:14.313757Z","steps":["trace[327785269] 'agreement among raft nodes before linearized reading' (duration: 139.114424ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:14.534142Z","caller":"traceutil/trace.go:171","msg":"trace[503981857] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"208.643791ms","start":"2026-02-19T00:40:14.325475Z","end":"2026-02-19T00:40:14.534119Z","steps":["trace[503981857] 'process raft request' (duration: 208.596001ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:14.534685Z","caller":"traceutil/trace.go:171","msg":"trace[217218478] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"211.51993ms","start":"2026-02-19T00:40:14.323137Z","end":"2026-02-19T00:40:14.534657Z","steps":["trace[217218478] 'process raft request' (duration: 182.32521ms)","trace[217218478] 'compare' (duration: 28.31462ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:40:14.535087Z","caller":"traceutil/trace.go:171","msg":"trace[874295944] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"209.750271ms","start":"2026-02-19T00:40:14.325325Z","end":"2026-02-19T00:40:14.535075Z","steps":["trace[874295944] 'read index received' (duration: 180.148991ms)","trace[874295944] 'applied index is now lower than readState.Index' (duration: 29.6001ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:40:14.535371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.027561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jsk67\" ","response":"range_response_count:1 size:18062"} {"level":"info","ts":"2026-02-19T00:40:14.535477Z","caller":"traceutil/trace.go:171","msg":"trace[1064425976] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jsk67; range_end:; response_count:1; response_revision:1019; }","duration":"210.125751ms","start":"2026-02-19T00:40:14.325319Z","end":"2026-02-19T00:40:14.535445Z","steps":["trace[1064425976] 'agreement among raft nodes before linearized reading' (duration: 209.930341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:14.535757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.015329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:40:14.535851Z","caller":"traceutil/trace.go:171","msg":"trace[110564733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"186.132769ms","start":"2026-02-19T00:40:14.349708Z","end":"2026-02-19T00:40:14.535841Z","steps":["trace[110564733] 'agreement among raft nodes before linearized reading' (duration: 186.019709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:14.536639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.061395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/local-path-storage/\" range_end:\"/registry/networkpolicies/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T00:40:14.536747Z","caller":"traceutil/trace.go:171","msg":"trace[1721951876] range","detail":"{range_begin:/registry/networkpolicies/local-path-storage/; range_end:/registry/networkpolicies/local-path-storage0; response_count:0; response_revision:1019; }","duration":"105.235195ms","start":"2026-02-19T00:40:14.431499Z","end":"2026-02-19T00:40:14.536734Z","steps":["trace[1721951876] 'agreement among raft nodes before linearized reading' (duration: 105.075785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:14.537087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.471589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk\" ","response":"range_response_count:1 size:4628"} {"level":"info","ts":"2026-02-19T00:40:14.537187Z","caller":"traceutil/trace.go:171","msg":"trace[1945324565] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-jplzk; range_end:; response_count:1; response_revision:1019; }","duration":"122.593199ms","start":"2026-02-19T00:40:14.414582Z","end":"2026-02-19T00:40:14.537175Z","steps":["trace[1945324565] 'agreement among raft nodes before linearized reading' (duration: 122.435879ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T00:40:22.815242Z","caller":"traceutil/trace.go:171","msg":"trace[253742913] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1089; }","duration":"128.525878ms","start":"2026-02-19T00:40:22.686697Z","end":"2026-02-19T00:40:22.815223Z","steps":["trace[253742913] 'read index received' (duration: 43.507876ms)","trace[253742913] 'applied index is now lower than readState.Index' (duration: 85.017162ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T00:40:22.815688Z","caller":"traceutil/trace.go:171","msg":"trace[611888458] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"130.665647ms","start":"2026-02-19T00:40:22.685006Z","end":"2026-02-19T00:40:22.815672Z","steps":["trace[611888458] 'process raft request' (duration: 78.031674ms)","trace[611888458] 'compare' (duration: 52.079553ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T00:40:22.81591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.200618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/default\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-19T00:40:22.816516Z","caller":"traceutil/trace.go:171","msg":"trace[1871281171] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/default; range_end:; response_count:1; response_revision:1043; }","duration":"129.812178ms","start":"2026-02-19T00:40:22.686689Z","end":"2026-02-19T00:40:22.816501Z","steps":["trace[1871281171] 'agreement among raft nodes before linearized reading' (duration: 129.166318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:22.816556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.273522ms","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-19T00:40:22.817739Z","caller":"traceutil/trace.go:171","msg":"trace[1808614954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"118.485031ms","start":"2026-02-19T00:40:22.699235Z","end":"2026-02-19T00:40:22.81772Z","steps":["trace[1808614954] 'agreement among raft nodes before linearized reading' (duration: 117.203492ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T00:40:22.820206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.418063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-19T00:40:22.820279Z","caller":"traceutil/trace.go:171","msg":"trace[1903882902] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1043; }","duration":"113.509792ms","start":"2026-02-19T00:40:22.706759Z","end":"2026-02-19T00:40:22.820269Z","steps":["trace[1903882902] 'agreement among raft nodes before linearized reading' (duration: 110.130894ms)"],"step_count":1}