{"level":"warn","ts":"2026-08-05T21:34:43.816183Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-05T21:34:43.816258Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.175: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.19.213.175:2380","--initial-cluster=instance=https://199.19.213.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.175: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-08-05T21:34:43.816311Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-05T21:34:43.816322Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-08-05T21:34:43.816337Z","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-08-05T21:34:43.816979Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"]} {"level":"info","ts":"2026-08-05T21:34:43.817097Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.175: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-08-05T21:34:43.845604Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"28.271258ms"} {"level":"info","ts":"2026-08-05T21:34:43.935809Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"223c7693b78843e1","cluster-id":"b697af90308fdc01"} {"level":"info","ts":"2026-08-05T21:34:43.935956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=()"} {"level":"info","ts":"2026-08-05T21:34:43.935995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 0"} {"level":"info","ts":"2026-08-05T21:34:43.936252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 223c7693b78843e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-05T21:34:43.936491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 1"} {"level":"info","ts":"2026-08-05T21:34:43.936575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"warn","ts":"2026-08-05T21:34:43.998569Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-05T21:34:44.049459Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-05T21:34:44.053666Z","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-08-05T21:34:44.094826Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"223c7693b78843e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-05T21:34:44.095389Z","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-08-05T21:34:44.095608Z","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-08-05T21:34:44.095743Z","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-08-05T21:34:44.095572Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"223c7693b78843e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-05T21:34:44.099663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"info","ts":"2026-08-05T21:34:44.09985Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","added-peer-id":"223c7693b78843e1","added-peer-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-08-05T21:34:44.102001Z","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-08-05T21:34:44.102372Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"223c7693b78843e1","initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-05T21:34:44.102422Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-05T21:34:44.102524Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-08-05T21:34:44.102549Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-08-05T21:34:44.337358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 is starting a new election at term 1"} {"level":"info","ts":"2026-08-05T21:34:44.337482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-05T21:34:44.337501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgPreVoteResp from 223c7693b78843e1 at term 1"} {"level":"info","ts":"2026-08-05T21:34:44.337518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became candidate at term 2"} {"level":"info","ts":"2026-08-05T21:34:44.337526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgVoteResp from 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-08-05T21:34:44.337537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became leader at term 2"} {"level":"info","ts":"2026-08-05T21:34:44.337547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 223c7693b78843e1 elected leader 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-08-05T21:34:44.367383Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:34:44.413702Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:34:44.4137Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"223c7693b78843e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.175:2379]}","request-path":"/0/members/223c7693b78843e1/attributes","cluster-id":"b697af90308fdc01","publish-timeout":"7s"} {"level":"info","ts":"2026-08-05T21:34:44.414188Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-05T21:34:44.414259Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-05T21:34:44.413762Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:34:44.417254Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.175:2379"} {"level":"info","ts":"2026-08-05T21:34:44.419029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-05T21:34:44.465698Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:34:44.465863Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:34:44.465907Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:34:45.958613Z","caller":"traceutil/trace.go:171","msg":"trace[564471082] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"138.934685ms","start":"2026-08-05T21:34:45.819649Z","end":"2026-08-05T21:34:45.958583Z","steps":["trace[564471082] 'process raft request' (duration: 138.781469ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.958747Z","caller":"traceutil/trace.go:171","msg":"trace[1017778159] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"139.016668ms","start":"2026-08-05T21:34:45.819718Z","end":"2026-08-05T21:34:45.958735Z","steps":["trace[1017778159] 'process raft request' (duration: 138.737957ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.95874Z","caller":"traceutil/trace.go:171","msg":"trace[2077153978] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"138.425396ms","start":"2026-08-05T21:34:45.820215Z","end":"2026-08-05T21:34:45.95864Z","steps":["trace[2077153978] 'process raft request' (duration: 138.288131ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.958849Z","caller":"traceutil/trace.go:171","msg":"trace[784183275] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"138.902084ms","start":"2026-08-05T21:34:45.819919Z","end":"2026-08-05T21:34:45.958821Z","steps":["trace[784183275] 'process raft request' (duration: 138.561161ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.958614Z","caller":"traceutil/trace.go:171","msg":"trace[1003640866] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"206.227321ms","start":"2026-08-05T21:34:45.752334Z","end":"2026-08-05T21:34:45.958561Z","steps":["trace[1003640866] 'process raft request' (duration: 173.648403ms)","trace[1003640866] 'compare' (duration: 32.284277ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:45.958958Z","caller":"traceutil/trace.go:171","msg":"trace[907668146] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"140.044966ms","start":"2026-08-05T21:34:45.818874Z","end":"2026-08-05T21:34:45.958919Z","steps":["trace[907668146] 'process raft request' (duration: 139.519847ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.958972Z","caller":"traceutil/trace.go:171","msg":"trace[1673199103] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"138.635654ms","start":"2026-08-05T21:34:45.820299Z","end":"2026-08-05T21:34:45.958934Z","steps":["trace[1673199103] 'process raft request' (duration: 138.228809ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:45.959143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.037236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:45.959214Z","caller":"traceutil/trace.go:171","msg":"trace[2067053331] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"126.102525ms","start":"2026-08-05T21:34:45.832511Z","end":"2026-08-05T21:34:45.958613Z","steps":["trace[2067053331] 'read index received' (duration: 93.556998ms)","trace[2067053331] 'applied index is now lower than readState.Index' (duration: 32.544367ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:45.959224Z","caller":"traceutil/trace.go:171","msg":"trace[1003466926] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"140.574985ms","start":"2026-08-05T21:34:45.818637Z","end":"2026-08-05T21:34:45.959212Z","steps":["trace[1003466926] 'agreement among raft nodes before linearized reading' (duration: 140.317596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:45.959136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.455814ms","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-08-05T21:34:45.959375Z","caller":"traceutil/trace.go:171","msg":"trace[922768830] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"139.769626ms","start":"2026-08-05T21:34:45.819585Z","end":"2026-08-05T21:34:45.959355Z","steps":["trace[922768830] 'agreement among raft nodes before linearized reading' (duration: 139.33693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:45.959312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.500298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.175\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:45.959473Z","caller":"traceutil/trace.go:171","msg":"trace[1662487345] range","detail":"{range_begin:/registry/masterleases/199.19.213.175; range_end:; response_count:0; response_revision:9; }","duration":"142.717656ms","start":"2026-08-05T21:34:45.816741Z","end":"2026-08-05T21:34:45.959458Z","steps":["trace[1662487345] 'agreement among raft nodes before linearized reading' (duration: 142.512519ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:45.964324Z","caller":"traceutil/trace.go:171","msg":"trace[2134515691] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"116.987814ms","start":"2026-08-05T21:34:45.847295Z","end":"2026-08-05T21:34:45.964283Z","steps":["trace[2134515691] 'process raft request' (duration: 116.801497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:45.964591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.038373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:45.964712Z","caller":"traceutil/trace.go:171","msg":"trace[785888516] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"118.186498ms","start":"2026-08-05T21:34:45.846501Z","end":"2026-08-05T21:34:45.964687Z","steps":["trace[785888516] 'agreement among raft nodes before linearized reading' (duration: 117.811684ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.212999Z","caller":"traceutil/trace.go:171","msg":"trace[163815170] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:13; }","duration":"248.770931ms","start":"2026-08-05T21:34:45.964196Z","end":"2026-08-05T21:34:46.212967Z","steps":["trace[163815170] 'read index received' (duration: 165.737974ms)","trace[163815170] 'applied index is now lower than readState.Index' (duration: 83.032017ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:46.213024Z","caller":"traceutil/trace.go:171","msg":"trace[821446997] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"249.439008ms","start":"2026-08-05T21:34:45.96356Z","end":"2026-08-05T21:34:46.213Z","steps":["trace[821446997] 'process raft request' (duration: 249.348724ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.21307Z","caller":"traceutil/trace.go:171","msg":"trace[1326992815] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"251.208823ms","start":"2026-08-05T21:34:45.961849Z","end":"2026-08-05T21:34:46.213058Z","steps":["trace[1326992815] 'process raft request' (duration: 168.084412ms)","trace[1326992815] 'compare' (duration: 82.740947ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:46.2131Z","caller":"traceutil/trace.go:171","msg":"trace[173710386] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"249.130345ms","start":"2026-08-05T21:34:45.963963Z","end":"2026-08-05T21:34:46.213093Z","steps":["trace[173710386] 'process raft request' (duration: 248.962739ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.21333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.881962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:46.213409Z","caller":"traceutil/trace.go:171","msg":"trace[2077817049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14; }","duration":"250.997356ms","start":"2026-08-05T21:34:45.96239Z","end":"2026-08-05T21:34:46.213387Z","steps":["trace[2077817049] 'agreement among raft nodes before linearized reading' (duration: 250.815429ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.213006Z","caller":"traceutil/trace.go:171","msg":"trace[2136292740] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"250.419634ms","start":"2026-08-05T21:34:45.962553Z","end":"2026-08-05T21:34:46.212973Z","steps":["trace[2136292740] 'process raft request' (duration: 250.276338ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.213367Z","caller":"traceutil/trace.go:171","msg":"trace[1444226757] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"249.732459ms","start":"2026-08-05T21:34:45.963552Z","end":"2026-08-05T21:34:46.213284Z","steps":["trace[1444226757] 'process raft request' (duration: 249.329023ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.239703Z","caller":"traceutil/trace.go:171","msg":"trace[1708953558] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"274.832342ms","start":"2026-08-05T21:34:45.964853Z","end":"2026-08-05T21:34:46.239686Z","steps":["trace[1708953558] 'process raft request' (duration: 274.605063ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.239782Z","caller":"traceutil/trace.go:171","msg":"trace[483093931] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"274.863352ms","start":"2026-08-05T21:34:45.964897Z","end":"2026-08-05T21:34:46.239761Z","steps":["trace[483093931] 'process raft request' (duration: 274.728357ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.239912Z","caller":"traceutil/trace.go:171","msg":"trace[300669609] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"274.990637ms","start":"2026-08-05T21:34:45.964895Z","end":"2026-08-05T21:34:46.239886Z","steps":["trace[300669609] 'process raft request' (duration: 274.80243ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.240085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.350549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-05T21:34:46.240137Z","caller":"traceutil/trace.go:171","msg":"trace[959411382] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"198.408331ms","start":"2026-08-05T21:34:46.041707Z","end":"2026-08-05T21:34:46.240116Z","steps":["trace[959411382] 'agreement among raft nodes before linearized reading' (duration: 198.226274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.240218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.409223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-05T21:34:46.240381Z","caller":"traceutil/trace.go:171","msg":"trace[1575972706] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"215.571689ms","start":"2026-08-05T21:34:46.024746Z","end":"2026-08-05T21:34:46.240318Z","steps":["trace[1575972706] 'agreement among raft nodes before linearized reading' (duration: 215.266248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.240457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.564436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-08-05T21:34:46.241233Z","caller":"traceutil/trace.go:171","msg":"trace[1202081323] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"273.374007ms","start":"2026-08-05T21:34:45.967843Z","end":"2026-08-05T21:34:46.241217Z","steps":["trace[1202081323] 'agreement among raft nodes before linearized reading' (duration: 272.559716ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.240762Z","caller":"traceutil/trace.go:171","msg":"trace[1619681229] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"267.822789ms","start":"2026-08-05T21:34:45.972271Z","end":"2026-08-05T21:34:46.240094Z","steps":["trace[1619681229] 'process raft request' (duration: 267.468346ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.423861Z","caller":"traceutil/trace.go:171","msg":"trace[1584879035] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"181.281144ms","start":"2026-08-05T21:34:46.242525Z","end":"2026-08-05T21:34:46.423806Z","steps":["trace[1584879035] 'process raft request' (duration: 123.826577ms)","trace[1584879035] 'compare' (duration: 57.177957ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:46.423967Z","caller":"traceutil/trace.go:171","msg":"trace[68830775] linearizableReadLoop","detail":"{readStateIndex:31; appliedIndex:25; }","duration":"137.763404ms","start":"2026-08-05T21:34:46.286179Z","end":"2026-08-05T21:34:46.423943Z","steps":["trace[68830775] 'read index received' (duration: 80.109879ms)","trace[68830775] 'applied index is now lower than readState.Index' (duration: 57.652695ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:46.42408Z","caller":"traceutil/trace.go:171","msg":"trace[1624239761] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"178.149568ms","start":"2026-08-05T21:34:46.245916Z","end":"2026-08-05T21:34:46.424066Z","steps":["trace[1624239761] 'process raft request' (duration: 177.904069ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.424063Z","caller":"traceutil/trace.go:171","msg":"trace[1490247969] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"178.110146ms","start":"2026-08-05T21:34:46.245916Z","end":"2026-08-05T21:34:46.424026Z","steps":["trace[1490247969] 'process raft request' (duration: 177.853527ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.42419Z","caller":"traceutil/trace.go:171","msg":"trace[382309569] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"179.298009ms","start":"2026-08-05T21:34:46.244868Z","end":"2026-08-05T21:34:46.424166Z","steps":["trace[382309569] 'process raft request' (duration: 178.859113ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.424308Z","caller":"traceutil/trace.go:171","msg":"trace[1805156661] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"178.198959ms","start":"2026-08-05T21:34:46.246064Z","end":"2026-08-05T21:34:46.424263Z","steps":["trace[1805156661] 'process raft request' (duration: 177.815195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.424465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.972914ms","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-08-05T21:34:46.424577Z","caller":"traceutil/trace.go:171","msg":"trace[2122925454] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"178.582064ms","start":"2026-08-05T21:34:46.245975Z","end":"2026-08-05T21:34:46.424557Z","steps":["trace[2122925454] 'process raft request' (duration: 177.874068ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.424606Z","caller":"traceutil/trace.go:171","msg":"trace[1480450935] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:27; }","duration":"180.129741ms","start":"2026-08-05T21:34:46.244458Z","end":"2026-08-05T21:34:46.424588Z","steps":["trace[1480450935] 'agreement among raft nodes before linearized reading' (duration: 179.878852ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.452581Z","caller":"traceutil/trace.go:171","msg":"trace[1542306238] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"163.193151ms","start":"2026-08-05T21:34:46.289369Z","end":"2026-08-05T21:34:46.452562Z","steps":["trace[1542306238] 'process raft request' (duration: 162.91124ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.452673Z","caller":"traceutil/trace.go:171","msg":"trace[2144551806] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"162.915041ms","start":"2026-08-05T21:34:46.289729Z","end":"2026-08-05T21:34:46.452644Z","steps":["trace[2144551806] 'process raft request' (duration: 162.717323ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.452879Z","caller":"traceutil/trace.go:171","msg":"trace[1612601835] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"162.747504ms","start":"2026-08-05T21:34:46.290122Z","end":"2026-08-05T21:34:46.452869Z","steps":["trace[1612601835] 'process raft request' (duration: 162.395721ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:46.452922Z","caller":"traceutil/trace.go:171","msg":"trace[1208566037] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"162.143272ms","start":"2026-08-05T21:34:46.290758Z","end":"2026-08-05T21:34:46.452901Z","steps":["trace[1208566037] 'process raft request' (duration: 161.80746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:46.454441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.739643ms","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-08-05T21:34:46.454473Z","caller":"traceutil/trace.go:171","msg":"trace[1568156818] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:31; }","duration":"164.432877ms","start":"2026-08-05T21:34:46.29003Z","end":"2026-08-05T21:34:46.454463Z","steps":["trace[1568156818] 'agreement among raft nodes before linearized reading' (duration: 162.595958ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:47.168864Z","caller":"traceutil/trace.go:171","msg":"trace[645592589] linearizableReadLoop","detail":"{readStateIndex:110; appliedIndex:108; }","duration":"216.704181ms","start":"2026-08-05T21:34:46.952137Z","end":"2026-08-05T21:34:47.168841Z","steps":["trace[645592589] 'read index received' (duration: 135.507386ms)","trace[645592589] 'applied index is now lower than readState.Index' (duration: 81.195465ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:47.168948Z","caller":"traceutil/trace.go:171","msg":"trace[1490133006] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"252.317754ms","start":"2026-08-05T21:34:46.916587Z","end":"2026-08-05T21:34:47.168904Z","steps":["trace[1490133006] 'process raft request' (duration: 171.047606ms)","trace[1490133006] 'compare' (duration: 80.983808ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:47.168967Z","caller":"traceutil/trace.go:171","msg":"trace[206059252] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"217.902955ms","start":"2026-08-05T21:34:46.951033Z","end":"2026-08-05T21:34:47.168936Z","steps":["trace[206059252] 'process raft request' (duration: 217.741029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:47.169152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.935559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-bootstrapper\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:47.169214Z","caller":"traceutil/trace.go:171","msg":"trace[83193380] range","detail":"{range_begin:/registry/clusterroles/system:node-bootstrapper; range_end:; response_count:0; response_revision:105; }","duration":"217.119596ms","start":"2026-08-05T21:34:46.952085Z","end":"2026-08-05T21:34:47.169205Z","steps":["trace[83193380] 'agreement among raft nodes before linearized reading' (duration: 216.909048ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:47.16931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.421964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-05T21:34:47.169437Z","caller":"traceutil/trace.go:171","msg":"trace[1135982788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:105; }","duration":"151.624602ms","start":"2026-08-05T21:34:47.017784Z","end":"2026-08-05T21:34:47.169409Z","steps":["trace[1135982788] 'agreement among raft nodes before linearized reading' (duration: 151.354692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:48.162119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.098044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:34:48.16241Z","caller":"traceutil/trace.go:171","msg":"trace[1550944850] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:248; }","duration":"146.489064ms","start":"2026-08-05T21:34:48.015904Z","end":"2026-08-05T21:34:48.162393Z","steps":["trace[1550944850] 'read index received' (duration: 32.543539ms)","trace[1550944850] 'applied index is now lower than readState.Index' (duration: 113.944595ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:34:48.162548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.628439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:34:48.162443Z","caller":"traceutil/trace.go:171","msg":"trace[19494178] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"164.909634ms","start":"2026-08-05T21:34:47.997321Z","end":"2026-08-05T21:34:48.162231Z","steps":["trace[19494178] 'process raft request' (duration: 51.077563ms)","trace[19494178] 'compare' (duration: 112.924278ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:48.162574Z","caller":"traceutil/trace.go:171","msg":"trace[1226796567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:244; }","duration":"146.692171ms","start":"2026-08-05T21:34:48.015874Z","end":"2026-08-05T21:34:48.162566Z","steps":["trace[1226796567] 'agreement among raft nodes before linearized reading' (duration: 146.607028ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:48.16292Z","caller":"traceutil/trace.go:171","msg":"trace[835808248] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"147.517521ms","start":"2026-08-05T21:34:48.015351Z","end":"2026-08-05T21:34:48.162869Z","steps":["trace[835808248] 'process raft request' (duration: 146.951901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:48.469156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.856607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:34:48.469718Z","caller":"traceutil/trace.go:171","msg":"trace[539295132] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"271.89521ms","start":"2026-08-05T21:34:48.197801Z","end":"2026-08-05T21:34:48.469696Z","steps":["trace[539295132] 'process raft request' (duration: 271.795017ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:48.469865Z","caller":"traceutil/trace.go:171","msg":"trace[168490263] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"275.560665ms","start":"2026-08-05T21:34:48.19418Z","end":"2026-08-05T21:34:48.46974Z","steps":["trace[168490263] 'process raft request' (duration: 155.490974ms)","trace[168490263] 'compare' (duration: 118.333837ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:48.469868Z","caller":"traceutil/trace.go:171","msg":"trace[30188282] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:252; }","duration":"273.020242ms","start":"2026-08-05T21:34:48.196769Z","end":"2026-08-05T21:34:48.46979Z","steps":["trace[30188282] 'read index received' (duration: 153.088136ms)","trace[30188282] 'applied index is now lower than readState.Index' (duration: 119.923146ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:34:48.472443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.649959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-05T21:34:48.472563Z","caller":"traceutil/trace.go:171","msg":"trace[384768413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:248; }","duration":"275.809644ms","start":"2026-08-05T21:34:48.196729Z","end":"2026-08-05T21:34:48.472539Z","steps":["trace[384768413] 'agreement among raft nodes before linearized reading' (duration: 273.203738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:48.472551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.502399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:34:48.472664Z","caller":"traceutil/trace.go:171","msg":"trace[669038384] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:248; }","duration":"267.588611ms","start":"2026-08-05T21:34:48.205011Z","end":"2026-08-05T21:34:48.472599Z","steps":["trace[669038384] 'agreement among raft nodes before linearized reading' (duration: 265.965501ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:49.275065Z","caller":"traceutil/trace.go:171","msg":"trace[1359359181] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"127.267872ms","start":"2026-08-05T21:34:49.147765Z","end":"2026-08-05T21:34:49.275033Z","steps":["trace[1359359181] 'process raft request' (duration: 50.817152ms)","trace[1359359181] 'compare' (duration: 76.296474ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:34:52.157177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.073053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-08-05T21:34:52.157273Z","caller":"traceutil/trace.go:171","msg":"trace[1481673652] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:334; }","duration":"130.224278ms","start":"2026-08-05T21:34:52.027029Z","end":"2026-08-05T21:34:52.157253Z","steps":["trace[1481673652] 'range keys from in-memory index tree' (duration: 129.934578ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:53.053608Z","caller":"traceutil/trace.go:171","msg":"trace[2010947253] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"118.394804ms","start":"2026-08-05T21:34:52.935184Z","end":"2026-08-05T21:34:53.053579Z","steps":["trace[2010947253] 'process raft request' (duration: 49.967493ms)","trace[2010947253] 'compare' (duration: 68.234834ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:53.054348Z","caller":"traceutil/trace.go:171","msg":"trace[1212532313] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"116.546837ms","start":"2026-08-05T21:34:52.937783Z","end":"2026-08-05T21:34:53.05433Z","steps":["trace[1212532313] 'process raft request' (duration: 116.208844ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:53.413394Z","caller":"traceutil/trace.go:171","msg":"trace[1893170958] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"109.018024ms","start":"2026-08-05T21:34:53.304348Z","end":"2026-08-05T21:34:53.413366Z","steps":["trace[1893170958] 'process raft request' (duration: 84.40625ms)","trace[1893170958] 'compare' (duration: 24.429157ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:53.413896Z","caller":"traceutil/trace.go:171","msg":"trace[846336949] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"108.752624ms","start":"2026-08-05T21:34:53.305126Z","end":"2026-08-05T21:34:53.413879Z","steps":["trace[846336949] 'process raft request' (duration: 108.198514ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:53.611842Z","caller":"traceutil/trace.go:171","msg":"trace[843822359] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"126.649267ms","start":"2026-08-05T21:34:53.485168Z","end":"2026-08-05T21:34:53.611817Z","steps":["trace[843822359] 'process raft request' (duration: 75.402687ms)","trace[843822359] 'compare' (duration: 51.087464ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:53.611965Z","caller":"traceutil/trace.go:171","msg":"trace[865076522] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"123.93119ms","start":"2026-08-05T21:34:53.487968Z","end":"2026-08-05T21:34:53.611899Z","steps":["trace[865076522] 'process raft request' (duration: 123.805426ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:53.612173Z","caller":"traceutil/trace.go:171","msg":"trace[430039922] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"122.943223ms","start":"2026-08-05T21:34:53.48919Z","end":"2026-08-05T21:34:53.612134Z","steps":["trace[430039922] 'process raft request' (duration: 122.627062ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:53.626552Z","caller":"traceutil/trace.go:171","msg":"trace[920429820] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"110.140655ms","start":"2026-08-05T21:34:53.516393Z","end":"2026-08-05T21:34:53.626534Z","steps":["trace[920429820] 'process raft request' (duration: 109.929297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:53.677513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.595774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-05T21:34:53.677591Z","caller":"traceutil/trace.go:171","msg":"trace[647116771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:360; }","duration":"141.709017ms","start":"2026-08-05T21:34:53.535863Z","end":"2026-08-05T21:34:53.677572Z","steps":["trace[647116771] 'agreement among raft nodes before linearized reading' (duration: 141.52375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:53.67755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.28707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-08-05T21:34:53.677739Z","caller":"traceutil/trace.go:171","msg":"trace[1015885437] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:360; }","duration":"100.529229ms","start":"2026-08-05T21:34:53.57716Z","end":"2026-08-05T21:34:53.677689Z","steps":["trace[1015885437] 'agreement among raft nodes before linearized reading' (duration: 100.214438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:54.156058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.462959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:34:54.156316Z","caller":"traceutil/trace.go:171","msg":"trace[654836950] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"393.292901ms","start":"2026-08-05T21:34:53.762986Z","end":"2026-08-05T21:34:54.156278Z","steps":["trace[654836950] 'process raft request' (duration: 126.505381ms)","trace[654836950] 'compare' (duration: 266.23263ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:34:54.156438Z","caller":"traceutil/trace.go:171","msg":"trace[1033212578] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"390.877275ms","start":"2026-08-05T21:34:53.765532Z","end":"2026-08-05T21:34:54.156409Z","steps":["trace[1033212578] 'process raft request' (duration: 390.686459ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.156513Z","caller":"traceutil/trace.go:171","msg":"trace[347587004] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"389.731664ms","start":"2026-08-05T21:34:53.76677Z","end":"2026-08-05T21:34:54.156502Z","steps":["trace[347587004] 'process raft request' (duration: 389.536187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:54.156497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:34:53.762973Z","time spent":"393.430066ms","remote":"127.0.0.1:39470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:34:54.156583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:34:53.765522Z","time spent":"390.986529ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:34:54.15645Z","caller":"traceutil/trace.go:171","msg":"trace[2035256808] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"389.417692ms","start":"2026-08-05T21:34:53.767006Z","end":"2026-08-05T21:34:54.156423Z","steps":["trace[2035256808] 'process raft request' (duration: 389.35673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:34:54.156701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:34:53.766762Z","time spent":"389.829977ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:34:54.156766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:34:53.766922Z","time spent":"389.783795ms","remote":"127.0.0.1:39446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:34:54.290913Z","caller":"traceutil/trace.go:171","msg":"trace[1228619601] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"128.785021ms","start":"2026-08-05T21:34:54.1621Z","end":"2026-08-05T21:34:54.290885Z","steps":["trace[1228619601] 'process raft request' (duration: 128.629595ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.291016Z","caller":"traceutil/trace.go:171","msg":"trace[261819158] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"127.525736ms","start":"2026-08-05T21:34:54.163451Z","end":"2026-08-05T21:34:54.290977Z","steps":["trace[261819158] 'process raft request' (duration: 127.395821ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.291116Z","caller":"traceutil/trace.go:171","msg":"trace[1140017524] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"127.212693ms","start":"2026-08-05T21:34:54.163885Z","end":"2026-08-05T21:34:54.291098Z","steps":["trace[1140017524] 'process raft request' (duration: 126.997355ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.290935Z","caller":"traceutil/trace.go:171","msg":"trace[408918197] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"128.588484ms","start":"2026-08-05T21:34:54.162324Z","end":"2026-08-05T21:34:54.290912Z","steps":["trace[408918197] 'process raft request' (duration: 128.448899ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.291299Z","caller":"traceutil/trace.go:171","msg":"trace[1387721652] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"119.870272ms","start":"2026-08-05T21:34:54.171419Z","end":"2026-08-05T21:34:54.291289Z","steps":["trace[1387721652] 'process raft request' (duration: 119.503809ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.291479Z","caller":"traceutil/trace.go:171","msg":"trace[1742037565] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"128.426328ms","start":"2026-08-05T21:34:54.163026Z","end":"2026-08-05T21:34:54.291452Z","steps":["trace[1742037565] 'process raft request' (duration: 127.794475ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:34:54.291638Z","caller":"traceutil/trace.go:171","msg":"trace[310662455] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"129.992473ms","start":"2026-08-05T21:34:54.161633Z","end":"2026-08-05T21:34:54.291625Z","steps":["trace[310662455] 'process raft request' (duration: 126.707525ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:05.973367Z","caller":"traceutil/trace.go:171","msg":"trace[399249744] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:441; }","duration":"163.649066ms","start":"2026-08-05T21:35:05.809695Z","end":"2026-08-05T21:35:05.973344Z","steps":["trace[399249744] 'read index received' (duration: 163.389847ms)","trace[399249744] 'applied index is now lower than readState.Index' (duration: 258.168µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:35:05.973479Z","caller":"traceutil/trace.go:171","msg":"trace[1269423160] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"192.844744ms","start":"2026-08-05T21:35:05.780606Z","end":"2026-08-05T21:35:05.97345Z","steps":["trace[1269423160] 'process raft request' (duration: 192.585725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:05.97365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.925325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-05T21:35:05.973731Z","caller":"traceutil/trace.go:171","msg":"trace[1303964338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:427; }","duration":"164.06093ms","start":"2026-08-05T21:35:05.80965Z","end":"2026-08-05T21:35:05.973711Z","steps":["trace[1303964338] 'agreement among raft nodes before linearized reading' (duration: 163.856193ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:08.213082Z","caller":"traceutil/trace.go:171","msg":"trace[218782206] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:446; }","duration":"268.491502ms","start":"2026-08-05T21:35:07.944572Z","end":"2026-08-05T21:35:08.213063Z","steps":["trace[218782206] 'read index received' (duration: 268.323196ms)","trace[218782206] 'applied index is now lower than readState.Index' (duration: 167.326µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:08.213279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.99684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-05T21:35:08.213311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.707099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:08.213409Z","caller":"traceutil/trace.go:171","msg":"trace[1830216442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"268.864184ms","start":"2026-08-05T21:35:07.944521Z","end":"2026-08-05T21:35:08.213386Z","steps":["trace[1830216442] 'agreement among raft nodes before linearized reading' (duration: 268.683689ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:08.213356Z","caller":"traceutil/trace.go:171","msg":"trace[843315374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:431; }","duration":"235.105303ms","start":"2026-08-05T21:35:07.978238Z","end":"2026-08-05T21:35:08.213344Z","steps":["trace[843315374] 'agreement among raft nodes before linearized reading' (duration: 234.988099ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:08.213429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.831391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-05T21:35:08.213485Z","caller":"traceutil/trace.go:171","msg":"trace[1420325058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:431; }","duration":"227.909923ms","start":"2026-08-05T21:35:07.985567Z","end":"2026-08-05T21:35:08.213477Z","steps":["trace[1420325058] 'agreement among raft nodes before linearized reading' (duration: 227.833861ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:12.504644Z","caller":"traceutil/trace.go:171","msg":"trace[760643760] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"260.627825ms","start":"2026-08-05T21:35:12.243989Z","end":"2026-08-05T21:35:12.504617Z","steps":["trace[760643760] 'process raft request' (duration: 260.46822ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:12.526526Z","caller":"traceutil/trace.go:171","msg":"trace[200958843] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"282.243821ms","start":"2026-08-05T21:35:12.244254Z","end":"2026-08-05T21:35:12.526498Z","steps":["trace[200958843] 'process raft request' (duration: 282.106857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:12.861978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.565477ms","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-08-05T21:35:12.86205Z","caller":"traceutil/trace.go:171","msg":"trace[2102448924] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"114.690592ms","start":"2026-08-05T21:35:12.747344Z","end":"2026-08-05T21:35:12.862034Z","steps":["trace[2102448924] 'range keys from in-memory index tree' (duration: 114.465254ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:23.093037Z","caller":"traceutil/trace.go:171","msg":"trace[2111386569] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"100.302958ms","start":"2026-08-05T21:35:22.992708Z","end":"2026-08-05T21:35:23.093011Z","steps":["trace[2111386569] 'process raft request' (duration: 100.177145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.289862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.370855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:35:24.289973Z","caller":"traceutil/trace.go:171","msg":"trace[1893353411] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"838.840633ms","start":"2026-08-05T21:35:23.451114Z","end":"2026-08-05T21:35:24.289954Z","steps":["trace[1893353411] 'process raft request' (duration: 283.292242ms)","trace[1893353411] 'compare' (duration: 555.21979ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:24.290031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.451094Z","time spent":"838.915505ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.339501Z","caller":"traceutil/trace.go:171","msg":"trace[1896089005] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"882.798431ms","start":"2026-08-05T21:35:23.456676Z","end":"2026-08-05T21:35:24.339475Z","steps":["trace[1896089005] 'process raft request' (duration: 882.277746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.339828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.45667Z","time spent":"882.904474ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:24.339853Z","caller":"traceutil/trace.go:171","msg":"trace[1585367338] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"880.397577ms","start":"2026-08-05T21:35:23.459315Z","end":"2026-08-05T21:35:24.339712Z","steps":["trace[1585367338] 'process raft request' (duration: 879.729986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.340015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.459304Z","time spent":"880.629543ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.340012Z","caller":"traceutil/trace.go:171","msg":"trace[1885420478] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"882.401179ms","start":"2026-08-05T21:35:23.457593Z","end":"2026-08-05T21:35:24.339994Z","steps":["trace[1885420478] 'process raft request' (duration: 881.413929ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:24.340055Z","caller":"traceutil/trace.go:171","msg":"trace[942582157] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"887.753355ms","start":"2026-08-05T21:35:23.452287Z","end":"2026-08-05T21:35:24.34004Z","steps":["trace[942582157] 'process raft request' (duration: 886.433784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.340085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.457586Z","time spent":"882.466781ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:35:24.340108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.452269Z","time spent":"887.814396ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.340155Z","caller":"traceutil/trace.go:171","msg":"trace[784878217] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"885.399642ms","start":"2026-08-05T21:35:23.454748Z","end":"2026-08-05T21:35:24.340147Z","steps":["trace[784878217] 'process raft request' (duration: 884.144794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.34019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.454731Z","time spent":"885.444024ms","remote":"127.0.0.1:39816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.340265Z","caller":"traceutil/trace.go:171","msg":"trace[2011737347] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"887.88445ms","start":"2026-08-05T21:35:23.452347Z","end":"2026-08-05T21:35:24.340232Z","steps":["trace[2011737347] 'process raft request' (duration: 886.511187ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:24.340415Z","caller":"traceutil/trace.go:171","msg":"trace[976220082] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"873.528024ms","start":"2026-08-05T21:35:23.466877Z","end":"2026-08-05T21:35:24.340406Z","steps":["trace[976220082] 'process raft request' (duration: 872.334596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.340414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.452343Z","time spent":"888.009693ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:35:24.340458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.46687Z","time spent":"873.570935ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.340517Z","caller":"traceutil/trace.go:171","msg":"trace[1909816119] transaction","detail":"{read_only:false; number_of_response:1; response_revision:542; }","duration":"877.653172ms","start":"2026-08-05T21:35:23.462856Z","end":"2026-08-05T21:35:24.340509Z","steps":["trace[1909816119] 'process raft request' (duration: 876.227648ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:24.340546Z","caller":"traceutil/trace.go:171","msg":"trace[1544253004] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"877.624682ms","start":"2026-08-05T21:35:23.462908Z","end":"2026-08-05T21:35:24.340533Z","steps":["trace[1544253004] 'process raft request' (duration: 876.256339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.34057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.46285Z","time spent":"877.684703ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:24.340513Z","caller":"traceutil/trace.go:171","msg":"trace[1406436451] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"852.79919ms","start":"2026-08-05T21:35:23.487633Z","end":"2026-08-05T21:35:24.340432Z","steps":["trace[1406436451] 'process raft request' (duration: 852.100747ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:24.340706Z","caller":"traceutil/trace.go:171","msg":"trace[1133272786] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"869.754487ms","start":"2026-08-05T21:35:23.470943Z","end":"2026-08-05T21:35:24.340698Z","steps":["trace[1133272786] 'process raft request' (duration: 868.696893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.340741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.470937Z","time spent":"869.790028ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:35:24.34063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.462905Z","time spent":"877.682903ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:35:24.340876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.487607Z","time spent":"853.197572ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.340655Z","caller":"traceutil/trace.go:171","msg":"trace[1323178253] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"847.917788ms","start":"2026-08-05T21:35:23.49273Z","end":"2026-08-05T21:35:24.340648Z","steps":["trace[1323178253] 'process raft request' (duration: 847.063201ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.341064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.492678Z","time spent":"848.355591ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.354657Z","caller":"traceutil/trace.go:171","msg":"trace[1518923482] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"694.628133ms","start":"2026-08-05T21:35:23.660017Z","end":"2026-08-05T21:35:24.354645Z","steps":["trace[1518923482] 'process raft request' (duration: 694.168038ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.354818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.659985Z","time spent":"694.792938ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-05T21:35:24.355027Z","caller":"traceutil/trace.go:171","msg":"trace[395590717] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:555; }","duration":"410.891527ms","start":"2026-08-05T21:35:23.944109Z","end":"2026-08-05T21:35:24.355Z","steps":["trace[395590717] 'read index received' (duration: 394.703416ms)","trace[395590717] 'applied index is now lower than readState.Index' (duration: 16.186061ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:24.355123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.00784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:24.355275Z","caller":"traceutil/trace.go:171","msg":"trace[1865789396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"411.206907ms","start":"2026-08-05T21:35:23.944056Z","end":"2026-08-05T21:35:24.355263Z","steps":["trace[1865789396] 'agreement among raft nodes before linearized reading' (duration: 411.006341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:24.355367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:23.944031Z","time spent":"411.32358ms","remote":"127.0.0.1:39264","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-08-05T21:35:26.832459Z","caller":"traceutil/trace.go:171","msg":"trace[1862222886] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"245.101971ms","start":"2026-08-05T21:35:26.587339Z","end":"2026-08-05T21:35:26.832441Z","steps":["trace[1862222886] 'process raft request' (duration: 244.981058ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:27.101103Z","caller":"traceutil/trace.go:171","msg":"trace[1594445468] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"455.757524ms","start":"2026-08-05T21:35:26.645318Z","end":"2026-08-05T21:35:27.101076Z","steps":["trace[1594445468] 'read index received' (duration: 187.208758ms)","trace[1594445468] 'applied index is now lower than readState.Index' (duration: 268.544996ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:35:27.101141Z","caller":"traceutil/trace.go:171","msg":"trace[1551233031] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"512.361319ms","start":"2026-08-05T21:35:26.588732Z","end":"2026-08-05T21:35:27.101093Z","steps":["trace[1551233031] 'process raft request' (duration: 512.182853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:27.101338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:26.588688Z","time spent":"512.521163ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T21:35:27.10144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.110084ms","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-08-05T21:35:27.101486Z","caller":"traceutil/trace.go:171","msg":"trace[496092720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"456.214048ms","start":"2026-08-05T21:35:26.645259Z","end":"2026-08-05T21:35:27.101473Z","steps":["trace[496092720] 'agreement among raft nodes before linearized reading' (duration: 455.970961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:27.101526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:26.64523Z","time spent":"456.28724ms","remote":"127.0.0.1:39534","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-08-05T21:35:27.101516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.16771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-05T21:35:27.10156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.776011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:27.101618Z","caller":"traceutil/trace.go:171","msg":"trace[1934626116] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:615; }","duration":"261.313844ms","start":"2026-08-05T21:35:26.840282Z","end":"2026-08-05T21:35:27.101596Z","steps":["trace[1934626116] 'agreement among raft nodes before linearized reading' (duration: 261.132499ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:27.101649Z","caller":"traceutil/trace.go:171","msg":"trace[478966208] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"157.926916ms","start":"2026-08-05T21:35:26.943699Z","end":"2026-08-05T21:35:27.101626Z","steps":["trace[478966208] 'agreement among raft nodes before linearized reading' (duration: 157.73663ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:28.542086Z","caller":"traceutil/trace.go:171","msg":"trace[205119827] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"497.752047ms","start":"2026-08-05T21:35:28.04431Z","end":"2026-08-05T21:35:28.542062Z","steps":["trace[205119827] 'process raft request' (duration: 495.886541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:28.542242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:28.044282Z","time spent":"497.880641ms","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:31.216636Z","caller":"traceutil/trace.go:171","msg":"trace[1041023868] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"271.549805ms","start":"2026-08-05T21:35:30.945057Z","end":"2026-08-05T21:35:31.216606Z","steps":["trace[1041023868] 'read index received' (duration: 271.38737ms)","trace[1041023868] 'applied index is now lower than readState.Index' (duration: 161.195µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:31.216868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.774882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:31.216975Z","caller":"traceutil/trace.go:171","msg":"trace[1084719320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"271.935736ms","start":"2026-08-05T21:35:30.945012Z","end":"2026-08-05T21:35:31.216948Z","steps":["trace[1084719320] 'agreement among raft nodes before linearized reading' (duration: 271.743791ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:31.216729Z","caller":"traceutil/trace.go:171","msg":"trace[1139172020] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"342.747147ms","start":"2026-08-05T21:35:30.873949Z","end":"2026-08-05T21:35:31.216696Z","steps":["trace[1139172020] 'process raft request' (duration: 342.416787ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.217503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:30.87393Z","time spent":"343.412137ms","remote":"127.0.0.1:39534","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-08-05T21:35:31.717706Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891366402539447609,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-05T21:35:31.744699Z","caller":"traceutil/trace.go:171","msg":"trace[579399101] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"679.954595ms","start":"2026-08-05T21:35:31.064686Z","end":"2026-08-05T21:35:31.744641Z","steps":["trace[579399101] 'process raft request' (duration: 679.332326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.744851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.064654Z","time spent":"680.11727ms","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:31.744929Z","caller":"traceutil/trace.go:171","msg":"trace[456487941] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"528.166346ms","start":"2026-08-05T21:35:31.216719Z","end":"2026-08-05T21:35:31.744885Z","steps":["trace[456487941] 'read index received' (duration: 526.96276ms)","trace[456487941] 'applied index is now lower than readState.Index' (duration: 1.201346ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:31.745063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.613576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-05T21:35:31.745144Z","caller":"traceutil/trace.go:171","msg":"trace[659819522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"627.729059ms","start":"2026-08-05T21:35:31.117397Z","end":"2026-08-05T21:35:31.745126Z","steps":["trace[659819522] 'agreement among raft nodes before linearized reading' (duration: 627.522663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.745198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.117387Z","time spent":"627.802151ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-05T21:35:31.745283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.915398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:31.74533Z","caller":"traceutil/trace.go:171","msg":"trace[980338427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"526.9653ms","start":"2026-08-05T21:35:31.218351Z","end":"2026-08-05T21:35:31.745316Z","steps":["trace[980338427] 'agreement among raft nodes before linearized reading' (duration: 526.889948ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:31.745332Z","caller":"traceutil/trace.go:171","msg":"trace[574295214] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"541.359131ms","start":"2026-08-05T21:35:31.203908Z","end":"2026-08-05T21:35:31.745267Z","steps":["trace[574295214] 'process raft request' (duration: 540.679231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.74515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.052059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-08-05T21:35:31.74523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.864863ms","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-08-05T21:35:31.745538Z","caller":"traceutil/trace.go:171","msg":"trace[2118400772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"633.207374ms","start":"2026-08-05T21:35:31.112313Z","end":"2026-08-05T21:35:31.74552Z","steps":["trace[2118400772] 'agreement among raft nodes before linearized reading' (duration: 632.884644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.745582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.218293Z","time spent":"527.187827ms","remote":"127.0.0.1:39268","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-08-05T21:35:31.745637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.112292Z","time spent":"633.325897ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-05T21:35:31.74567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.905665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hnjwr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-05T21:35:31.74548Z","caller":"traceutil/trace.go:171","msg":"trace[1195242671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"628.43055ms","start":"2026-08-05T21:35:31.117038Z","end":"2026-08-05T21:35:31.745468Z","steps":["trace[1195242671] 'agreement among raft nodes before linearized reading' (duration: 628.027368ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:31.745795Z","caller":"traceutil/trace.go:171","msg":"trace[1752573411] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hnjwr; range_end:; response_count:1; response_revision:643; }","duration":"328.115401ms","start":"2026-08-05T21:35:31.417647Z","end":"2026-08-05T21:35:31.745763Z","steps":["trace[1752573411] 'agreement among raft nodes before linearized reading' (duration: 327.695929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:31.745834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.117022Z","time spent":"628.800451ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-05T21:35:31.745904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.41761Z","time spent":"328.261976ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-hnjwr\" "} {"level":"warn","ts":"2026-08-05T21:35:31.746436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.203893Z","time spent":"542.465434ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:31.935432Z","caller":"traceutil/trace.go:171","msg":"trace[1315291925] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"184.8837ms","start":"2026-08-05T21:35:31.750513Z","end":"2026-08-05T21:35:31.935396Z","steps":["trace[1315291925] 'process raft request' (duration: 124.383446ms)","trace[1315291925] 'compare' (duration: 60.328739ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:32.214181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.056263ms","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-08-05T21:35:32.214311Z","caller":"traceutil/trace.go:171","msg":"trace[830383353] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:644; }","duration":"170.207487ms","start":"2026-08-05T21:35:32.044085Z","end":"2026-08-05T21:35:32.214292Z","steps":["trace[830383353] 'range keys from in-memory index tree' (duration: 170.039862ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:32.214933Z","caller":"traceutil/trace.go:171","msg":"trace[68885930] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"463.926162ms","start":"2026-08-05T21:35:31.750978Z","end":"2026-08-05T21:35:32.214905Z","steps":["trace[68885930] 'process raft request' (duration: 459.663036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:32.215089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.750953Z","time spent":"464.047517ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:32.215118Z","caller":"traceutil/trace.go:171","msg":"trace[1762630732] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:668; }","duration":"269.57629ms","start":"2026-08-05T21:35:31.945528Z","end":"2026-08-05T21:35:32.215105Z","steps":["trace[1762630732] 'read index received' (duration: 265.200709ms)","trace[1762630732] 'applied index is now lower than readState.Index' (duration: 4.372121ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:32.215201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.674674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:32.215236Z","caller":"traceutil/trace.go:171","msg":"trace[1155147721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"269.760366ms","start":"2026-08-05T21:35:31.945467Z","end":"2026-08-05T21:35:32.215228Z","steps":["trace[1155147721] 'agreement among raft nodes before linearized reading' (duration: 269.687754ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:32.215411Z","caller":"traceutil/trace.go:171","msg":"trace[2109371734] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"451.957745ms","start":"2026-08-05T21:35:31.763444Z","end":"2026-08-05T21:35:32.215401Z","steps":["trace[2109371734] 'process raft request' (duration: 451.578274ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:32.215439Z","caller":"traceutil/trace.go:171","msg":"trace[136279120] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"464.277903ms","start":"2026-08-05T21:35:31.751143Z","end":"2026-08-05T21:35:32.215421Z","steps":["trace[136279120] 'process raft request' (duration: 463.804628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:32.215787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.763425Z","time spent":"452.199682ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:32.215463Z","caller":"traceutil/trace.go:171","msg":"trace[933466262] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"418.902294ms","start":"2026-08-05T21:35:31.796542Z","end":"2026-08-05T21:35:32.215444Z","steps":["trace[933466262] 'process raft request' (duration: 418.524073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:32.215926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.751134Z","time spent":"464.672496ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T21:35:32.215975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:31.796516Z","time spent":"419.377948ms","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-05T21:35:33.446138Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891366402539447618,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-05T21:35:33.898665Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.27344497s","expected-duration":"1s"} {"level":"info","ts":"2026-08-05T21:35:33.906676Z","caller":"traceutil/trace.go:171","msg":"trace[1389072205] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.283124997s","start":"2026-08-05T21:35:32.623519Z","end":"2026-08-05T21:35:33.906644Z","steps":["trace[1389072205] 'process raft request' (duration: 1.275982305s)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:33.906829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:32.62349Z","time spent":"1.283272301s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:35:33.920895Z","caller":"traceutil/trace.go:171","msg":"trace[1553174107] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"975.318493ms","start":"2026-08-05T21:35:32.945513Z","end":"2026-08-05T21:35:33.920831Z","steps":["trace[1553174107] 'read index received' (duration: 953.529937ms)","trace[1553174107] 'applied index is now lower than readState.Index' (duration: 21.787046ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:33.92109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.543501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:35:33.921122Z","caller":"traceutil/trace.go:171","msg":"trace[1372655237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"975.630803ms","start":"2026-08-05T21:35:32.945481Z","end":"2026-08-05T21:35:33.921112Z","steps":["trace[1372655237] 'agreement among raft nodes before linearized reading' (duration: 975.540711ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:33.921148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:32.945468Z","time spent":"975.674454ms","remote":"127.0.0.1:39264","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-08-05T21:35:33.921781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.622947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-05T21:35:33.924102Z","caller":"traceutil/trace.go:171","msg":"trace[418440183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"700.756161ms","start":"2026-08-05T21:35:33.221095Z","end":"2026-08-05T21:35:33.921851Z","steps":["trace[418440183] 'agreement among raft nodes before linearized reading' (duration: 700.002099ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:35:33.924337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:35:33.22108Z","time spent":"703.111502ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-05T21:35:35.791198Z","caller":"traceutil/trace.go:171","msg":"trace[1534126362] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"157.098095ms","start":"2026-08-05T21:35:35.634073Z","end":"2026-08-05T21:35:35.791171Z","steps":["trace[1534126362] 'process raft request' (duration: 156.910919ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:46.204631Z","caller":"traceutil/trace.go:171","msg":"trace[1575454983] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"195.96015ms","start":"2026-08-05T21:35:46.008621Z","end":"2026-08-05T21:35:46.204581Z","steps":["trace[1575454983] 'read index received' (duration: 195.675152ms)","trace[1575454983] 'applied index is now lower than readState.Index' (duration: 284.008µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:35:46.20487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.224728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-05T21:35:46.204908Z","caller":"traceutil/trace.go:171","msg":"trace[1953803011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"196.30363ms","start":"2026-08-05T21:35:46.008595Z","end":"2026-08-05T21:35:46.204899Z","steps":["trace[1953803011] 'agreement among raft nodes before linearized reading' (duration: 196.112504ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:46.205024Z","caller":"traceutil/trace.go:171","msg":"trace[974871673] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"197.284597ms","start":"2026-08-05T21:35:46.00769Z","end":"2026-08-05T21:35:46.204975Z","steps":["trace[974871673] 'process raft request' (duration: 196.699041ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:35:52.870453Z","caller":"traceutil/trace.go:171","msg":"trace[1792690137] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"118.249836ms","start":"2026-08-05T21:35:52.752174Z","end":"2026-08-05T21:35:52.870424Z","steps":["trace[1792690137] 'process raft request' (duration: 116.21736ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.767065Z","caller":"traceutil/trace.go:171","msg":"trace[463584377] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"293.776988ms","start":"2026-08-05T21:36:03.473115Z","end":"2026-08-05T21:36:03.766892Z","steps":["trace[463584377] 'process raft request' (duration: 293.115201ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.889508Z","caller":"traceutil/trace.go:171","msg":"trace[2119165561] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"117.189568ms","start":"2026-08-05T21:36:03.772293Z","end":"2026-08-05T21:36:03.889482Z","steps":["trace[2119165561] 'process raft request' (duration: 112.701631ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.988491Z","caller":"traceutil/trace.go:171","msg":"trace[1698721475] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"212.711667ms","start":"2026-08-05T21:36:03.775754Z","end":"2026-08-05T21:36:03.988466Z","steps":["trace[1698721475] 'process raft request' (duration: 212.50518ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.989179Z","caller":"traceutil/trace.go:171","msg":"trace[404104194] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1006; }","duration":"206.788573ms","start":"2026-08-05T21:36:03.782345Z","end":"2026-08-05T21:36:03.989133Z","steps":["trace[404104194] 'read index received' (duration: 102.74762ms)","trace[404104194] 'applied index is now lower than readState.Index' (duration: 104.039573ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:36:03.989249Z","caller":"traceutil/trace.go:171","msg":"trace[577979723] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"207.615183ms","start":"2026-08-05T21:36:03.781618Z","end":"2026-08-05T21:36:03.989234Z","steps":["trace[577979723] 'process raft request' (duration: 207.148381ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.989303Z","caller":"traceutil/trace.go:171","msg":"trace[185424009] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"208.786655ms","start":"2026-08-05T21:36:03.780507Z","end":"2026-08-05T21:36:03.989293Z","steps":["trace[185424009] 'process raft request' (duration: 207.898352ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:03.989446Z","caller":"traceutil/trace.go:171","msg":"trace[1634516292] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"182.381063ms","start":"2026-08-05T21:36:03.807027Z","end":"2026-08-05T21:36:03.989408Z","steps":["trace[1634516292] 'process raft request' (duration: 181.8668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:36:04.161806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.438674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-srbqt\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-08-05T21:36:04.161858Z","caller":"traceutil/trace.go:171","msg":"trace[981577141] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-srbqt; range_end:; response_count:1; response_revision:978; }","duration":"379.521626ms","start":"2026-08-05T21:36:03.782322Z","end":"2026-08-05T21:36:04.161844Z","steps":["trace[981577141] 'agreement among raft nodes before linearized reading' (duration: 207.038699ms)","trace[981577141] 'range keys from in-memory index tree' (duration: 172.310693ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:36:04.161881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:36:03.782315Z","time spent":"379.561187ms","remote":"127.0.0.1:39456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5095,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-srbqt\" "} {"level":"info","ts":"2026-08-05T21:36:04.200144Z","caller":"traceutil/trace.go:171","msg":"trace[72622352] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"173.498443ms","start":"2026-08-05T21:36:04.026621Z","end":"2026-08-05T21:36:04.20012Z","steps":["trace[72622352] 'process raft request' (duration: 173.257927ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:36:30.760745Z","caller":"traceutil/trace.go:171","msg":"trace[1028917045] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"102.398399ms","start":"2026-08-05T21:36:30.658303Z","end":"2026-08-05T21:36:30.760702Z","steps":["trace[1028917045] 'process raft request' (duration: 88.105432ms)","trace[1028917045] 'compare' (duration: 14.016201ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:36:30.919122Z","caller":"traceutil/trace.go:171","msg":"trace[1797724476] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"152.648269ms","start":"2026-08-05T21:36:30.766445Z","end":"2026-08-05T21:36:30.919093Z","steps":["trace[1797724476] 'process raft request' (duration: 118.298447ms)","trace[1797724476] 'compare' (duration: 34.223349ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:36:34.282294Z","caller":"traceutil/trace.go:171","msg":"trace[336211893] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"128.491993ms","start":"2026-08-05T21:36:34.153775Z","end":"2026-08-05T21:36:34.282267Z","steps":["trace[336211893] 'process raft request' (duration: 128.318839ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:11.184273Z","caller":"traceutil/trace.go:171","msg":"trace[141450687] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"141.918374ms","start":"2026-08-05T21:37:11.042324Z","end":"2026-08-05T21:37:11.184242Z","steps":["trace[141450687] 'process raft request' (duration: 135.092844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.445775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.999269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:37:15.445917Z","caller":"traceutil/trace.go:171","msg":"trace[778676285] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1270; }","duration":"500.947699ms","start":"2026-08-05T21:37:14.944908Z","end":"2026-08-05T21:37:15.445855Z","steps":["trace[778676285] 'read index received' (duration: 226.791627ms)","trace[778676285] 'applied index is now lower than readState.Index' (duration: 274.154902ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:15.446039Z","caller":"traceutil/trace.go:171","msg":"trace[1908648556] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"547.508435ms","start":"2026-08-05T21:37:14.898518Z","end":"2026-08-05T21:37:15.446026Z","steps":["trace[1908648556] 'process raft request' (duration: 273.171419ms)","trace[1908648556] 'compare' (duration: 273.559339ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:37:15.446172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:37:14.898497Z","time spent":"547.607576ms","remote":"127.0.0.1:39534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T21:37:15.446286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.288988ms","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-08-05T21:37:15.446402Z","caller":"traceutil/trace.go:171","msg":"trace[1856157958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1223; }","duration":"442.450911ms","start":"2026-08-05T21:37:15.003927Z","end":"2026-08-05T21:37:15.446378Z","steps":["trace[1856157958] 'agreement among raft nodes before linearized reading' (duration: 442.215636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.446461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:37:15.003894Z","time spent":"442.552823ms","remote":"127.0.0.1:39534","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-08-05T21:37:15.446522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.411603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-05T21:37:15.446554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.091159ms","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-08-05T21:37:15.44658Z","caller":"traceutil/trace.go:171","msg":"trace[405933786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1223; }","duration":"174.519496ms","start":"2026-08-05T21:37:15.272047Z","end":"2026-08-05T21:37:15.446566Z","steps":["trace[405933786] 'agreement among raft nodes before linearized reading' (duration: 174.334762ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:15.446606Z","caller":"traceutil/trace.go:171","msg":"trace[686088368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1223; }","duration":"108.182751ms","start":"2026-08-05T21:37:15.33841Z","end":"2026-08-05T21:37:15.446593Z","steps":["trace[686088368] 'agreement among raft nodes before linearized reading' (duration: 107.993647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.446819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.869355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"} {"level":"info","ts":"2026-08-05T21:37:15.44688Z","caller":"traceutil/trace.go:171","msg":"trace[1907229084] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1223; }","duration":"248.928947ms","start":"2026-08-05T21:37:15.197933Z","end":"2026-08-05T21:37:15.446862Z","steps":["trace[1907229084] 'agreement among raft nodes before linearized reading' (duration: 248.660431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.446874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.163633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-05T21:37:15.446931Z","caller":"traceutil/trace.go:171","msg":"trace[1780035214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1223; }","duration":"274.254695ms","start":"2026-08-05T21:37:15.17266Z","end":"2026-08-05T21:37:15.446915Z","steps":["trace[1780035214] 'agreement among raft nodes before linearized reading' (duration: 274.00318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.446313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.364919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:37:15.448047Z","caller":"traceutil/trace.go:171","msg":"trace[1673448518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"503.172934ms","start":"2026-08-05T21:37:14.944853Z","end":"2026-08-05T21:37:15.448026Z","steps":["trace[1673448518] 'agreement among raft nodes before linearized reading' (duration: 501.275206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:15.448102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:37:14.944833Z","time spent":"503.254866ms","remote":"127.0.0.1:39264","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-08-05T21:37:15.645324Z","caller":"traceutil/trace.go:171","msg":"trace[570901597] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"192.81506ms","start":"2026-08-05T21:37:15.452483Z","end":"2026-08-05T21:37:15.645298Z","steps":["trace[570901597] 'process raft request' (duration: 174.460074ms)","trace[570901597] 'compare' (duration: 18.07787ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:15.64557Z","caller":"traceutil/trace.go:171","msg":"trace[109737943] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"192.999134ms","start":"2026-08-05T21:37:15.452547Z","end":"2026-08-05T21:37:15.645547Z","steps":["trace[109737943] 'process raft request' (duration: 192.671207ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:15.645913Z","caller":"traceutil/trace.go:171","msg":"trace[714043898] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"190.455132ms","start":"2026-08-05T21:37:15.455432Z","end":"2026-08-05T21:37:15.645887Z","steps":["trace[714043898] 'process raft request' (duration: 190.047034ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:21.728681Z","caller":"traceutil/trace.go:171","msg":"trace[1252001784] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1291; }","duration":"191.318142ms","start":"2026-08-05T21:37:21.53734Z","end":"2026-08-05T21:37:21.728658Z","steps":["trace[1252001784] 'read index received' (duration: 191.023456ms)","trace[1252001784] 'applied index is now lower than readState.Index' (duration: 293.616µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:21.728773Z","caller":"traceutil/trace.go:171","msg":"trace[1183635410] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"264.949172ms","start":"2026-08-05T21:37:21.463775Z","end":"2026-08-05T21:37:21.728724Z","steps":["trace[1183635410] 'process raft request' (duration: 264.721937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:21.728935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.578617ms","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-08-05T21:37:21.728988Z","caller":"traceutil/trace.go:171","msg":"trace[1089221033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"191.680489ms","start":"2026-08-05T21:37:21.537284Z","end":"2026-08-05T21:37:21.728964Z","steps":["trace[1089221033] 'agreement among raft nodes before linearized reading' (duration: 191.522616ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:45.067125Z","caller":"traceutil/trace.go:171","msg":"trace[412094608] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"112.121856ms","start":"2026-08-05T21:37:44.954973Z","end":"2026-08-05T21:37:45.067095Z","steps":["trace[412094608] 'process raft request' (duration: 111.865911ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:45.362854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.429716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:37:45.362985Z","caller":"traceutil/trace.go:171","msg":"trace[1674281308] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1358; }","duration":"124.617279ms","start":"2026-08-05T21:37:45.238352Z","end":"2026-08-05T21:37:45.362969Z","steps":["trace[1674281308] 'range keys from in-memory index tree' (duration: 124.374644ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:46.029635Z","caller":"traceutil/trace.go:171","msg":"trace[1998573317] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"143.689017ms","start":"2026-08-05T21:37:45.8859Z","end":"2026-08-05T21:37:46.029589Z","steps":["trace[1998573317] 'read index received' (duration: 143.350871ms)","trace[1998573317] 'applied index is now lower than readState.Index' (duration: 336.896µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:46.029705Z","caller":"traceutil/trace.go:171","msg":"trace[1699810253] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"159.449554ms","start":"2026-08-05T21:37:45.870225Z","end":"2026-08-05T21:37:46.029674Z","steps":["trace[1699810253] 'process raft request' (duration: 159.117298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:46.029917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.000323ms","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-08-05T21:37:46.030007Z","caller":"traceutil/trace.go:171","msg":"trace[1826407319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"144.134625ms","start":"2026-08-05T21:37:45.885851Z","end":"2026-08-05T21:37:46.029985Z","steps":["trace[1826407319] 'agreement among raft nodes before linearized reading' (duration: 143.932481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:46.265535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.833636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:37:46.265868Z","caller":"traceutil/trace.go:171","msg":"trace[1934894034] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"231.504502ms","start":"2026-08-05T21:37:46.03429Z","end":"2026-08-05T21:37:46.265794Z","steps":["trace[1934894034] 'process raft request' (duration: 122.305729ms)","trace[1934894034] 'compare' (duration: 108.684714ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:46.332575Z","caller":"traceutil/trace.go:171","msg":"trace[1112007348] linearizableReadLoop","detail":"{readStateIndex:1418; appliedIndex:1414; }","duration":"296.823611ms","start":"2026-08-05T21:37:46.035728Z","end":"2026-08-05T21:37:46.332551Z","steps":["trace[1112007348] 'read index received' (duration: 120.977714ms)","trace[1112007348] 'applied index is now lower than readState.Index' (duration: 175.845027ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:46.332613Z","caller":"traceutil/trace.go:171","msg":"trace[1407677358] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"297.716617ms","start":"2026-08-05T21:37:46.034856Z","end":"2026-08-05T21:37:46.332572Z","steps":["trace[1407677358] 'process raft request' (duration: 297.493993ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:46.332655Z","caller":"traceutil/trace.go:171","msg":"trace[243852797] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"297.618726ms","start":"2026-08-05T21:37:46.035007Z","end":"2026-08-05T21:37:46.332626Z","steps":["trace[243852797] 'process raft request' (duration: 297.467483ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:46.332694Z","caller":"traceutil/trace.go:171","msg":"trace[1742955358] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"297.593925ms","start":"2026-08-05T21:37:46.035089Z","end":"2026-08-05T21:37:46.332683Z","steps":["trace[1742955358] 'process raft request' (duration: 297.427372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:37:46.332885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.150697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-08-05T21:37:46.332889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.171164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-05T21:37:46.332929Z","caller":"traceutil/trace.go:171","msg":"trace[41475107] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1363; }","duration":"297.220808ms","start":"2026-08-05T21:37:46.035696Z","end":"2026-08-05T21:37:46.332917Z","steps":["trace[41475107] 'agreement among raft nodes before linearized reading' (duration: 297.120867ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:46.332938Z","caller":"traceutil/trace.go:171","msg":"trace[616797270] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1363; }","duration":"233.258096ms","start":"2026-08-05T21:37:46.099667Z","end":"2026-08-05T21:37:46.332925Z","steps":["trace[616797270] 'agreement among raft nodes before linearized reading' (duration: 233.171204ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:48.449029Z","caller":"traceutil/trace.go:171","msg":"trace[642936157] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"108.861987ms","start":"2026-08-05T21:37:48.340141Z","end":"2026-08-05T21:37:48.449003Z","steps":["trace[642936157] 'process raft request' (duration: 108.799676ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:37:48.449045Z","caller":"traceutil/trace.go:171","msg":"trace[1914595343] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"108.869317ms","start":"2026-08-05T21:37:48.340138Z","end":"2026-08-05T21:37:48.449008Z","steps":["trace[1914595343] 'process raft request' (duration: 91.974551ms)","trace[1914595343] 'compare' (duration: 16.688242ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:37:48.451162Z","caller":"traceutil/trace.go:171","msg":"trace[1357827385] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"109.934067ms","start":"2026-08-05T21:37:48.341207Z","end":"2026-08-05T21:37:48.451141Z","steps":["trace[1357827385] 'process raft request' (duration: 109.822895ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:38:19.424151Z","caller":"traceutil/trace.go:171","msg":"trace[1380011460] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"101.594422ms","start":"2026-08-05T21:38:19.322533Z","end":"2026-08-05T21:38:19.424127Z","steps":["trace[1380011460] 'process raft request' (duration: 101.281107ms)"],"step_count":1}