{"level":"warn","ts":"2026-02-10T14:55:41.505708Z","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-10T14:55:41.505813Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-10T14:55:41.505895Z","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-10T14:55:41.505904Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-02-10T14:55:41.505923Z","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-10T14:55:41.507673Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-02-10T14:55:41.507748Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-10T14:55:41.512367Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.455466ms"} {"level":"info","ts":"2026-02-10T14:55:41.519976Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-02-10T14:55:41.520054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T14:55:41.520086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-02-10T14:55:41.520096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T14:55:41.520102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-02-10T14:55:41.520128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-02-10T14:55:41.530506Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T14:55:41.532825Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T14:55:41.539457Z","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-10T14:55:41.543155Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T14:55:41.549937Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T14:55:41.550171Z","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-10T14:55:41.550255Z","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-10T14:55:41.55032Z","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-10T14:55:41.554186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-02-10T14:55:41.557723Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-02-10T14:55:41.558892Z","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-10T14:55:41.558916Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-02-10T14:55:41.559188Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-02-10T14:55:41.559382Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T14:55:41.561591Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T14:55:42.320608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T14:55:42.320653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T14:55:42.320678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-02-10T14:55:42.320689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-02-10T14:55:42.320694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-02-10T14:55:42.320702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-02-10T14:55:42.320708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-02-10T14:55:42.323539Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:55:42.325678Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T14:55:42.325699Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:55:42.32597Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:55:42.327581Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T14:55:42.327666Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:55:42.327698Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:55:42.327709Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:55:42.330305Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-02-10T14:55:42.361634Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T14:55:42.361665Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T14:55:44.220026Z","caller":"traceutil/trace.go:171","msg":"trace[1717451575] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:5; }","duration":"183.904927ms","start":"2026-02-10T14:55:44.036108Z","end":"2026-02-10T14:55:44.220012Z","steps":["trace[1717451575] 'read index received' (duration: 48.418543ms)","trace[1717451575] 'applied index is now lower than readState.Index' (duration: 135.485834ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:44.220112Z","caller":"traceutil/trace.go:171","msg":"trace[920139258] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"184.059779ms","start":"2026-02-10T14:55:44.036044Z","end":"2026-02-10T14:55:44.220104Z","steps":["trace[920139258] 'process raft request' (duration: 181.290437ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.220557Z","caller":"traceutil/trace.go:171","msg":"trace[1766293475] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"184.467191ms","start":"2026-02-10T14:55:44.036077Z","end":"2026-02-10T14:55:44.220544Z","steps":["trace[1766293475] 'process raft request' (duration: 183.774676ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.221516Z","caller":"traceutil/trace.go:171","msg":"trace[961355965] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"176.474698ms","start":"2026-02-10T14:55:44.04501Z","end":"2026-02-10T14:55:44.221485Z","steps":["trace[961355965] 'process raft request' (duration: 174.967076ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.222103Z","caller":"traceutil/trace.go:171","msg":"trace[487843529] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"182.419645ms","start":"2026-02-10T14:55:44.03967Z","end":"2026-02-10T14:55:44.222089Z","steps":["trace[487843529] 'process raft request' (duration: 180.204628ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.222707Z","caller":"traceutil/trace.go:171","msg":"trace[2044362015] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"179.284231ms","start":"2026-02-10T14:55:44.043342Z","end":"2026-02-10T14:55:44.222626Z","steps":["trace[2044362015] 'process raft request' (duration: 176.548959ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.222894Z","caller":"traceutil/trace.go:171","msg":"trace[697350424] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"157.162576ms","start":"2026-02-10T14:55:44.065715Z","end":"2026-02-10T14:55:44.222878Z","steps":["trace[697350424] 'process raft request' (duration: 154.280463ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.223124Z","caller":"traceutil/trace.go:171","msg":"trace[1056373049] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"179.555652ms","start":"2026-02-10T14:55:44.043554Z","end":"2026-02-10T14:55:44.22311Z","steps":["trace[1056373049] 'process raft request' (duration: 176.378797ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.224156Z","caller":"traceutil/trace.go:171","msg":"trace[369916489] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"179.629843ms","start":"2026-02-10T14:55:44.043851Z","end":"2026-02-10T14:55:44.223481Z","steps":["trace[369916489] 'process raft request' (duration: 176.095085ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.223942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.819178ms","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-10T14:55:44.224556Z","caller":"traceutil/trace.go:171","msg":"trace[1500934480] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"179.651473ms","start":"2026-02-10T14:55:44.044892Z","end":"2026-02-10T14:55:44.224543Z","steps":["trace[1500934480] 'process raft request' (duration: 175.066937ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.224721Z","caller":"traceutil/trace.go:171","msg":"trace[707956986] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"188.612674ms","start":"2026-02-10T14:55:44.036093Z","end":"2026-02-10T14:55:44.224706Z","steps":["trace[707956986] 'agreement among raft nodes before linearized reading' (duration: 187.561596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.225108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.851678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.226351Z","caller":"traceutil/trace.go:171","msg":"trace[1818532387] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"189.100968ms","start":"2026-02-10T14:55:44.037237Z","end":"2026-02-10T14:55:44.226338Z","steps":["trace[1818532387] 'agreement among raft nodes before linearized reading' (duration: 187.843388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.226869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.177223ms","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-10T14:55:44.22693Z","caller":"traceutil/trace.go:171","msg":"trace[1331988029] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"129.232863ms","start":"2026-02-10T14:55:44.097669Z","end":"2026-02-10T14:55:44.226901Z","steps":["trace[1331988029] 'agreement among raft nodes before linearized reading' (duration: 129.165653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.230621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.053644ms","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-10T14:55:44.230668Z","caller":"traceutil/trace.go:171","msg":"trace[1043204131] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"133.116804ms","start":"2026-02-10T14:55:44.09754Z","end":"2026-02-10T14:55:44.230657Z","steps":["trace[1043204131] 'agreement among raft nodes before linearized reading' (duration: 133.045204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.231145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.715349ms","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-10T14:55:44.231189Z","caller":"traceutil/trace.go:171","msg":"trace[1670671490] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"138.777029ms","start":"2026-02-10T14:55:44.0924Z","end":"2026-02-10T14:55:44.231177Z","steps":["trace[1670671490] 'agreement among raft nodes before linearized reading' (duration: 138.706359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.231428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.766545ms","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-10T14:55:44.231466Z","caller":"traceutil/trace.go:171","msg":"trace[562986677] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"145.825475ms","start":"2026-02-10T14:55:44.085632Z","end":"2026-02-10T14:55:44.231457Z","steps":["trace[562986677] 'agreement among raft nodes before linearized reading' (duration: 145.741855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.231754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.811666ms","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-10T14:55:44.231935Z","caller":"traceutil/trace.go:171","msg":"trace[296559780] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"189.010767ms","start":"2026-02-10T14:55:44.042918Z","end":"2026-02-10T14:55:44.231928Z","steps":["trace[296559780] 'agreement among raft nodes before linearized reading' (duration: 188.796196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.232075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.188894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.232107Z","caller":"traceutil/trace.go:171","msg":"trace[1085829038] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:11; }","duration":"191.230565ms","start":"2026-02-10T14:55:44.040873Z","end":"2026-02-10T14:55:44.232103Z","steps":["trace[1085829038] 'agreement among raft nodes before linearized reading' (duration: 191.189854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.61664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.920402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:44.616978Z","caller":"traceutil/trace.go:171","msg":"trace[867425903] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"377.067417ms","start":"2026-02-10T14:55:44.239836Z","end":"2026-02-10T14:55:44.616903Z","steps":["trace[867425903] 'process raft request' (duration: 108.365789ms)","trace[867425903] 'compare' (duration: 267.71235ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:44.617243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239569Z","time spent":"377.527771ms","remote":"127.0.0.1:38064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.620563Z","caller":"traceutil/trace.go:171","msg":"trace[2059401234] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"380.010611ms","start":"2026-02-10T14:55:44.240535Z","end":"2026-02-10T14:55:44.620546Z","steps":["trace[2059401234] 'process raft request' (duration: 379.87728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.620714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.24053Z","time spent":"380.152162ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.62083Z","caller":"traceutil/trace.go:171","msg":"trace[1567521506] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"380.191752ms","start":"2026-02-10T14:55:44.24063Z","end":"2026-02-10T14:55:44.620822Z","steps":["trace[1567521506] 'process raft request' (duration: 379.797949ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.620928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.240626Z","time spent":"380.228562ms","remote":"127.0.0.1:37974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.620936Z","caller":"traceutil/trace.go:171","msg":"trace[2136785982] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"381.033599ms","start":"2026-02-10T14:55:44.239892Z","end":"2026-02-10T14:55:44.620926Z","steps":["trace[2136785982] 'process raft request' (duration: 376.886546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.621033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239889Z","time spent":"381.12164ms","remote":"127.0.0.1:38064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.621176Z","caller":"traceutil/trace.go:171","msg":"trace[1282655858] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"381.25406ms","start":"2026-02-10T14:55:44.239915Z","end":"2026-02-10T14:55:44.621169Z","steps":["trace[1282655858] 'process raft request' (duration: 376.906446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.621245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239912Z","time spent":"381.314941ms","remote":"127.0.0.1:38064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.621403Z","caller":"traceutil/trace.go:171","msg":"trace[548209617] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"381.410251ms","start":"2026-02-10T14:55:44.239957Z","end":"2026-02-10T14:55:44.621367Z","steps":["trace[548209617] 'process raft request' (duration: 380.405433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.621475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239954Z","time spent":"381.503222ms","remote":"127.0.0.1:38064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.621621Z","caller":"traceutil/trace.go:171","msg":"trace[1592871971] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"381.582063ms","start":"2026-02-10T14:55:44.240033Z","end":"2026-02-10T14:55:44.621615Z","steps":["trace[1592871971] 'process raft request' (duration: 380.357264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.621686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.240026Z","time spent":"381.643904ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.620581Z","caller":"traceutil/trace.go:171","msg":"trace[1254803706] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"324.859603ms","start":"2026-02-10T14:55:44.295712Z","end":"2026-02-10T14:55:44.620571Z","steps":["trace[1254803706] 'process raft request' (duration: 324.836653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.621844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.295673Z","time spent":"326.152924ms","remote":"127.0.0.1:38064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:44.622239Z","caller":"traceutil/trace.go:171","msg":"trace[1848799284] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"379.568307ms","start":"2026-02-10T14:55:44.242663Z","end":"2026-02-10T14:55:44.622232Z","steps":["trace[1848799284] 'process raft request' (duration: 377.807973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.622462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.242658Z","time spent":"379.637248ms","remote":"127.0.0.1:37700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3167,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:44.622621Z","caller":"traceutil/trace.go:171","msg":"trace[1031762361] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:15; }","duration":"333.597422ms","start":"2026-02-10T14:55:44.288999Z","end":"2026-02-10T14:55:44.622597Z","steps":["trace[1031762361] 'read index received' (duration: 59.280809ms)","trace[1031762361] 'applied index is now lower than readState.Index' (duration: 274.315493ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:44.622713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.161545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.622776Z","caller":"traceutil/trace.go:171","msg":"trace[2088416485] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:20; }","duration":"383.230725ms","start":"2026-02-10T14:55:44.239538Z","end":"2026-02-10T14:55:44.622768Z","steps":["trace[2088416485] 'agreement among raft nodes before linearized reading' (duration: 383.154485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.622818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239534Z","time spent":"383.273916ms","remote":"127.0.0.1:37924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-02-10T14:55:44.622977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.444488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-8kjbs\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-10T14:55:44.623026Z","caller":"traceutil/trace.go:171","msg":"trace[332472357] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-8kjbs; range_end:; response_count:1; response_revision:20; }","duration":"383.498948ms","start":"2026-02-10T14:55:44.23952Z","end":"2026-02-10T14:55:44.623019Z","steps":["trace[332472357] 'agreement among raft nodes before linearized reading' (duration: 383.433288ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.62306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.239518Z","time spent":"383.536949ms","remote":"127.0.0.1:37768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-8kjbs\" "} {"level":"warn","ts":"2026-02-10T14:55:44.623397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.488661ms","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-10T14:55:44.623467Z","caller":"traceutil/trace.go:171","msg":"trace[2088538447] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"179.580543ms","start":"2026-02-10T14:55:44.443876Z","end":"2026-02-10T14:55:44.623456Z","steps":["trace[2088538447] 'agreement among raft nodes before linearized reading' (duration: 179.502362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.623658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.0838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.623713Z","caller":"traceutil/trace.go:171","msg":"trace[246670361] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:20; }","duration":"279.159501ms","start":"2026-02-10T14:55:44.344546Z","end":"2026-02-10T14:55:44.623706Z","steps":["trace[246670361] 'agreement among raft nodes before linearized reading' (duration: 279.0932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.62354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.196273ms","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-10T14:55:44.623877Z","caller":"traceutil/trace.go:171","msg":"trace[631472915] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"326.554807ms","start":"2026-02-10T14:55:44.297312Z","end":"2026-02-10T14:55:44.623867Z","steps":["trace[631472915] 'agreement among raft nodes before linearized reading' (duration: 325.866422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.623907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:44.2973Z","time spent":"326.599317ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-10T14:55:44.826899Z","caller":"traceutil/trace.go:171","msg":"trace[1273779225] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"191.144314ms","start":"2026-02-10T14:55:44.635725Z","end":"2026-02-10T14:55:44.82687Z","steps":["trace[1273779225] 'process raft request' (duration: 95.297535ms)","trace[1273779225] 'compare' (duration: 95.153544ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:44.827943Z","caller":"traceutil/trace.go:171","msg":"trace[1061653904] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"192.163723ms","start":"2026-02-10T14:55:44.635769Z","end":"2026-02-10T14:55:44.827933Z","steps":["trace[1061653904] 'process raft request' (duration: 191.029254ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.828448Z","caller":"traceutil/trace.go:171","msg":"trace[950777152] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"191.89828ms","start":"2026-02-10T14:55:44.63654Z","end":"2026-02-10T14:55:44.828439Z","steps":["trace[950777152] 'process raft request' (duration: 191.135774ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.828971Z","caller":"traceutil/trace.go:171","msg":"trace[1084063864] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"192.312334ms","start":"2026-02-10T14:55:44.63665Z","end":"2026-02-10T14:55:44.828962Z","steps":["trace[1084063864] 'process raft request' (duration: 191.263196ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.829385Z","caller":"traceutil/trace.go:171","msg":"trace[1257125366] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"191.372086ms","start":"2026-02-10T14:55:44.638003Z","end":"2026-02-10T14:55:44.829375Z","steps":["trace[1257125366] 'process raft request' (duration: 190.898233ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.829869Z","caller":"traceutil/trace.go:171","msg":"trace[1642421287] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"191.81676ms","start":"2026-02-10T14:55:44.63804Z","end":"2026-02-10T14:55:44.829856Z","steps":["trace[1642421287] 'process raft request' (duration: 190.901833ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.830204Z","caller":"traceutil/trace.go:171","msg":"trace[1449189335] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"191.908601ms","start":"2026-02-10T14:55:44.638286Z","end":"2026-02-10T14:55:44.830194Z","steps":["trace[1449189335] 'process raft request' (duration: 191.063544ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.830582Z","caller":"traceutil/trace.go:171","msg":"trace[565977784] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"153.353495ms","start":"2026-02-10T14:55:44.677218Z","end":"2026-02-10T14:55:44.830572Z","steps":["trace[565977784] 'process raft request' (duration: 153.299484ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:44.830748Z","caller":"traceutil/trace.go:171","msg":"trace[847823254] linearizableReadLoop","detail":"{readStateIndex:32; appliedIndex:25; }","duration":"158.138333ms","start":"2026-02-10T14:55:44.672594Z","end":"2026-02-10T14:55:44.830733Z","steps":["trace[847823254] 'read index received' (duration: 58.388303ms)","trace[847823254] 'applied index is now lower than readState.Index' (duration: 99.74832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:44.831073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.139111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.831117Z","caller":"traceutil/trace.go:171","msg":"trace[1231119045] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:29; }","duration":"193.207101ms","start":"2026-02-10T14:55:44.637899Z","end":"2026-02-10T14:55:44.831106Z","steps":["trace[1231119045] 'agreement among raft nodes before linearized reading' (duration: 193.05754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.831507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.029577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-10T14:55:44.831542Z","caller":"traceutil/trace.go:171","msg":"trace[204678549] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:29; }","duration":"199.074667ms","start":"2026-02-10T14:55:44.632459Z","end":"2026-02-10T14:55:44.831533Z","steps":["trace[204678549] 'agreement among raft nodes before linearized reading' (duration: 199.006787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.833639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.359841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.833681Z","caller":"traceutil/trace.go:171","msg":"trace[1831557505] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"155.436091ms","start":"2026-02-10T14:55:44.678235Z","end":"2026-02-10T14:55:44.833671Z","steps":["trace[1831557505] 'agreement among raft nodes before linearized reading' (duration: 155.374161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:44.833991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.625851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:44.834026Z","caller":"traceutil/trace.go:171","msg":"trace[1745855513] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:29; }","duration":"113.694981ms","start":"2026-02-10T14:55:44.720322Z","end":"2026-02-10T14:55:44.834017Z","steps":["trace[1745855513] 'agreement among raft nodes before linearized reading' (duration: 113.639961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:45.098676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.793189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:45.099067Z","caller":"traceutil/trace.go:171","msg":"trace[209813377] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"259.63091ms","start":"2026-02-10T14:55:44.839412Z","end":"2026-02-10T14:55:45.099043Z","steps":["trace[209813377] 'process raft request' (duration: 128.416698ms)","trace[209813377] 'compare' (duration: 130.677938ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:45.099274Z","caller":"traceutil/trace.go:171","msg":"trace[892885970] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:34; }","duration":"178.010934ms","start":"2026-02-10T14:55:44.921111Z","end":"2026-02-10T14:55:45.099122Z","steps":["trace[892885970] 'read index received' (duration: 46.730731ms)","trace[892885970] 'applied index is now lower than readState.Index' (duration: 131.279443ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:45.099424Z","caller":"traceutil/trace.go:171","msg":"trace[1908749125] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"257.963167ms","start":"2026-02-10T14:55:44.841448Z","end":"2026-02-10T14:55:45.099411Z","steps":["trace[1908749125] 'process raft request' (duration: 257.312992ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.099652Z","caller":"traceutil/trace.go:171","msg":"trace[1180563346] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"258.139159ms","start":"2026-02-10T14:55:44.841499Z","end":"2026-02-10T14:55:45.099638Z","steps":["trace[1180563346] 'process raft request' (duration: 257.411493ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.100192Z","caller":"traceutil/trace.go:171","msg":"trace[824220534] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"258.640202ms","start":"2026-02-10T14:55:44.841538Z","end":"2026-02-10T14:55:45.100178Z","steps":["trace[824220534] 'process raft request' (duration: 257.409853ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.100473Z","caller":"traceutil/trace.go:171","msg":"trace[345301128] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"257.426663ms","start":"2026-02-10T14:55:44.843034Z","end":"2026-02-10T14:55:45.10046Z","steps":["trace[345301128] 'process raft request' (duration: 256.033292ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.100615Z","caller":"traceutil/trace.go:171","msg":"trace[561997771] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"205.111509ms","start":"2026-02-10T14:55:44.895495Z","end":"2026-02-10T14:55:45.100606Z","steps":["trace[561997771] 'process raft request' (duration: 203.599707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:45.100733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.621947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.104013Z","caller":"traceutil/trace.go:171","msg":"trace[1403576912] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:39; }","duration":"182.951602ms","start":"2026-02-10T14:55:44.921051Z","end":"2026-02-10T14:55:45.104003Z","steps":["trace[1403576912] 'agreement among raft nodes before linearized reading' (duration: 179.581676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:45.100772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.468889ms","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-10T14:55:45.104234Z","caller":"traceutil/trace.go:171","msg":"trace[1329732557] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:39; }","duration":"180.929366ms","start":"2026-02-10T14:55:44.923296Z","end":"2026-02-10T14:55:45.104226Z","steps":["trace[1329732557] 'agreement among raft nodes before linearized reading' (duration: 177.458439ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.101126Z","caller":"traceutil/trace.go:171","msg":"trace[706882598] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"259.451799ms","start":"2026-02-10T14:55:44.841664Z","end":"2026-02-10T14:55:45.101116Z","steps":["trace[706882598] 'process raft request' (duration: 257.315812ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.101241Z","caller":"traceutil/trace.go:171","msg":"trace[870001382] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"259.52254ms","start":"2026-02-10T14:55:44.84171Z","end":"2026-02-10T14:55:45.101233Z","steps":["trace[870001382] 'process raft request' (duration: 257.295052ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.101271Z","caller":"traceutil/trace.go:171","msg":"trace[1933405890] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"258.768454ms","start":"2026-02-10T14:55:44.842496Z","end":"2026-02-10T14:55:45.101264Z","steps":["trace[1933405890] 'process raft request' (duration: 256.544156ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.30152Z","caller":"traceutil/trace.go:171","msg":"trace[169089345] linearizableReadLoop","detail":"{readStateIndex:47; appliedIndex:46; }","duration":"121.129982ms","start":"2026-02-10T14:55:45.180364Z","end":"2026-02-10T14:55:45.301494Z","steps":["trace[169089345] 'read index received' (duration: 54.601369ms)","trace[169089345] 'applied index is now lower than readState.Index' (duration: 66.527573ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:45.302018Z","caller":"traceutil/trace.go:171","msg":"trace[563847976] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"124.74425ms","start":"2026-02-10T14:55:45.177258Z","end":"2026-02-10T14:55:45.302002Z","steps":["trace[563847976] 'process raft request' (duration: 57.764514ms)","trace[563847976] 'compare' (duration: 66.292541ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:45.303922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.538971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.303972Z","caller":"traceutil/trace.go:171","msg":"trace[46577238] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:43; }","duration":"123.630532ms","start":"2026-02-10T14:55:45.180329Z","end":"2026-02-10T14:55:45.303959Z","steps":["trace[46577238] 'agreement among raft nodes before linearized reading' (duration: 123.511191ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:45.304261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.38915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.304305Z","caller":"traceutil/trace.go:171","msg":"trace[763483784] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:43; }","duration":"123.45386ms","start":"2026-02-10T14:55:45.180841Z","end":"2026-02-10T14:55:45.304295Z","steps":["trace[763483784] 'agreement among raft nodes before linearized reading' (duration: 123.39174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:45.304902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.37338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.304932Z","caller":"traceutil/trace.go:171","msg":"trace[645479373] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:43; }","duration":"123.42206ms","start":"2026-02-10T14:55:45.181502Z","end":"2026-02-10T14:55:45.304924Z","steps":["trace[645479373] 'agreement among raft nodes before linearized reading' (duration: 123.38158ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.467619Z","caller":"traceutil/trace.go:171","msg":"trace[1049766459] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"100.830982ms","start":"2026-02-10T14:55:45.366764Z","end":"2026-02-10T14:55:45.467595Z","steps":["trace[1049766459] 'process raft request' (duration: 100.779472ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.468046Z","caller":"traceutil/trace.go:171","msg":"trace[1514181006] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"102.455405ms","start":"2026-02-10T14:55:45.365574Z","end":"2026-02-10T14:55:45.468029Z","steps":["trace[1514181006] 'process raft request' (duration: 40.380607ms)","trace[1514181006] 'compare' (duration: 60.793378ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:45.468744Z","caller":"traceutil/trace.go:171","msg":"trace[647593072] linearizableReadLoop","detail":"{readStateIndex:52; appliedIndex:51; }","duration":"102.545816ms","start":"2026-02-10T14:55:45.366178Z","end":"2026-02-10T14:55:45.468724Z","steps":["trace[647593072] 'read index received' (duration: 39.806163ms)","trace[647593072] 'applied index is now lower than readState.Index' (duration: 62.737883ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:45.469018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.818858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.469186Z","caller":"traceutil/trace.go:171","msg":"trace[466973897] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:49; }","duration":"102.958059ms","start":"2026-02-10T14:55:45.366148Z","end":"2026-02-10T14:55:45.469106Z","steps":["trace[466973897] 'agreement among raft nodes before linearized reading' (duration: 102.726757ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.659389Z","caller":"traceutil/trace.go:171","msg":"trace[1388576813] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"174.905244ms","start":"2026-02-10T14:55:45.484466Z","end":"2026-02-10T14:55:45.659371Z","steps":["trace[1388576813] 'process raft request' (duration: 119.522369ms)","trace[1388576813] 'compare' (duration: 54.927682ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:45.659773Z","caller":"traceutil/trace.go:171","msg":"trace[1541718608] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"172.483705ms","start":"2026-02-10T14:55:45.48728Z","end":"2026-02-10T14:55:45.659763Z","steps":["trace[1541718608] 'process raft request' (duration: 172.411965ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:45.659886Z","caller":"traceutil/trace.go:171","msg":"trace[1334445640] linearizableReadLoop","detail":"{readStateIndex:56; appliedIndex:55; }","duration":"175.377598ms","start":"2026-02-10T14:55:45.4845Z","end":"2026-02-10T14:55:45.659877Z","steps":["trace[1334445640] 'read index received' (duration: 582.305µs)","trace[1334445640] 'applied index is now lower than readState.Index' (duration: 174.794653ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:45.660026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.510349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:45.660056Z","caller":"traceutil/trace.go:171","msg":"trace[271296071] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:53; }","duration":"175.56177ms","start":"2026-02-10T14:55:45.484488Z","end":"2026-02-10T14:55:45.660049Z","steps":["trace[271296071] 'agreement among raft nodes before linearized reading' (duration: 175.419098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.071693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.776442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:46.071783Z","caller":"traceutil/trace.go:171","msg":"trace[1903721939] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"405.983575ms","start":"2026-02-10T14:55:45.665783Z","end":"2026-02-10T14:55:46.071767Z","steps":["trace[1903721939] 'process raft request' (duration: 139.066032ms)","trace[1903721939] 'compare' (duration: 264.886528ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:46.071826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:45.665773Z","time spent":"406.036476ms","remote":"127.0.0.1:37970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:46.288992Z","caller":"traceutil/trace.go:171","msg":"trace[1595430307] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"622.830875ms","start":"2026-02-10T14:55:45.666146Z","end":"2026-02-10T14:55:46.288977Z","steps":["trace[1595430307] 'process raft request' (duration: 536.865385ms)","trace[1595430307] 'compare' (duration: 85.776169ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:46.28908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:45.666139Z","time spent":"622.895217ms","remote":"127.0.0.1:37970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1199,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:46.289095Z","caller":"traceutil/trace.go:171","msg":"trace[106507796] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"621.915408ms","start":"2026-02-10T14:55:45.667162Z","end":"2026-02-10T14:55:46.289077Z","steps":["trace[106507796] 'process raft request' (duration: 621.708187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.289192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:45.667154Z","time spent":"621.9741ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:46.290153Z","caller":"traceutil/trace.go:171","msg":"trace[497702377] linearizableReadLoop","detail":"{readStateIndex:61; appliedIndex:58; }","duration":"246.260579ms","start":"2026-02-10T14:55:46.04388Z","end":"2026-02-10T14:55:46.29014Z","steps":["trace[497702377] 'read index received' (duration: 159.14046ms)","trace[497702377] 'applied index is now lower than readState.Index' (duration: 87.119369ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:46.290289Z","caller":"traceutil/trace.go:171","msg":"trace[2009467693] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"215.707752ms","start":"2026-02-10T14:55:46.074575Z","end":"2026-02-10T14:55:46.290282Z","steps":["trace[2009467693] 'process raft request' (duration: 215.51648ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.290349Z","caller":"traceutil/trace.go:171","msg":"trace[1372161639] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"104.679526ms","start":"2026-02-10T14:55:46.185657Z","end":"2026-02-10T14:55:46.290336Z","steps":["trace[1372161639] 'process raft request' (duration: 104.459984ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.290371Z","caller":"traceutil/trace.go:171","msg":"trace[1032529879] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"302.792351ms","start":"2026-02-10T14:55:45.987571Z","end":"2026-02-10T14:55:46.290364Z","steps":["trace[1032529879] 'process raft request' (duration: 302.467969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.290401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:45.987547Z","time spent":"302.840141ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5860,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:55:46.290577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.691843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:46.290611Z","caller":"traceutil/trace.go:171","msg":"trace[2030365794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:59; }","duration":"246.764763ms","start":"2026-02-10T14:55:46.043838Z","end":"2026-02-10T14:55:46.290602Z","steps":["trace[2030365794] 'agreement among raft nodes before linearized reading' (duration: 246.650912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.546646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.782927ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:46.546741Z","caller":"traceutil/trace.go:171","msg":"trace[946767168] linearizableReadLoop","detail":"{readStateIndex:64; appliedIndex:63; }","duration":"249.849747ms","start":"2026-02-10T14:55:46.296875Z","end":"2026-02-10T14:55:46.546725Z","steps":["trace[946767168] 'read index received' (duration: 109.01118ms)","trace[946767168] 'applied index is now lower than readState.Index' (duration: 140.836877ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:46.547034Z","caller":"traceutil/trace.go:171","msg":"trace[1240018937] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"251.949384ms","start":"2026-02-10T14:55:46.295062Z","end":"2026-02-10T14:55:46.547012Z","steps":["trace[1240018937] 'process raft request' (duration: 110.739853ms)","trace[1240018937] 'compare' (duration: 140.653096ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:46.548648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.757212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-10T14:55:46.549359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.449818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:46.549411Z","caller":"traceutil/trace.go:171","msg":"trace[1295097363] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:61; }","duration":"252.500018ms","start":"2026-02-10T14:55:46.296903Z","end":"2026-02-10T14:55:46.549404Z","steps":["trace[1295097363] 'agreement among raft nodes before linearized reading' (duration: 252.421358ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.548697Z","caller":"traceutil/trace.go:171","msg":"trace[665124309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:60; }","duration":"251.830103ms","start":"2026-02-10T14:55:46.296855Z","end":"2026-02-10T14:55:46.548685Z","steps":["trace[665124309] 'agreement among raft nodes before linearized reading' (duration: 251.654941ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.549854Z","caller":"traceutil/trace.go:171","msg":"trace[421310962] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"252.883301ms","start":"2026-02-10T14:55:46.296965Z","end":"2026-02-10T14:55:46.549848Z","steps":["trace[421310962] 'process raft request' (duration: 252.322226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.549943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.28099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-10T14:55:46.549993Z","caller":"traceutil/trace.go:171","msg":"trace[27145474] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:61; }","duration":"250.345901ms","start":"2026-02-10T14:55:46.299642Z","end":"2026-02-10T14:55:46.549988Z","steps":["trace[27145474] 'agreement among raft nodes before linearized reading' (duration: 250.26007ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:46.957691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.907838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:46.957812Z","caller":"traceutil/trace.go:171","msg":"trace[994532599] linearizableReadLoop","detail":"{readStateIndex:90; appliedIndex:89; }","duration":"160.783693ms","start":"2026-02-10T14:55:46.797008Z","end":"2026-02-10T14:55:46.957792Z","steps":["trace[994532599] 'read index received' (duration: 55.645594ms)","trace[994532599] 'applied index is now lower than readState.Index' (duration: 105.136709ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:46.957936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.922134ms","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-10T14:55:46.957967Z","caller":"traceutil/trace.go:171","msg":"trace[1810018866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:86; }","duration":"160.996054ms","start":"2026-02-10T14:55:46.796959Z","end":"2026-02-10T14:55:46.957955Z","steps":["trace[1810018866] 'agreement among raft nodes before linearized reading' (duration: 160.882443ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:46.958353Z","caller":"traceutil/trace.go:171","msg":"trace[2095878732] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"210.41307ms","start":"2026-02-10T14:55:46.747926Z","end":"2026-02-10T14:55:46.958339Z","steps":["trace[2095878732] 'process raft request' (duration: 104.784647ms)","trace[2095878732] 'compare' (duration: 104.744376ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.376855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.07561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:47.377089Z","caller":"traceutil/trace.go:171","msg":"trace[1951118285] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"411.622014ms","start":"2026-02-10T14:55:46.965447Z","end":"2026-02-10T14:55:47.377069Z","steps":["trace[1951118285] 'process raft request' (duration: 217.302102ms)","trace[1951118285] 'compare' (duration: 193.903419ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.377357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:46.96544Z","time spent":"411.889856ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1917,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:47.377699Z","caller":"traceutil/trace.go:171","msg":"trace[178366226] linearizableReadLoop","detail":"{readStateIndex:92; appliedIndex:91; }","duration":"369.551007ms","start":"2026-02-10T14:55:47.008137Z","end":"2026-02-10T14:55:47.377688Z","steps":["trace[178366226] 'read index received' (duration: 174.714241ms)","trace[178366226] 'applied index is now lower than readState.Index' (duration: 194.835696ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.377884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.740128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-10T14:55:47.377964Z","caller":"traceutil/trace.go:171","msg":"trace[1854748795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:88; }","duration":"370.199152ms","start":"2026-02-10T14:55:47.007753Z","end":"2026-02-10T14:55:47.377953Z","steps":["trace[1854748795] 'agreement among raft nodes before linearized reading' (duration: 370.052401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:47.37805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.007736Z","time spent":"370.303293ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:55:47.378257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.989083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-10T14:55:47.378338Z","caller":"traceutil/trace.go:171","msg":"trace[322989662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:88; }","duration":"267.109795ms","start":"2026-02-10T14:55:47.111212Z","end":"2026-02-10T14:55:47.378322Z","steps":["trace[322989662] 'agreement among raft nodes before linearized reading' (duration: 267.021874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:47.712753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.432405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:47.712888Z","caller":"traceutil/trace.go:171","msg":"trace[1603129978] linearizableReadLoop","detail":"{readStateIndex:97; appliedIndex:95; }","duration":"295.490285ms","start":"2026-02-10T14:55:47.417387Z","end":"2026-02-10T14:55:47.712877Z","steps":["trace[1603129978] 'read index received' (duration: 40.391243ms)","trace[1603129978] 'applied index is now lower than readState.Index' (duration: 255.098422ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.713096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.711477ms","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-10T14:55:47.71312Z","caller":"traceutil/trace.go:171","msg":"trace[1184741365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:92; }","duration":"295.771747ms","start":"2026-02-10T14:55:47.417342Z","end":"2026-02-10T14:55:47.713113Z","steps":["trace[1184741365] 'agreement among raft nodes before linearized reading' (duration: 295.569116ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:47.713329Z","caller":"traceutil/trace.go:171","msg":"trace[1144392444] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"327.13459ms","start":"2026-02-10T14:55:47.386176Z","end":"2026-02-10T14:55:47.713311Z","steps":["trace[1144392444] 'process raft request' (duration: 150.09598ms)","trace[1144392444] 'compare' (duration: 175.571598ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:47.713623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.386164Z","time spent":"327.409162ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:55:47.71381Z","caller":"traceutil/trace.go:171","msg":"trace[1727630464] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"326.085612ms","start":"2026-02-10T14:55:47.387692Z","end":"2026-02-10T14:55:47.713777Z","steps":["trace[1727630464] 'process raft request' (duration: 325.126285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:47.713863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:55:47.387679Z","time spent":"326.156623ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:55:47.716585Z","caller":"traceutil/trace.go:171","msg":"trace[178202145] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"256.592844ms","start":"2026-02-10T14:55:47.459971Z","end":"2026-02-10T14:55:47.716564Z","steps":["trace[178202145] 'process raft request' (duration: 256.198961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:48.016565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.813224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:48.016711Z","caller":"traceutil/trace.go:171","msg":"trace[1999475149] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"231.168737ms","start":"2026-02-10T14:55:47.785531Z","end":"2026-02-10T14:55:48.0167Z","steps":["trace[1999475149] 'process raft request' (duration: 231.140377ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.016959Z","caller":"traceutil/trace.go:171","msg":"trace[1634187297] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"287.316101ms","start":"2026-02-10T14:55:47.729612Z","end":"2026-02-10T14:55:48.016928Z","steps":["trace[1634187297] 'process raft request' (duration: 287.025068ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.017249Z","caller":"traceutil/trace.go:171","msg":"trace[289801966] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"288.563391ms","start":"2026-02-10T14:55:47.728675Z","end":"2026-02-10T14:55:48.017238Z","steps":["trace[289801966] 'process raft request' (duration: 119.030721ms)","trace[289801966] 'compare' (duration: 168.683513ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:48.203372Z","caller":"traceutil/trace.go:171","msg":"trace[1991039170] linearizableReadLoop","detail":"{readStateIndex:108; appliedIndex:107; }","duration":"134.846955ms","start":"2026-02-10T14:55:48.068503Z","end":"2026-02-10T14:55:48.20335Z","steps":["trace[1991039170] 'read index received' (duration: 93.635249ms)","trace[1991039170] 'applied index is now lower than readState.Index' (duration: 41.210376ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:48.203797Z","caller":"traceutil/trace.go:171","msg":"trace[2120258542] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"135.324719ms","start":"2026-02-10T14:55:48.068463Z","end":"2026-02-10T14:55:48.203788Z","steps":["trace[2120258542] 'process raft request' (duration: 93.73122ms)","trace[2120258542] 'compare' (duration: 40.577901ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:48.204116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.597611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1892ea691521ab99\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-02-10T14:55:48.204216Z","caller":"traceutil/trace.go:171","msg":"trace[692160273] range","detail":"{range_begin:/registry/events/default/instance.1892ea691521ab99; range_end:; response_count:1; response_revision:103; }","duration":"135.728662ms","start":"2026-02-10T14:55:48.068475Z","end":"2026-02-10T14:55:48.204204Z","steps":["trace[692160273] 'agreement among raft nodes before linearized reading' (duration: 135.546601ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:48.661415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.556594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-10T14:55:48.661762Z","caller":"traceutil/trace.go:171","msg":"trace[824348297] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"191.55367ms","start":"2026-02-10T14:55:48.47018Z","end":"2026-02-10T14:55:48.661733Z","steps":["trace[824348297] 'process raft request' (duration: 35.602603ms)","trace[824348297] 'compare' (duration: 155.470053ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:48.662357Z","caller":"traceutil/trace.go:171","msg":"trace[266378997] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"191.628881ms","start":"2026-02-10T14:55:48.470717Z","end":"2026-02-10T14:55:48.662346Z","steps":["trace[266378997] 'process raft request' (duration: 191.57603ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.895867Z","caller":"traceutil/trace.go:171","msg":"trace[854412270] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"131.086725ms","start":"2026-02-10T14:55:48.764767Z","end":"2026-02-10T14:55:48.895854Z","steps":["trace[854412270] 'process raft request' (duration: 130.749943ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:48.89611Z","caller":"traceutil/trace.go:171","msg":"trace[397839467] linearizableReadLoop","detail":"{readStateIndex:126; appliedIndex:125; }","duration":"128.169013ms","start":"2026-02-10T14:55:48.76749Z","end":"2026-02-10T14:55:48.895659Z","steps":["trace[397839467] 'read index received' (duration: 127.953411ms)","trace[397839467] 'applied index is now lower than readState.Index' (duration: 214.652µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:48.896212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.708118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1892ea691521ab99\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-02-10T14:55:48.896238Z","caller":"traceutil/trace.go:171","msg":"trace[1651364979] range","detail":"{range_begin:/registry/events/default/instance.1892ea691521ab99; range_end:; response_count:1; response_revision:121; }","duration":"128.779278ms","start":"2026-02-10T14:55:48.767452Z","end":"2026-02-10T14:55:48.896232Z","steps":["trace[1651364979] 'agreement among raft nodes before linearized reading' (duration: 128.685528ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.42374Z","caller":"traceutil/trace.go:171","msg":"trace[772036227] transaction","detail":"{read_only:false; response_revision:135; number_of_response:1; }","duration":"115.633921ms","start":"2026-02-10T14:55:49.308083Z","end":"2026-02-10T14:55:49.423717Z","steps":["trace[772036227] 'process raft request' (duration: 56.435759ms)","trace[772036227] 'compare' (duration: 58.836799ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:49.426461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.737257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.1892ea6915218a0b\" ","response":"range_response_count:1 size:656"} {"level":"info","ts":"2026-02-10T14:55:49.426525Z","caller":"traceutil/trace.go:171","msg":"trace[33098607] range","detail":"{range_begin:/registry/events/default/instance.1892ea6915218a0b; range_end:; response_count:1; response_revision:135; }","duration":"117.828018ms","start":"2026-02-10T14:55:49.308683Z","end":"2026-02-10T14:55:49.426511Z","steps":["trace[33098607] 'agreement among raft nodes before linearized reading' (duration: 116.486958ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:49.425123Z","caller":"traceutil/trace.go:171","msg":"trace[144191412] linearizableReadLoop","detail":"{readStateIndex:140; appliedIndex:139; }","duration":"114.833185ms","start":"2026-02-10T14:55:49.308705Z","end":"2026-02-10T14:55:49.423538Z","steps":["trace[144191412] 'read index received' (duration: 55.871206ms)","trace[144191412] 'applied index is now lower than readState.Index' (duration: 58.960819ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:50.392366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.899967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:50.392467Z","caller":"traceutil/trace.go:171","msg":"trace[1415616081] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:0; response_revision:196; }","duration":"169.046728ms","start":"2026-02-10T14:55:50.223385Z","end":"2026-02-10T14:55:50.392451Z","steps":["trace[1415616081] 'range keys from in-memory index tree' (duration: 168.817106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:50.857189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.169463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:50.857289Z","caller":"traceutil/trace.go:171","msg":"trace[444665824] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:207; }","duration":"165.497412ms","start":"2026-02-10T14:55:50.691775Z","end":"2026-02-10T14:55:50.857273Z","steps":["trace[444665824] 'read index received' (duration: 22.104717ms)","trace[444665824] 'applied index is now lower than readState.Index' (duration: 143.391635ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:50.857421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.643173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5873"} {"level":"info","ts":"2026-02-10T14:55:50.857407Z","caller":"traceutil/trace.go:171","msg":"trace[247552165] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"236.270967ms","start":"2026-02-10T14:55:50.621108Z","end":"2026-02-10T14:55:50.857379Z","steps":["trace[247552165] 'process raft request' (duration: 92.819262ms)","trace[247552165] 'compare' (duration: 142.992461ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:50.857448Z","caller":"traceutil/trace.go:171","msg":"trace[1783340435] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:203; }","duration":"165.709943ms","start":"2026-02-10T14:55:50.691729Z","end":"2026-02-10T14:55:50.857438Z","steps":["trace[1783340435] 'agreement among raft nodes before linearized reading' (duration: 165.587212ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:51.053067Z","caller":"traceutil/trace.go:171","msg":"trace[1274024322] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"114.958345ms","start":"2026-02-10T14:55:50.938089Z","end":"2026-02-10T14:55:51.053047Z","steps":["trace[1274024322] 'read index received' (duration: 70.660643ms)","trace[1274024322] 'applied index is now lower than readState.Index' (duration: 44.296822ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:51.053195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.083256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:51.053227Z","caller":"traceutil/trace.go:171","msg":"trace[2144886058] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslice-controller; range_end:; response_count:0; response_revision:205; }","duration":"115.166117ms","start":"2026-02-10T14:55:50.93805Z","end":"2026-02-10T14:55:51.053217Z","steps":["trace[2144886058] 'agreement among raft nodes before linearized reading' (duration: 115.068946ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:51.053451Z","caller":"traceutil/trace.go:171","msg":"trace[1933700374] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"177.131515ms","start":"2026-02-10T14:55:50.876312Z","end":"2026-02-10T14:55:51.053443Z","steps":["trace[1933700374] 'process raft request' (duration: 132.47806ms)","trace[1933700374] 'compare' (duration: 44.165331ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:51.588253Z","caller":"traceutil/trace.go:171","msg":"trace[1951695527] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"179.529768ms","start":"2026-02-10T14:55:51.408698Z","end":"2026-02-10T14:55:51.588228Z","steps":["trace[1951695527] 'process raft request' (duration: 123.8065ms)","trace[1951695527] 'compare' (duration: 55.578507ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:51.882116Z","caller":"traceutil/trace.go:171","msg":"trace[1996175792] linearizableReadLoop","detail":"{readStateIndex:225; appliedIndex:224; }","duration":"129.19154ms","start":"2026-02-10T14:55:51.7529Z","end":"2026-02-10T14:55:51.882091Z","steps":["trace[1996175792] 'read index received' (duration: 36.195992ms)","trace[1996175792] 'applied index is now lower than readState.Index' (duration: 92.994668ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:51.882276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.366491ms","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-10T14:55:51.882309Z","caller":"traceutil/trace.go:171","msg":"trace[1327980899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:220; }","duration":"129.454972ms","start":"2026-02-10T14:55:51.752845Z","end":"2026-02-10T14:55:51.8823Z","steps":["trace[1327980899] 'agreement among raft nodes before linearized reading' (duration: 129.348151ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:51.882558Z","caller":"traceutil/trace.go:171","msg":"trace[667258760] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"225.11388ms","start":"2026-02-10T14:55:51.657425Z","end":"2026-02-10T14:55:51.882539Z","steps":["trace[667258760] 'process raft request' (duration: 131.77055ms)","trace[667258760] 'compare' (duration: 92.783716ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:51.99482Z","caller":"traceutil/trace.go:171","msg":"trace[1401682544] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"104.967538ms","start":"2026-02-10T14:55:51.889829Z","end":"2026-02-10T14:55:51.994796Z","steps":["trace[1401682544] 'process raft request' (duration: 95.413267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:52.339479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.881392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:52.339575Z","caller":"traceutil/trace.go:171","msg":"trace[2020920475] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:229; }","duration":"229.882624ms","start":"2026-02-10T14:55:52.109676Z","end":"2026-02-10T14:55:52.339559Z","steps":["trace[2020920475] 'read index received' (duration: 128.76715ms)","trace[2020920475] 'applied index is now lower than readState.Index' (duration: 101.114323ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:52.339857Z","caller":"traceutil/trace.go:171","msg":"trace[1371539795] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"270.415507ms","start":"2026-02-10T14:55:52.069429Z","end":"2026-02-10T14:55:52.339844Z","steps":["trace[1371539795] 'process raft request' (duration: 169.107121ms)","trace[1371539795] 'compare' (duration: 100.724651ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:52.340412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.724461ms","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-10T14:55:52.340576Z","caller":"traceutil/trace.go:171","msg":"trace[1962003172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:225; }","duration":"230.943052ms","start":"2026-02-10T14:55:52.10961Z","end":"2026-02-10T14:55:52.340553Z","steps":["trace[1962003172] 'agreement among raft nodes before linearized reading' (duration: 230.74399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:52.600468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.231272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:52.600569Z","caller":"traceutil/trace.go:171","msg":"trace[1538632333] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"175.423938ms","start":"2026-02-10T14:55:52.425127Z","end":"2026-02-10T14:55:52.600551Z","steps":["trace[1538632333] 'process raft request' (duration: 53.044005ms)","trace[1538632333] 'compare' (duration: 122.105591ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:53.08168Z","caller":"traceutil/trace.go:171","msg":"trace[1393353475] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"124.225332ms","start":"2026-02-10T14:55:52.957436Z","end":"2026-02-10T14:55:53.081661Z","steps":["trace[1393353475] 'process raft request' (duration: 97.433654ms)","trace[1393353475] 'compare' (duration: 26.224444ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:53.384014Z","caller":"traceutil/trace.go:171","msg":"trace[975797680] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"148.269448ms","start":"2026-02-10T14:55:53.23572Z","end":"2026-02-10T14:55:53.38399Z","steps":["trace[975797680] 'process raft request' (duration: 85.348372ms)","trace[975797680] 'compare' (duration: 62.491113ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:54.076585Z","caller":"traceutil/trace.go:171","msg":"trace[1773071744] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"113.014103ms","start":"2026-02-10T14:55:53.963545Z","end":"2026-02-10T14:55:54.076559Z","steps":["trace[1773071744] 'process raft request' (duration: 76.576675ms)","trace[1773071744] 'compare' (duration: 36.337477ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:55.173296Z","caller":"traceutil/trace.go:171","msg":"trace[806879291] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"198.095299ms","start":"2026-02-10T14:55:54.975171Z","end":"2026-02-10T14:55:55.173266Z","steps":["trace[806879291] 'process raft request' (duration: 97.870056ms)","trace[806879291] 'compare' (duration: 99.685029ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:55.173748Z","caller":"traceutil/trace.go:171","msg":"trace[444269061] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"196.787679ms","start":"2026-02-10T14:55:54.976927Z","end":"2026-02-10T14:55:55.173715Z","steps":["trace[444269061] 'read index received' (duration: 96.058113ms)","trace[444269061] 'applied index is now lower than readState.Index' (duration: 100.728386ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:55.174036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.101572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:55.174105Z","caller":"traceutil/trace.go:171","msg":"trace[271618926] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:0; response_revision:295; }","duration":"197.216843ms","start":"2026-02-10T14:55:54.976878Z","end":"2026-02-10T14:55:55.174094Z","steps":["trace[271618926] 'agreement among raft nodes before linearized reading' (duration: 197.127163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:55.174682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.353986ms","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-10T14:55:55.17481Z","caller":"traceutil/trace.go:171","msg":"trace[2032711520] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:295; }","duration":"162.480017ms","start":"2026-02-10T14:55:55.012316Z","end":"2026-02-10T14:55:55.174796Z","steps":["trace[2032711520] 'agreement among raft nodes before linearized reading' (duration: 162.287126ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.06529Z","caller":"traceutil/trace.go:171","msg":"trace[1647922599] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"129.347012ms","start":"2026-02-10T14:55:55.935928Z","end":"2026-02-10T14:55:56.065275Z","steps":["trace[1647922599] 'process raft request' (duration: 101.954623ms)","trace[1647922599] 'compare' (duration: 27.091846ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.065404Z","caller":"traceutil/trace.go:171","msg":"trace[1561710236] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"100.620712ms","start":"2026-02-10T14:55:55.964776Z","end":"2026-02-10T14:55:56.065397Z","steps":["trace[1561710236] 'read index received' (duration: 73.113743ms)","trace[1561710236] 'applied index is now lower than readState.Index' (duration: 27.506269ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:56.065468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.707805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-10T14:55:56.065483Z","caller":"traceutil/trace.go:171","msg":"trace[1890884279] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:313; }","duration":"129.759155ms","start":"2026-02-10T14:55:55.93572Z","end":"2026-02-10T14:55:56.065479Z","steps":["trace[1890884279] 'agreement among raft nodes before linearized reading' (duration: 129.698435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.06565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.886735ms","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-10T14:55:56.065665Z","caller":"traceutil/trace.go:171","msg":"trace[1069387969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:313; }","duration":"118.924715ms","start":"2026-02-10T14:55:55.946735Z","end":"2026-02-10T14:55:56.06566Z","steps":["trace[1069387969] 'agreement among raft nodes before linearized reading' (duration: 118.897265ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.065726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.868066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-02-10T14:55:56.065738Z","caller":"traceutil/trace.go:171","msg":"trace[1060193873] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:313; }","duration":"129.890886ms","start":"2026-02-10T14:55:55.935844Z","end":"2026-02-10T14:55:56.065735Z","steps":["trace[1060193873] 'agreement among raft nodes before linearized reading' (duration: 129.870156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.065791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.953676ms","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-10T14:55:56.065803Z","caller":"traceutil/trace.go:171","msg":"trace[583382818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:313; }","duration":"129.971876ms","start":"2026-02-10T14:55:55.935828Z","end":"2026-02-10T14:55:56.0658Z","steps":["trace[583382818] 'agreement among raft nodes before linearized reading' (duration: 129.948686ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.215386Z","caller":"traceutil/trace.go:171","msg":"trace[23753714] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"177.028636ms","start":"2026-02-10T14:55:56.038268Z","end":"2026-02-10T14:55:56.215296Z","steps":["trace[23753714] 'process raft request' (duration: 145.092613ms)","trace[23753714] 'compare' (duration: 31.884292ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.215778Z","caller":"traceutil/trace.go:171","msg":"trace[2034132301] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"174.344906ms","start":"2026-02-10T14:55:56.041424Z","end":"2026-02-10T14:55:56.215769Z","steps":["trace[2034132301] 'process raft request' (duration: 173.971113ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.215974Z","caller":"traceutil/trace.go:171","msg":"trace[1023780582] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"174.200745ms","start":"2026-02-10T14:55:56.041766Z","end":"2026-02-10T14:55:56.215967Z","steps":["trace[1023780582] 'process raft request' (duration: 173.799683ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.216282Z","caller":"traceutil/trace.go:171","msg":"trace[2137550626] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"172.570424ms","start":"2026-02-10T14:55:56.043702Z","end":"2026-02-10T14:55:56.216272Z","steps":["trace[2137550626] 'process raft request' (duration: 171.921439ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.2173Z","caller":"traceutil/trace.go:171","msg":"trace[1581836592] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:319; }","duration":"140.563691ms","start":"2026-02-10T14:55:56.076725Z","end":"2026-02-10T14:55:56.217288Z","steps":["trace[1581836592] 'read index received' (duration: 106.736805ms)","trace[1581836592] 'applied index is now lower than readState.Index' (duration: 33.826206ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.21737Z","caller":"traceutil/trace.go:171","msg":"trace[1113052553] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"170.095296ms","start":"2026-02-10T14:55:56.047266Z","end":"2026-02-10T14:55:56.217362Z","steps":["trace[1113052553] 'process raft request' (duration: 169.957155ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.217442Z","caller":"traceutil/trace.go:171","msg":"trace[1758057603] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"168.0486ms","start":"2026-02-10T14:55:56.049388Z","end":"2026-02-10T14:55:56.217437Z","steps":["trace[1758057603] 'process raft request' (duration: 167.878039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.217533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.792123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:56.217566Z","caller":"traceutil/trace.go:171","msg":"trace[61320160] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:313; }","duration":"140.861233ms","start":"2026-02-10T14:55:56.076696Z","end":"2026-02-10T14:55:56.217558Z","steps":["trace[61320160] 'agreement among raft nodes before linearized reading' (duration: 140.800203ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.279809Z","caller":"traceutil/trace.go:171","msg":"trace[971273535] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"202.948854ms","start":"2026-02-10T14:55:56.076841Z","end":"2026-02-10T14:55:56.27979Z","steps":["trace[971273535] 'process raft request' (duration: 202.712272ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.280307Z","caller":"traceutil/trace.go:171","msg":"trace[1817079286] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"201.500533ms","start":"2026-02-10T14:55:56.078789Z","end":"2026-02-10T14:55:56.28029Z","steps":["trace[1817079286] 'process raft request' (duration: 200.947109ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.280523Z","caller":"traceutil/trace.go:171","msg":"trace[91871894] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"201.697265ms","start":"2026-02-10T14:55:56.07882Z","end":"2026-02-10T14:55:56.280517Z","steps":["trace[91871894] 'process raft request' (duration: 201.423313ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.283112Z","caller":"traceutil/trace.go:171","msg":"trace[1702258001] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"202.879633ms","start":"2026-02-10T14:55:56.076888Z","end":"2026-02-10T14:55:56.279767Z","steps":["trace[1702258001] 'process raft request' (duration: 202.787023ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.28058Z","caller":"traceutil/trace.go:171","msg":"trace[56661220] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"200.337095ms","start":"2026-02-10T14:55:56.080237Z","end":"2026-02-10T14:55:56.280574Z","steps":["trace[56661220] 'process raft request' (duration: 200.159564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.280627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.740296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-10T14:55:56.283497Z","caller":"traceutil/trace.go:171","msg":"trace[1408184632] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:318; }","duration":"204.640366ms","start":"2026-02-10T14:55:56.078841Z","end":"2026-02-10T14:55:56.283482Z","steps":["trace[1408184632] 'agreement among raft nodes before linearized reading' (duration: 201.746095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.52733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.579692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:56.528037Z","caller":"traceutil/trace.go:171","msg":"trace[242499662] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:331; }","duration":"210.343148ms","start":"2026-02-10T14:55:56.317677Z","end":"2026-02-10T14:55:56.52802Z","steps":["trace[242499662] 'read index received' (duration: 106.02745ms)","trace[242499662] 'applied index is now lower than readState.Index' (duration: 104.314708ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.528457Z","caller":"traceutil/trace.go:171","msg":"trace[1847190196] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"233.909009ms","start":"2026-02-10T14:55:56.294532Z","end":"2026-02-10T14:55:56.528441Z","steps":["trace[1847190196] 'process raft request' (duration: 129.164048ms)","trace[1847190196] 'compare' (duration: 103.458701ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.52892Z","caller":"traceutil/trace.go:171","msg":"trace[1255393643] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"229.257245ms","start":"2026-02-10T14:55:56.299651Z","end":"2026-02-10T14:55:56.528908Z","steps":["trace[1255393643] 'process raft request' (duration: 228.245358ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.528966Z","caller":"traceutil/trace.go:171","msg":"trace[620624875] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"213.053178ms","start":"2026-02-10T14:55:56.315906Z","end":"2026-02-10T14:55:56.528959Z","steps":["trace[620624875] 'process raft request' (duration: 212.07855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.529037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.347795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-10T14:55:56.531194Z","caller":"traceutil/trace.go:171","msg":"trace[199100739] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:322; }","duration":"213.49459ms","start":"2026-02-10T14:55:56.317646Z","end":"2026-02-10T14:55:56.531141Z","steps":["trace[199100739] 'agreement among raft nodes before linearized reading' (duration: 211.346115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.540867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.171774ms","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-10T14:55:56.540912Z","caller":"traceutil/trace.go:171","msg":"trace[763111601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:322; }","duration":"116.257884ms","start":"2026-02-10T14:55:56.424645Z","end":"2026-02-10T14:55:56.540903Z","steps":["trace[763111601] 'agreement among raft nodes before linearized reading' (duration: 116.160044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.541049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.114598ms","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-10T14:55:56.541067Z","caller":"traceutil/trace.go:171","msg":"trace[1575897625] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:322; }","duration":"103.16701ms","start":"2026-02-10T14:55:56.437895Z","end":"2026-02-10T14:55:56.541062Z","steps":["trace[1575897625] 'agreement among raft nodes before linearized reading' (duration: 103.130639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:56.821314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.785381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:56.824048Z","caller":"traceutil/trace.go:171","msg":"trace[1529441660] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"282.396061ms","start":"2026-02-10T14:55:56.541626Z","end":"2026-02-10T14:55:56.824022Z","steps":["trace[1529441660] 'process raft request' (duration: 178.812899ms)","trace[1529441660] 'compare' (duration: 100.62252ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:56.829506Z","caller":"traceutil/trace.go:171","msg":"trace[720995138] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"242.790804ms","start":"2026-02-10T14:55:56.586692Z","end":"2026-02-10T14:55:56.829483Z","steps":["trace[720995138] 'process raft request' (duration: 242.742003ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.8297Z","caller":"traceutil/trace.go:171","msg":"trace[243166437] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"284.791569ms","start":"2026-02-10T14:55:56.544893Z","end":"2026-02-10T14:55:56.829685Z","steps":["trace[243166437] 'process raft request' (duration: 278.973387ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.830213Z","caller":"traceutil/trace.go:171","msg":"trace[1900629368] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"283.915872ms","start":"2026-02-10T14:55:56.546287Z","end":"2026-02-10T14:55:56.830202Z","steps":["trace[1900629368] 'process raft request' (duration: 283.046775ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:56.831874Z","caller":"traceutil/trace.go:171","msg":"trace[132998200] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:335; }","duration":"286.835944ms","start":"2026-02-10T14:55:56.545018Z","end":"2026-02-10T14:55:56.831854Z","steps":["trace[132998200] 'read index received' (duration: 38.897863ms)","trace[132998200] 'applied index is now lower than readState.Index' (duration: 247.936441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:56.831976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.936244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-10T14:55:56.832051Z","caller":"traceutil/trace.go:171","msg":"trace[812128570] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:327; }","duration":"287.040995ms","start":"2026-02-10T14:55:56.545001Z","end":"2026-02-10T14:55:56.832042Z","steps":["trace[812128570] 'agreement among raft nodes before linearized reading' (duration: 286.916934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:55:57.054936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.199598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:55:57.055445Z","caller":"traceutil/trace.go:171","msg":"trace[1457074292] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"166.371405ms","start":"2026-02-10T14:55:56.889009Z","end":"2026-02-10T14:55:57.055381Z","steps":["trace[1457074292] 'process raft request' (duration: 166.284775ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.056123Z","caller":"traceutil/trace.go:171","msg":"trace[143464008] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"167.371503ms","start":"2026-02-10T14:55:56.888706Z","end":"2026-02-10T14:55:57.056077Z","steps":["trace[143464008] 'process raft request' (duration: 40.976006ms)","trace[143464008] 'compare' (duration: 125.056507ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:57.056639Z","caller":"traceutil/trace.go:171","msg":"trace[1631177733] linearizableReadLoop","detail":"{readStateIndex:341; appliedIndex:340; }","duration":"167.663885ms","start":"2026-02-10T14:55:56.888959Z","end":"2026-02-10T14:55:57.056623Z","steps":["trace[1631177733] 'read index received' (duration: 40.667453ms)","trace[1631177733] 'applied index is now lower than readState.Index' (duration: 126.994842ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:57.058842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.8264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-10T14:55:57.058898Z","caller":"traceutil/trace.go:171","msg":"trace[281284409] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:330; }","duration":"169.944692ms","start":"2026-02-10T14:55:56.88894Z","end":"2026-02-10T14:55:57.058884Z","steps":["trace[281284409] 'agreement among raft nodes before linearized reading' (duration: 167.795026ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.243291Z","caller":"traceutil/trace.go:171","msg":"trace[329999300] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"113.761991ms","start":"2026-02-10T14:55:57.129513Z","end":"2026-02-10T14:55:57.243275Z","steps":["trace[329999300] 'process raft request' (duration: 113.729081ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.243658Z","caller":"traceutil/trace.go:171","msg":"trace[1932447424] linearizableReadLoop","detail":"{readStateIndex:344; appliedIndex:343; }","duration":"114.262714ms","start":"2026-02-10T14:55:57.129376Z","end":"2026-02-10T14:55:57.243638Z","steps":["trace[1932447424] 'read index received' (duration: 96.657587ms)","trace[1932447424] 'applied index is now lower than readState.Index' (duration: 17.603697ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:57.243754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.362915ms","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-10T14:55:57.243955Z","caller":"traceutil/trace.go:171","msg":"trace[2133038935] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:333; }","duration":"114.597007ms","start":"2026-02-10T14:55:57.129349Z","end":"2026-02-10T14:55:57.243946Z","steps":["trace[2133038935] 'agreement among raft nodes before linearized reading' (duration: 114.360215ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.245447Z","caller":"traceutil/trace.go:171","msg":"trace[1676705954] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"173.643774ms","start":"2026-02-10T14:55:57.070591Z","end":"2026-02-10T14:55:57.244235Z","steps":["trace[1676705954] 'process raft request' (duration: 155.372052ms)","trace[1676705954] 'compare' (duration: 17.195254ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:57.409002Z","caller":"traceutil/trace.go:171","msg":"trace[2010479652] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"135.680679ms","start":"2026-02-10T14:55:57.2733Z","end":"2026-02-10T14:55:57.40898Z","steps":["trace[2010479652] 'process raft request' (duration: 88.263967ms)","trace[2010479652] 'compare' (duration: 46.908658ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:55:57.410099Z","caller":"traceutil/trace.go:171","msg":"trace[1385655449] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"125.865229ms","start":"2026-02-10T14:55:57.284224Z","end":"2026-02-10T14:55:57.410089Z","steps":["trace[1385655449] 'process raft request' (duration: 124.371318ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:55:57.410575Z","caller":"traceutil/trace.go:171","msg":"trace[142957507] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:347; }","duration":"125.427256ms","start":"2026-02-10T14:55:57.28463Z","end":"2026-02-10T14:55:57.410057Z","steps":["trace[142957507] 'read index received' (duration: 77.106257ms)","trace[142957507] 'applied index is now lower than readState.Index' (duration: 48.293838ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:55:57.410851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.182131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:55:57.411211Z","caller":"traceutil/trace.go:171","msg":"trace[1858471252] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:337; }","duration":"126.563824ms","start":"2026-02-10T14:55:57.284608Z","end":"2026-02-10T14:55:57.411172Z","steps":["trace[1858471252] 'agreement among raft nodes before linearized reading' (duration: 126.156211ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:02.43319Z","caller":"traceutil/trace.go:171","msg":"trace[820924488] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"116.145375ms","start":"2026-02-10T14:56:02.316981Z","end":"2026-02-10T14:56:02.433126Z","steps":["trace[820924488] 'process raft request' (duration: 115.969874ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:02.60555Z","caller":"traceutil/trace.go:171","msg":"trace[590641459] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"288.464974ms","start":"2026-02-10T14:56:02.317064Z","end":"2026-02-10T14:56:02.605529Z","steps":["trace[590641459] 'process raft request' (duration: 196.439458ms)","trace[590641459] 'compare' (duration: 91.944605ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:23.849979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:23.44631Z","time spent":"403.665408ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-10T14:56:24.664292Z","caller":"traceutil/trace.go:171","msg":"trace[1210295469] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"133.596536ms","start":"2026-02-10T14:56:24.530678Z","end":"2026-02-10T14:56:24.664275Z","steps":["trace[1210295469] 'process raft request' (duration: 133.506562ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.520272Z","caller":"traceutil/trace.go:171","msg":"trace[23353321] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"158.893034ms","start":"2026-02-10T14:56:25.361361Z","end":"2026-02-10T14:56:25.520254Z","steps":["trace[23353321] 'process raft request' (duration: 154.622113ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.585961Z","caller":"traceutil/trace.go:171","msg":"trace[1292789562] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:575; }","duration":"191.995621ms","start":"2026-02-10T14:56:25.393951Z","end":"2026-02-10T14:56:25.585947Z","steps":["trace[1292789562] 'read index received' (duration: 122.126092ms)","trace[1292789562] 'applied index is now lower than readState.Index' (duration: 69.868939ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:25.586095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.132668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-10T14:56:25.586112Z","caller":"traceutil/trace.go:171","msg":"trace[2010916290] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:561; }","duration":"192.19655ms","start":"2026-02-10T14:56:25.393909Z","end":"2026-02-10T14:56:25.586106Z","steps":["trace[2010916290] 'agreement among raft nodes before linearized reading' (duration: 192.095256ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.586304Z","caller":"traceutil/trace.go:171","msg":"trace[1059882379] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"218.443142ms","start":"2026-02-10T14:56:25.367856Z","end":"2026-02-10T14:56:25.586299Z","steps":["trace[1059882379] 'process raft request' (duration: 217.94495ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.586361Z","caller":"traceutil/trace.go:171","msg":"trace[1491180378] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"218.032144ms","start":"2026-02-10T14:56:25.368325Z","end":"2026-02-10T14:56:25.586357Z","steps":["trace[1491180378] 'process raft request' (duration: 217.556522ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.586414Z","caller":"traceutil/trace.go:171","msg":"trace[1075257412] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"217.850226ms","start":"2026-02-10T14:56:25.36856Z","end":"2026-02-10T14:56:25.58641Z","steps":["trace[1075257412] 'process raft request' (duration: 217.342173ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.586502Z","caller":"traceutil/trace.go:171","msg":"trace[351688547] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"213.961722ms","start":"2026-02-10T14:56:25.372537Z","end":"2026-02-10T14:56:25.586498Z","steps":["trace[351688547] 'process raft request' (duration: 213.383776ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:25.723377Z","caller":"traceutil/trace.go:171","msg":"trace[594274668] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"198.102844ms","start":"2026-02-10T14:56:25.525253Z","end":"2026-02-10T14:56:25.723356Z","steps":["trace[594274668] 'process raft request' (duration: 142.735532ms)","trace[594274668] 'compare' (duration: 54.86813ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:31.408671Z","caller":"traceutil/trace.go:171","msg":"trace[1519912802] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"704.619378ms","start":"2026-02-10T14:56:30.704029Z","end":"2026-02-10T14:56:31.408648Z","steps":["trace[1519912802] 'process raft request' (duration: 704.486642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:31.408807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:30.704017Z","time spent":"704.717482ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:31.859732Z","caller":"traceutil/trace.go:171","msg":"trace[1929347750] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"879.200925ms","start":"2026-02-10T14:56:30.980516Z","end":"2026-02-10T14:56:31.859717Z","steps":["trace[1929347750] 'read index received' (duration: 428.027396ms)","trace[1929347750] 'applied index is now lower than readState.Index' (duration: 451.172849ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:31.859801Z","caller":"traceutil/trace.go:171","msg":"trace[1709426621] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.152682575s","start":"2026-02-10T14:56:30.707113Z","end":"2026-02-10T14:56:31.859796Z","steps":["trace[1709426621] 'process raft request' (duration: 1.071668755s)","trace[1709426621] 'compare' (duration: 80.880574ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:31.859875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:30.707106Z","time spent":"1.152708487s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:31.859872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.692986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q7bjm\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-10T14:56:31.859903Z","caller":"traceutil/trace.go:171","msg":"trace[1180216529] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q7bjm; range_end:; response_count:1; response_revision:578; }","duration":"717.747027ms","start":"2026-02-10T14:56:31.142148Z","end":"2026-02-10T14:56:31.859895Z","steps":["trace[1180216529] 'agreement among raft nodes before linearized reading' (duration: 717.681274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:31.859925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:31.142135Z","time spent":"717.784489ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-q7bjm\" "} {"level":"warn","ts":"2026-02-10T14:56:31.860068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.834261ms","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-10T14:56:31.860084Z","caller":"traceutil/trace.go:171","msg":"trace[2096301200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"717.854942ms","start":"2026-02-10T14:56:31.142223Z","end":"2026-02-10T14:56:31.860077Z","steps":["trace[2096301200] 'agreement among raft nodes before linearized reading' (duration: 717.797019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:31.860097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:31.142219Z","time spent":"717.875782ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:56:31.860173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.656334ms","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-10T14:56:31.860197Z","caller":"traceutil/trace.go:171","msg":"trace[521318226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"879.716186ms","start":"2026-02-10T14:56:30.980474Z","end":"2026-02-10T14:56:31.86019Z","steps":["trace[521318226] 'agreement among raft nodes before linearized reading' (duration: 879.653214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:31.861171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:30.980457Z","time spent":"880.679787ms","remote":"127.0.0.1:37774","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-10T14:56:32.921381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.726814ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:56:32.921469Z","caller":"traceutil/trace.go:171","msg":"trace[640441271] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.056867414s","start":"2026-02-10T14:56:31.864582Z","end":"2026-02-10T14:56:32.921449Z","steps":["trace[640441271] 'process raft request' (duration: 498.020556ms)","trace[640441271] 'compare' (duration: 558.294895ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:32.921515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:31.864568Z","time spent":"1.056929016s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:33.747665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.06971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:56:33.747776Z","caller":"traceutil/trace.go:171","msg":"trace[555983648] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:598; }","duration":"1.746286905s","start":"2026-02-10T14:56:32.001479Z","end":"2026-02-10T14:56:33.747766Z","steps":["trace[555983648] 'read index received' (duration: 361.075359ms)","trace[555983648] 'applied index is now lower than readState.Index' (duration: 1.385211076s)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:33.747897Z","caller":"traceutil/trace.go:171","msg":"trace[2036649313] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.882484891s","start":"2026-02-10T14:56:31.865405Z","end":"2026-02-10T14:56:33.74789Z","steps":["trace[2036649313] 'process raft request' (duration: 1.17512861s)","trace[2036649313] 'compare' (duration: 706.699835ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:33.747932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:31.865381Z","time spent":"1.882531893s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:33.748099Z","caller":"traceutil/trace.go:171","msg":"trace[685462017] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.870176089s","start":"2026-02-10T14:56:31.877917Z","end":"2026-02-10T14:56:33.748093Z","steps":["trace[685462017] 'process raft request' (duration: 1.869809824s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:33.748123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:31.877903Z","time spent":"1.87020674s","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:33.748182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.746706612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:56:33.748194Z","caller":"traceutil/trace.go:171","msg":"trace[1262731805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"1.746741534s","start":"2026-02-10T14:56:32.001448Z","end":"2026-02-10T14:56:33.74819Z","steps":["trace[1262731805] 'agreement among raft nodes before linearized reading' (duration: 1.746720733s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:33.748206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:32.001435Z","time spent":"1.746769125s","remote":"127.0.0.1:37504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T14:56:33.748308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.791629ms","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-10T14:56:33.74832Z","caller":"traceutil/trace.go:171","msg":"trace[747711849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"336.845022ms","start":"2026-02-10T14:56:33.411472Z","end":"2026-02-10T14:56:33.748317Z","steps":["trace[747711849] 'agreement among raft nodes before linearized reading' (duration: 336.79119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:33.748332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.411454Z","time spent":"336.875112ms","remote":"127.0.0.1:37774","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-10T14:56:33.748503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.494845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.233\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-10T14:56:33.748516Z","caller":"traceutil/trace.go:171","msg":"trace[2107715557] range","detail":"{range_begin:/registry/masterleases/199.204.45.233; range_end:; response_count:1; response_revision:581; }","duration":"302.531227ms","start":"2026-02-10T14:56:33.445981Z","end":"2026-02-10T14:56:33.748513Z","steps":["trace[2107715557] 'agreement among raft nodes before linearized reading' (duration: 302.492155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:33.748527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.445969Z","time spent":"302.556027ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.233\" "} {"level":"warn","ts":"2026-02-10T14:56:34.261647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067439,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:56:34.762604Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067439,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:56:35.037015Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.284607258s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T14:56:35.116871Z","caller":"traceutil/trace.go:171","msg":"trace[437243004] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:601; }","duration":"1.356045978s","start":"2026-02-10T14:56:33.760747Z","end":"2026-02-10T14:56:35.116793Z","steps":["trace[437243004] 'read index received' (duration: 1.276449497s)","trace[437243004] 'applied index is now lower than readState.Index' (duration: 79.524978ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:35.117454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.752337Z","time spent":"1.365108926s","remote":"127.0.0.1:37536","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T14:56:35.118913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.358146722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:56:35.119009Z","caller":"traceutil/trace.go:171","msg":"trace[978826978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"1.358275037s","start":"2026-02-10T14:56:33.760722Z","end":"2026-02-10T14:56:35.118998Z","steps":["trace[978826978] 'agreement among raft nodes before linearized reading' (duration: 1.358019427s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:35.119118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.760711Z","time spent":"1.358386391s","remote":"127.0.0.1:37504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-10T14:56:35.120302Z","caller":"traceutil/trace.go:171","msg":"trace[56811909] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.35888897s","start":"2026-02-10T14:56:33.761404Z","end":"2026-02-10T14:56:35.120293Z","steps":["trace[56811909] 'process raft request' (duration: 1.355172733s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:35.120411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.761396Z","time spent":"1.358933103s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:35.120512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249488834s","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-10T14:56:35.120576Z","caller":"traceutil/trace.go:171","msg":"trace[378446868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.249583768s","start":"2026-02-10T14:56:33.870976Z","end":"2026-02-10T14:56:35.12056Z","steps":["trace[378446868] 'agreement among raft nodes before linearized reading' (duration: 1.248447693s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:35.121226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.427989ms","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-10T14:56:35.121279Z","caller":"traceutil/trace.go:171","msg":"trace[230934988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"196.514602ms","start":"2026-02-10T14:56:34.924753Z","end":"2026-02-10T14:56:35.121268Z","steps":["trace[230934988] 'agreement among raft nodes before linearized reading' (duration: 196.431459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:35.120613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:33.870963Z","time spent":"1.249643s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-10T14:56:46.016964Z","caller":"traceutil/trace.go:171","msg":"trace[1867253908] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"426.072428ms","start":"2026-02-10T14:56:45.59071Z","end":"2026-02-10T14:56:46.016782Z","steps":["trace[1867253908] 'process raft request' (duration: 425.889142ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:46.017058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:45.590694Z","time spent":"426.317397ms","remote":"127.0.0.1:51508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:56:46.024394Z","caller":"traceutil/trace.go:171","msg":"trace[1925826762] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:729; }","duration":"218.983921ms","start":"2026-02-10T14:56:45.805391Z","end":"2026-02-10T14:56:46.024375Z","steps":["trace[1925826762] 'read index received' (duration: 211.345323ms)","trace[1925826762] 'applied index is now lower than readState.Index' (duration: 7.637638ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:46.024563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.151587ms","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-10T14:56:46.024585Z","caller":"traceutil/trace.go:171","msg":"trace[1995200440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:708; }","duration":"219.216369ms","start":"2026-02-10T14:56:45.805362Z","end":"2026-02-10T14:56:46.024578Z","steps":["trace[1995200440] 'agreement among raft nodes before linearized reading' (duration: 219.086034ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:46.024867Z","caller":"traceutil/trace.go:171","msg":"trace[1535921241] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"414.613079ms","start":"2026-02-10T14:56:45.610241Z","end":"2026-02-10T14:56:46.024854Z","steps":["trace[1535921241] 'process raft request' (duration: 414.08545ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:46.024902Z","caller":"traceutil/trace.go:171","msg":"trace[1240396171] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"398.273718ms","start":"2026-02-10T14:56:45.626619Z","end":"2026-02-10T14:56:46.024893Z","steps":["trace[1240396171] 'process raft request' (duration: 397.733789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:46.024948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:45.610229Z","time spent":"414.691701ms","remote":"127.0.0.1:51532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1669,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-10T14:56:46.024969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:45.626603Z","time spent":"398.32193ms","remote":"127.0.0.1:51508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:56:46.025122Z","caller":"traceutil/trace.go:171","msg":"trace[1870268936] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"418.562849ms","start":"2026-02-10T14:56:45.60655Z","end":"2026-02-10T14:56:46.025113Z","steps":["trace[1870268936] 'process raft request' (duration: 417.684408ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:46.025178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:45.60653Z","time spent":"418.60698ms","remote":"127.0.0.1:51508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2262,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-10T14:56:48.778702Z","caller":"traceutil/trace.go:171","msg":"trace[1673748110] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"307.376978ms","start":"2026-02-10T14:56:48.471304Z","end":"2026-02-10T14:56:48.77868Z","steps":["trace[1673748110] 'process raft request' (duration: 307.314605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:48.778961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.4713Z","time spent":"307.469751ms","remote":"127.0.0.1:38022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:48.779093Z","caller":"traceutil/trace.go:171","msg":"trace[1280583889] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"307.841103ms","start":"2026-02-10T14:56:48.471232Z","end":"2026-02-10T14:56:48.779073Z","steps":["trace[1280583889] 'process raft request' (duration: 305.491632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:48.779306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.471226Z","time spent":"307.912416ms","remote":"127.0.0.1:37684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:48.787447Z","caller":"traceutil/trace.go:171","msg":"trace[935551702] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"310.34294ms","start":"2026-02-10T14:56:48.47709Z","end":"2026-02-10T14:56:48.787433Z","steps":["trace[935551702] 'process raft request' (duration: 310.084871ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:48.787692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.477083Z","time spent":"310.451653ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4797,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:49.296346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:56:49.458078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.648891ms","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-10T14:56:49.458583Z","caller":"traceutil/trace.go:171","msg":"trace[1919694296] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:740; }","duration":"422.161568ms","start":"2026-02-10T14:56:49.036403Z","end":"2026-02-10T14:56:49.458564Z","steps":["trace[1919694296] 'range keys from in-memory index tree' (duration: 421.63736ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:49.459539Z","caller":"traceutil/trace.go:171","msg":"trace[505093389] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"672.845135ms","start":"2026-02-10T14:56:48.786682Z","end":"2026-02-10T14:56:49.459527Z","steps":["trace[505093389] 'process raft request' (duration: 667.590356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:49.460376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.786666Z","time spent":"673.639592ms","remote":"127.0.0.1:38022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:49.46754Z","caller":"traceutil/trace.go:171","msg":"trace[2010530451] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:766; }","duration":"671.61213ms","start":"2026-02-10T14:56:48.795913Z","end":"2026-02-10T14:56:49.467525Z","steps":["trace[2010530451] 'read index received' (duration: 658.777544ms)","trace[2010530451] 'applied index is now lower than readState.Index' (duration: 12.833886ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:56:49.469054Z","caller":"traceutil/trace.go:171","msg":"trace[1077881938] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"674.391625ms","start":"2026-02-10T14:56:48.794633Z","end":"2026-02-10T14:56:49.469024Z","steps":["trace[1077881938] 'process raft request' (duration: 670.490002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:49.469253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.794615Z","time spent":"674.595532ms","remote":"127.0.0.1:37684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1017,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:49.472248Z","caller":"traceutil/trace.go:171","msg":"trace[1596595631] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"676.425183ms","start":"2026-02-10T14:56:48.795814Z","end":"2026-02-10T14:56:49.472239Z","steps":["trace[1596595631] 'process raft request' (duration: 671.647961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:49.472361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.795808Z","time spent":"676.529218ms","remote":"127.0.0.1:37782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1612,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:56:49.472482Z","caller":"traceutil/trace.go:171","msg":"trace[1436967932] transaction","detail":"{read_only:false; number_of_response:1; response_revision:743; }","duration":"674.929382ms","start":"2026-02-10T14:56:48.797547Z","end":"2026-02-10T14:56:49.472476Z","steps":["trace[1436967932] 'process raft request' (duration: 669.949163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:49.472573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.797542Z","time spent":"675.013235ms","remote":"127.0.0.1:38022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":56,"response count":0,"response size":3831,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:56:49.472757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.842338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-xgpt4\" ","response":"range_response_count:1 size:5023"} {"level":"info","ts":"2026-02-10T14:56:49.472821Z","caller":"traceutil/trace.go:171","msg":"trace[1151359101] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-xgpt4; range_end:; response_count:1; response_revision:743; }","duration":"676.919521ms","start":"2026-02-10T14:56:48.795896Z","end":"2026-02-10T14:56:49.472815Z","steps":["trace[1151359101] 'agreement among raft nodes before linearized reading' (duration: 676.808487ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:56:49.472881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:48.795891Z","time spent":"676.983433ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5046,"request content":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-xgpt4\" "} {"level":"info","ts":"2026-02-10T14:56:52.231862Z","caller":"traceutil/trace.go:171","msg":"trace[300483274] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"113.693806ms","start":"2026-02-10T14:56:52.118147Z","end":"2026-02-10T14:56:52.23184Z","steps":["trace[300483274] 'process raft request' (duration: 113.545061ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:56:55.095629Z","caller":"traceutil/trace.go:171","msg":"trace[1670904703] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:802; }","duration":"1.184875658s","start":"2026-02-10T14:56:53.910734Z","end":"2026-02-10T14:56:55.09561Z","steps":["trace[1670904703] 'read index received' (duration: 1.184871698s)","trace[1670904703] 'applied index is now lower than readState.Index' (duration: 3.29µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:55.115757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204397921s","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-10T14:56:55.115829Z","caller":"traceutil/trace.go:171","msg":"trace[1076600246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:773; }","duration":"1.204476454s","start":"2026-02-10T14:56:53.911317Z","end":"2026-02-10T14:56:55.115793Z","steps":["trace[1076600246] 'agreement among raft nodes before linearized reading' (duration: 1.184383692s)","trace[1076600246] 'range keys from in-memory index tree' (duration: 19.955598ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:55.115854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:53.910785Z","time spent":"1.205063324s","remote":"127.0.0.1:37774","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-10T14:56:55.115998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205267289s","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-10T14:56:55.116013Z","caller":"traceutil/trace.go:171","msg":"trace[285989124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"1.205322992s","start":"2026-02-10T14:56:53.910684Z","end":"2026-02-10T14:56:55.116008Z","steps":["trace[285989124] 'agreement among raft nodes before linearized reading' (duration: 1.185026133s)","trace[285989124] 'range keys from in-memory index tree' (duration: 20.258988ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:56:55.116025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:56:53.910231Z","time spent":"1.205790527s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-10T14:56:57.614037Z","caller":"traceutil/trace.go:171","msg":"trace[1299912372] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"160.487989ms","start":"2026-02-10T14:56:57.453526Z","end":"2026-02-10T14:56:57.614014Z","steps":["trace[1299912372] 'process raft request' (duration: 160.20214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:05.690728Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067927,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:06.675297Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.4873857s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T14:57:06.675529Z","caller":"traceutil/trace.go:171","msg":"trace[937845317] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"1.485200657s","start":"2026-02-10T14:57:05.190296Z","end":"2026-02-10T14:57:06.675497Z","steps":["trace[937845317] 'read index received' (duration: 1.485074283s)","trace[937845317] 'applied index is now lower than readState.Index' (duration: 125.734µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:06.675684Z","caller":"traceutil/trace.go:171","msg":"trace[1449547068] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"1.487818842s","start":"2026-02-10T14:57:05.187842Z","end":"2026-02-10T14:57:06.675661Z","steps":["trace[1449547068] 'process raft request' (duration: 1.487560575s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.675991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.18783Z","time spent":"1.487871543s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:06.676661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.482539659s","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-10T14:57:06.676715Z","caller":"traceutil/trace.go:171","msg":"trace[1788667061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:814; }","duration":"1.482611521s","start":"2026-02-10T14:57:05.194087Z","end":"2026-02-10T14:57:06.676698Z","steps":["trace[1788667061] 'agreement among raft nodes before linearized reading' (duration: 1.482458767s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.676746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.19408Z","time spent":"1.482660643s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T14:57:06.67669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4863863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-10T14:57:06.676888Z","caller":"traceutil/trace.go:171","msg":"trace[1030859998] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:814; }","duration":"1.486601566s","start":"2026-02-10T14:57:05.190279Z","end":"2026-02-10T14:57:06.676881Z","steps":["trace[1030859998] 'agreement among raft nodes before linearized reading' (duration: 1.486167694s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.676901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.475292311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-10T14:57:06.67691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.190272Z","time spent":"1.486631937s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-10T14:57:06.676919Z","caller":"traceutil/trace.go:171","msg":"trace[1321131341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:814; }","duration":"1.475319831s","start":"2026-02-10T14:57:05.201593Z","end":"2026-02-10T14:57:06.676913Z","steps":["trace[1321131341] 'agreement among raft nodes before linearized reading' (duration: 1.475264539s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.676938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.201587Z","time spent":"1.475346032s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:06.677042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4777015s","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-10T14:57:06.677058Z","caller":"traceutil/trace.go:171","msg":"trace[1727808673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"1.47772667s","start":"2026-02-10T14:57:05.199326Z","end":"2026-02-10T14:57:06.677053Z","steps":["trace[1727808673] 'agreement among raft nodes before linearized reading' (duration: 1.477674889s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:06.677073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:05.199321Z","time spent":"1.47774833s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:07.190857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:07.691713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:08.192335Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:08.75005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.047515019s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-10T14:57:08.750101Z","caller":"traceutil/trace.go:171","msg":"trace[393669932] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.047596771s","start":"2026-02-10T14:57:06.702493Z","end":"2026-02-10T14:57:08.75009Z","steps":["trace[393669932] 'agreement among raft nodes before linearized reading' (duration: 2.047534219s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:08.750142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.702483Z","time spent":"2.047652912s","remote":"127.0.0.1:37504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/10 14:57:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-10T14:57:08.750289Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:09.250378Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:09.75049Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:10.251378Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581740029190067931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:10.408251Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.718086239s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-10T14:57:10.409697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374004501s","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-10T14:57:10.409767Z","caller":"traceutil/trace.go:171","msg":"trace[1542146427] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:814; }","duration":"1.374080523s","start":"2026-02-10T14:57:09.035675Z","end":"2026-02-10T14:57:10.409756Z","steps":["trace[1542146427] 'range keys from in-memory index tree' (duration: 1.373994291s)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:10.411485Z","caller":"traceutil/trace.go:171","msg":"trace[790508099] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"3.708826811s","start":"2026-02-10T14:57:06.702641Z","end":"2026-02-10T14:57:10.411468Z","steps":["trace[790508099] 'process raft request' (duration: 3.707619488s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.411589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.702633Z","time spent":"3.708890792s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:10.411644Z","caller":"traceutil/trace.go:171","msg":"trace[1118509058] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"3.708940694s","start":"2026-02-10T14:57:06.702696Z","end":"2026-02-10T14:57:10.411636Z","steps":["trace[1118509058] 'process raft request' (duration: 3.707588467s)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:10.411693Z","caller":"traceutil/trace.go:171","msg":"trace[977475969] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"3.721596985s","start":"2026-02-10T14:57:06.690091Z","end":"2026-02-10T14:57:10.411688Z","steps":["trace[977475969] 'process raft request' (duration: 3.71959608s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.41171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.702692Z","time spent":"3.708971745s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:10.411721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.690072Z","time spent":"3.721632925s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:10.411867Z","caller":"traceutil/trace.go:171","msg":"trace[110479434] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"3.69756132s","start":"2026-02-10T14:57:06.714301Z","end":"2026-02-10T14:57:10.411863Z","steps":["trace[110479434] 'process raft request' (duration: 3.697279362s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.411896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.714285Z","time spent":"3.69759706s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:10.412063Z","caller":"traceutil/trace.go:171","msg":"trace[2093034796] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"3.69546321s","start":"2026-02-10T14:57:06.716592Z","end":"2026-02-10T14:57:10.412055Z","steps":["trace[2093034796] 'process raft request' (duration: 3.695247804s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.412087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.716582Z","time spent":"3.695491681s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:10.412157Z","caller":"traceutil/trace.go:171","msg":"trace[1305324307] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"2.542290601s","start":"2026-02-10T14:57:07.869862Z","end":"2026-02-10T14:57:10.412153Z","steps":["trace[1305324307] 'process raft request' (duration: 2.542130656s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.41218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:07.869843Z","time spent":"2.542324122s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T14:57:10.415402Z","caller":"traceutil/trace.go:171","msg":"trace[1831888689] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:846; }","duration":"3.724869724s","start":"2026-02-10T14:57:06.690525Z","end":"2026-02-10T14:57:10.415394Z","steps":["trace[1831888689] 'read index received' (duration: 3.719061274s)","trace[1831888689] 'applied index is now lower than readState.Index' (duration: 5.80787ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:10.415633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.72508423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T14:57:10.415663Z","caller":"traceutil/trace.go:171","msg":"trace[481461670] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:820; }","duration":"3.725147372s","start":"2026-02-10T14:57:06.690504Z","end":"2026-02-10T14:57:10.415651Z","steps":["trace[481461670] 'agreement among raft nodes before linearized reading' (duration: 3.72508483s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.415809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:06.690496Z","time spent":"3.725304796s","remote":"127.0.0.1:37956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-10T14:57:10.415969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.1749423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:10.415999Z","caller":"traceutil/trace.go:171","msg":"trace[740134738] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:820; }","duration":"3.174997122s","start":"2026-02-10T14:57:07.240997Z","end":"2026-02-10T14:57:10.415994Z","steps":["trace[740134738] 'agreement among raft nodes before linearized reading' (duration: 3.174951981s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.416429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:07.240972Z","time spent":"3.175447815s","remote":"127.0.0.1:37666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-10T14:57:10.416639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.666357311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:10.416659Z","caller":"traceutil/trace.go:171","msg":"trace[512062710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"1.666386362s","start":"2026-02-10T14:57:08.750268Z","end":"2026-02-10T14:57:10.416654Z","steps":["trace[512062710] 'agreement among raft nodes before linearized reading' (duration: 1.666348221s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.416736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.750264Z","time spent":"1.666405952s","remote":"127.0.0.1:37516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T14:57:10.416913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.66668269s","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-10T14:57:10.417831Z","caller":"traceutil/trace.go:171","msg":"trace[393919653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:820; }","duration":"1.667617936s","start":"2026-02-10T14:57:08.750204Z","end":"2026-02-10T14:57:10.417822Z","steps":["trace[393919653] 'agreement among raft nodes before linearized reading' (duration: 1.666622298s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:10.418129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:08.750194Z","time spent":"1.667925854s","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T14:58:09.193845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.612449ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-10T14:58:09.194046Z","caller":"traceutil/trace.go:171","msg":"trace[1043099478] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"359.208438ms","start":"2026-02-10T14:58:08.834823Z","end":"2026-02-10T14:58:09.194031Z","steps":["trace[1043099478] 'read index received' (duration: 25.388655ms)","trace[1043099478] 'applied index is now lower than readState.Index' (duration: 333.818583ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:09.193846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.444941ms","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-10T14:58:09.194283Z","caller":"traceutil/trace.go:171","msg":"trace[834540045] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1018; }","duration":"158.89704ms","start":"2026-02-10T14:58:09.035366Z","end":"2026-02-10T14:58:09.194263Z","steps":["trace[834540045] 'range keys from in-memory index tree' (duration: 158.421901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.194538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.713487ms","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-10T14:58:09.194596Z","caller":"traceutil/trace.go:171","msg":"trace[489215090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1018; }","duration":"359.84482ms","start":"2026-02-10T14:58:08.834743Z","end":"2026-02-10T14:58:09.194588Z","steps":["trace[489215090] 'agreement among raft nodes before linearized reading' (duration: 359.648296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.194614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.784776ms","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-10T14:58:09.194656Z","caller":"traceutil/trace.go:171","msg":"trace[80486274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1018; }","duration":"356.853697ms","start":"2026-02-10T14:58:08.837791Z","end":"2026-02-10T14:58:09.194645Z","steps":["trace[80486274] 'agreement among raft nodes before linearized reading' (duration: 356.702834ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.194637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:08.834725Z","time spent":"359.90421ms","remote":"127.0.0.1:37774","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-10T14:58:09.19474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.315087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:09.194772Z","caller":"traceutil/trace.go:171","msg":"trace[1813128984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1018; }","duration":"190.373898ms","start":"2026-02-10T14:58:09.004391Z","end":"2026-02-10T14:58:09.194765Z","steps":["trace[1813128984] 'agreement among raft nodes before linearized reading' (duration: 190.317647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.194689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:08.837742Z","time spent":"356.939898ms","remote":"127.0.0.1:37774","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-10T14:58:09.194993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.740527ms","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-10T14:58:09.195027Z","caller":"traceutil/trace.go:171","msg":"trace[1357660325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1018; }","duration":"250.806957ms","start":"2026-02-10T14:58:08.944212Z","end":"2026-02-10T14:58:09.195019Z","steps":["trace[1357660325] 'agreement among raft nodes before linearized reading' (duration: 250.722546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.195136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.709566ms","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-10T14:58:09.195165Z","caller":"traceutil/trace.go:171","msg":"trace[1262953110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1018; }","duration":"266.774248ms","start":"2026-02-10T14:58:08.928384Z","end":"2026-02-10T14:58:09.195158Z","steps":["trace[1262953110] 'agreement among raft nodes before linearized reading' (duration: 266.701036ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:09.42393Z","caller":"traceutil/trace.go:171","msg":"trace[1977206397] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"223.129279ms","start":"2026-02-10T14:58:09.200776Z","end":"2026-02-10T14:58:09.423905Z","steps":["trace[1977206397] 'process raft request' (duration: 222.957856ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:09.426702Z","caller":"traceutil/trace.go:171","msg":"trace[262164136] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1065; }","duration":"112.547802ms","start":"2026-02-10T14:58:09.314136Z","end":"2026-02-10T14:58:09.426684Z","steps":["trace[262164136] 'read index received' (duration: 109.835595ms)","trace[262164136] 'applied index is now lower than readState.Index' (duration: 2.711437ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:58:09.426729Z","caller":"traceutil/trace.go:171","msg":"trace[1773567058] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"225.666984ms","start":"2026-02-10T14:58:09.201041Z","end":"2026-02-10T14:58:09.426708Z","steps":["trace[1773567058] 'process raft request' (duration: 225.46007ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:09.427062Z","caller":"traceutil/trace.go:171","msg":"trace[1222481473] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"225.954309ms","start":"2026-02-10T14:58:09.201093Z","end":"2026-02-10T14:58:09.427047Z","steps":["trace[1222481473] 'process raft request' (duration: 225.515491ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:09.4272Z","caller":"traceutil/trace.go:171","msg":"trace[728657268] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"223.224311ms","start":"2026-02-10T14:58:09.203963Z","end":"2026-02-10T14:58:09.427187Z","steps":["trace[728657268] 'process raft request' (duration: 222.680412ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:09.427413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.250745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:58:09.427464Z","caller":"traceutil/trace.go:171","msg":"trace[563795449] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1022; }","duration":"113.355886ms","start":"2026-02-10T14:58:09.314092Z","end":"2026-02-10T14:58:09.427448Z","steps":["trace[563795449] 'agreement among raft nodes before linearized reading' (duration: 113.236994ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:58:25.273664Z","caller":"traceutil/trace.go:171","msg":"trace[669870498] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"430.969804ms","start":"2026-02-10T14:58:24.842686Z","end":"2026-02-10T14:58:25.273656Z","steps":["trace[669870498] 'process raft request' (duration: 429.925238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:25.274658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:24.842678Z","time spent":"431.055156ms","remote":"127.0.0.1:37774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:58:25.275451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.115176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-10T14:58:25.275476Z","caller":"traceutil/trace.go:171","msg":"trace[715914311] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:1068; }","duration":"421.158327ms","start":"2026-02-10T14:58:24.854312Z","end":"2026-02-10T14:58:25.27547Z","steps":["trace[715914311] 'agreement among raft nodes before linearized reading' (duration: 421.111416ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:25.275558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:24.854303Z","time spent":"421.249969ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-public\" "} {"level":"info","ts":"2026-02-10T14:58:25.273527Z","caller":"traceutil/trace.go:171","msg":"trace[2131449693] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"419.177735ms","start":"2026-02-10T14:58:24.854333Z","end":"2026-02-10T14:58:25.27351Z","steps":["trace[2131449693] 'read index received' (duration: 418.22436ms)","trace[2131449693] 'applied index is now lower than readState.Index' (duration: 952.355µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:58:25.276284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.810656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:1 size:363"} {"level":"info","ts":"2026-02-10T14:58:25.276306Z","caller":"traceutil/trace.go:171","msg":"trace[966287074] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:1; response_revision:1068; }","duration":"409.846886ms","start":"2026-02-10T14:58:24.866451Z","end":"2026-02-10T14:58:25.276298Z","steps":["trace[966287074] 'agreement among raft nodes before linearized reading' (duration: 409.806476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:58:25.276325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:58:24.866429Z","time spent":"409.890047ms","remote":"127.0.0.1:37614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":386,"request content":"key:\"/registry/namespaces/kube-node-lease\" "}