{"level":"warn","ts":"2026-07-23T23:45:13.609363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:45:13.609542Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-07-23T23:45:13.60964Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-23T23:45:13.609711Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-23T23:45:13.609793Z","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-07-23T23:45:13.610932Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-07-23T23:45:13.611155Z","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.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-07-23T23:45:13.63007Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"18.531747ms"} {"level":"info","ts":"2026-07-23T23:45:13.673777Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-07-23T23:45:13.673859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T23:45:13.673884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-07-23T23:45:13.673894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T23:45:13.673903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-07-23T23:45:13.673972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-07-23T23:45:13.899555Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T23:45:13.909548Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T23:45:13.918943Z","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-07-23T23:45:13.925503Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T23:45:13.925686Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T23:45:13.925809Z","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-07-23T23:45:13.925909Z","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-07-23T23:45:13.925949Z","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-07-23T23:45:13.930822Z","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-07-23T23:45:13.930916Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-23T23:45:13.931017Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-07-23T23:45:13.931112Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T23:45:13.93115Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T23:45:13.933507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-07-23T23:45:13.933687Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-07-23T23:45:14.581367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T23:45:14.58143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T23:45:14.581456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-07-23T23:45:14.581471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-07-23T23:45:14.581481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-23T23:45:14.581492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-07-23T23:45:14.581619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-07-23T23:45:14.592015Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:45:14.599532Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T23:45:14.599709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:45:14.599752Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:45:14.603062Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-23T23:45:14.603265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-07-23T23:45:14.603349Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T23:45:14.603369Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T23:45:14.605312Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:45:14.605877Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:45:14.605972Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:45:16.063784Z","caller":"traceutil/trace.go:171","msg":"trace[1914484672] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"161.795743ms","start":"2026-07-23T23:45:15.901964Z","end":"2026-07-23T23:45:16.06376Z","steps":["trace[1914484672] 'process raft request' (duration: 161.695059ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.063829Z","caller":"traceutil/trace.go:171","msg":"trace[1817045918] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"161.824355ms","start":"2026-07-23T23:45:15.901972Z","end":"2026-07-23T23:45:16.063796Z","steps":["trace[1817045918] 'process raft request' (duration: 161.716591ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.063882Z","caller":"traceutil/trace.go:171","msg":"trace[887642917] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"161.319775ms","start":"2026-07-23T23:45:15.902523Z","end":"2026-07-23T23:45:16.063842Z","steps":["trace[887642917] 'process raft request' (duration: 161.18793ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.063749Z","caller":"traceutil/trace.go:171","msg":"trace[402705914] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"161.788093ms","start":"2026-07-23T23:45:15.901922Z","end":"2026-07-23T23:45:16.06371Z","steps":["trace[402705914] 'process raft request' (duration: 152.706003ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.064356Z","caller":"traceutil/trace.go:171","msg":"trace[2121406868] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:7; }","duration":"144.052952ms","start":"2026-07-23T23:45:15.920291Z","end":"2026-07-23T23:45:16.064344Z","steps":["trace[2121406868] 'read index received' (duration: 134.304007ms)","trace[2121406868] 'applied index is now lower than readState.Index' (duration: 9.748075ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:16.064448Z","caller":"traceutil/trace.go:171","msg":"trace[1101218633] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"161.70966ms","start":"2026-07-23T23:45:15.90273Z","end":"2026-07-23T23:45:16.064439Z","steps":["trace[1101218633] 'process raft request' (duration: 161.049885ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.06446Z","caller":"traceutil/trace.go:171","msg":"trace[1450383374] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"147.96422ms","start":"2026-07-23T23:45:15.916482Z","end":"2026-07-23T23:45:16.064446Z","steps":["trace[1450383374] 'process raft request' (duration: 147.818854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.064654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.570245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:45:16.064723Z","caller":"traceutil/trace.go:171","msg":"trace[1293243703] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"161.668678ms","start":"2026-07-23T23:45:15.903043Z","end":"2026-07-23T23:45:16.064712Z","steps":["trace[1293243703] 'agreement among raft nodes before linearized reading' (duration: 161.540973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.064722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.584685ms","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-07-23T23:45:16.064953Z","caller":"traceutil/trace.go:171","msg":"trace[1396607361] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"161.791613ms","start":"2026-07-23T23:45:15.90308Z","end":"2026-07-23T23:45:16.064872Z","steps":["trace[1396607361] 'agreement among raft nodes before linearized reading' (duration: 161.46074ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.080056Z","caller":"traceutil/trace.go:171","msg":"trace[2096979641] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"158.19459ms","start":"2026-07-23T23:45:15.921846Z","end":"2026-07-23T23:45:16.080041Z","steps":["trace[2096979641] 'process raft request' (duration: 158.084146ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.080091Z","caller":"traceutil/trace.go:171","msg":"trace[1061571422] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"156.918992ms","start":"2026-07-23T23:45:15.923154Z","end":"2026-07-23T23:45:16.080073Z","steps":["trace[1061571422] 'process raft request' (duration: 156.84921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.080157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.697872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:45:16.080195Z","caller":"traceutil/trace.go:171","msg":"trace[475495815] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"116.766084ms","start":"2026-07-23T23:45:15.963419Z","end":"2026-07-23T23:45:16.080185Z","steps":["trace[475495815] 'agreement among raft nodes before linearized reading' (duration: 116.661851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.080204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.585784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:45:16.080308Z","caller":"traceutil/trace.go:171","msg":"trace[789635755] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"127.714359ms","start":"2026-07-23T23:45:15.952584Z","end":"2026-07-23T23:45:16.080298Z","steps":["trace[789635755] 'agreement among raft nodes before linearized reading' (duration: 127.586264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.331206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.816409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-23T23:45:16.331564Z","caller":"traceutil/trace.go:171","msg":"trace[877354311] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"233.524554ms","start":"2026-07-23T23:45:16.098006Z","end":"2026-07-23T23:45:16.331531Z","steps":["trace[877354311] 'process raft request' (duration: 233.365988ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.331743Z","caller":"traceutil/trace.go:171","msg":"trace[842389494] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"192.326063ms","start":"2026-07-23T23:45:16.1394Z","end":"2026-07-23T23:45:16.331726Z","steps":["trace[842389494] 'process raft request' (duration: 192.202919ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.331889Z","caller":"traceutil/trace.go:171","msg":"trace[604376164] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"232.319839ms","start":"2026-07-23T23:45:16.099493Z","end":"2026-07-23T23:45:16.331813Z","steps":["trace[604376164] 'process raft request' (duration: 232.051509ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.332136Z","caller":"traceutil/trace.go:171","msg":"trace[85781344] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:24; }","duration":"219.533461ms","start":"2026-07-23T23:45:16.112589Z","end":"2026-07-23T23:45:16.332123Z","steps":["trace[85781344] 'read index received' (duration: 82.35376ms)","trace[85781344] 'applied index is now lower than readState.Index' (duration: 137.172231ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:16.332351Z","caller":"traceutil/trace.go:171","msg":"trace[436404458] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"217.404861ms","start":"2026-07-23T23:45:16.114885Z","end":"2026-07-23T23:45:16.33229Z","steps":["trace[436404458] 'process raft request' (duration: 216.692865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.332558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.444431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:45:16.332636Z","caller":"traceutil/trace.go:171","msg":"trace[2128654326] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"233.553345ms","start":"2026-07-23T23:45:16.09907Z","end":"2026-07-23T23:45:16.332623Z","steps":["trace[2128654326] 'agreement among raft nodes before linearized reading' (duration: 233.294075ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.332761Z","caller":"traceutil/trace.go:171","msg":"trace[1317889147] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"233.727521ms","start":"2026-07-23T23:45:16.099018Z","end":"2026-07-23T23:45:16.332746Z","steps":["trace[1317889147] 'process raft request' (duration: 232.492135ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.332115Z","caller":"traceutil/trace.go:171","msg":"trace[1924608184] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"234.143977ms","start":"2026-07-23T23:45:16.097953Z","end":"2026-07-23T23:45:16.332097Z","steps":["trace[1924608184] 'process raft request' (duration: 96.978797ms)","trace[1924608184] 'compare' (duration: 135.724766ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:16.333079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.193154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-23T23:45:16.333295Z","caller":"traceutil/trace.go:171","msg":"trace[1797855201] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:28; }","duration":"236.451403ms","start":"2026-07-23T23:45:16.09683Z","end":"2026-07-23T23:45:16.333281Z","steps":["trace[1797855201] 'agreement among raft nodes before linearized reading' (duration: 236.013587ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.33343Z","caller":"traceutil/trace.go:171","msg":"trace[1566706877] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"234.886655ms","start":"2026-07-23T23:45:16.098516Z","end":"2026-07-23T23:45:16.333402Z","steps":["trace[1566706877] 'process raft request' (duration: 232.944422ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.331663Z","caller":"traceutil/trace.go:171","msg":"trace[530061457] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"233.047206ms","start":"2026-07-23T23:45:16.098536Z","end":"2026-07-23T23:45:16.331584Z","steps":["trace[530061457] 'process raft request' (duration: 232.951912ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.503663Z","caller":"traceutil/trace.go:171","msg":"trace[2035631772] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"167.11847ms","start":"2026-07-23T23:45:16.33652Z","end":"2026-07-23T23:45:16.503638Z","steps":["trace[2035631772] 'process raft request' (duration: 120.482895ms)","trace[2035631772] 'compare' (duration: 46.413406ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:16.50385Z","caller":"traceutil/trace.go:171","msg":"trace[55332077] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"165.913105ms","start":"2026-07-23T23:45:16.337921Z","end":"2026-07-23T23:45:16.503834Z","steps":["trace[55332077] 'process raft request' (duration: 165.872473ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.503945Z","caller":"traceutil/trace.go:171","msg":"trace[1874700646] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"167.238055ms","start":"2026-07-23T23:45:16.336694Z","end":"2026-07-23T23:45:16.503932Z","steps":["trace[1874700646] 'process raft request' (duration: 166.83868ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.50391Z","caller":"traceutil/trace.go:171","msg":"trace[1265557017] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"166.554859ms","start":"2026-07-23T23:45:16.337305Z","end":"2026-07-23T23:45:16.503859Z","steps":["trace[1265557017] 'process raft request' (duration: 166.31844ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.503874Z","caller":"traceutil/trace.go:171","msg":"trace[404690168] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"166.475726ms","start":"2026-07-23T23:45:16.337376Z","end":"2026-07-23T23:45:16.503852Z","steps":["trace[404690168] 'process raft request' (duration: 166.284198ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.504078Z","caller":"traceutil/trace.go:171","msg":"trace[128261060] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"166.433405ms","start":"2026-07-23T23:45:16.337634Z","end":"2026-07-23T23:45:16.504067Z","steps":["trace[128261060] 'process raft request' (duration: 166.05338ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.504197Z","caller":"traceutil/trace.go:171","msg":"trace[1578597745] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:33; }","duration":"131.352073ms","start":"2026-07-23T23:45:16.372823Z","end":"2026-07-23T23:45:16.504175Z","steps":["trace[1578597745] 'read index received' (duration: 84.192289ms)","trace[1578597745] 'applied index is now lower than readState.Index' (duration: 47.158684ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:16.504248Z","caller":"traceutil/trace.go:171","msg":"trace[1452068631] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"166.521938ms","start":"2026-07-23T23:45:16.337712Z","end":"2026-07-23T23:45:16.504233Z","steps":["trace[1452068631] 'process raft request' (duration: 166.000958ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:16.504297Z","caller":"traceutil/trace.go:171","msg":"trace[42649327] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"132.287458ms","start":"2026-07-23T23:45:16.371999Z","end":"2026-07-23T23:45:16.504286Z","steps":["trace[42649327] 'process raft request' (duration: 132.0826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:16.504391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.555691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-23T23:45:16.504444Z","caller":"traceutil/trace.go:171","msg":"trace[186897424] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:37; }","duration":"131.640303ms","start":"2026-07-23T23:45:16.372786Z","end":"2026-07-23T23:45:16.504426Z","steps":["trace[186897424] 'agreement among raft nodes before linearized reading' (duration: 131.493048ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:19.601469Z","caller":"traceutil/trace.go:171","msg":"trace[1741592055] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"233.638099ms","start":"2026-07-23T23:45:19.367803Z","end":"2026-07-23T23:45:19.601441Z","steps":["trace[1741592055] 'process raft request' (duration: 233.497504ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:19.864668Z","caller":"traceutil/trace.go:171","msg":"trace[645370520] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"472.067601ms","start":"2026-07-23T23:45:19.392576Z","end":"2026-07-23T23:45:19.864644Z","steps":["trace[645370520] 'process raft request' (duration: 472.03313ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.86484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.392558Z","time spent":"472.192845ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:19.864838Z","caller":"traceutil/trace.go:171","msg":"trace[586605135] transaction","detail":"{read_only:false; number_of_response:0; response_revision:230; }","duration":"496.416743ms","start":"2026-07-23T23:45:19.368368Z","end":"2026-07-23T23:45:19.864785Z","steps":["trace[586605135] 'process raft request' (duration: 461.373394ms)","trace[586605135] 'compare' (duration: 34.602293ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:19.865013Z","caller":"traceutil/trace.go:171","msg":"trace[1109710007] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"476.7231ms","start":"2026-07-23T23:45:19.388263Z","end":"2026-07-23T23:45:19.864986Z","steps":["trace[1109710007] 'process raft request' (duration: 476.222632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.865065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.36834Z","time spent":"496.639061ms","remote":"127.0.0.1:60366","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:19.865107Z","caller":"traceutil/trace.go:171","msg":"trace[752050236] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"475.06821ms","start":"2026-07-23T23:45:19.390027Z","end":"2026-07-23T23:45:19.865095Z","steps":["trace[752050236] 'process raft request' (duration: 474.561601ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:19.865106Z","caller":"traceutil/trace.go:171","msg":"trace[524026272] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"475.110452ms","start":"2026-07-23T23:45:19.389963Z","end":"2026-07-23T23:45:19.865073Z","steps":["trace[524026272] 'process raft request' (duration: 474.594533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.865191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.39002Z","time spent":"475.115681ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:19.865244Z","caller":"traceutil/trace.go:171","msg":"trace[2101484832] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"489.925547ms","start":"2026-07-23T23:45:19.375293Z","end":"2026-07-23T23:45:19.865218Z","steps":["trace[2101484832] 'process raft request' (duration: 489.117988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.865197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.388249Z","time spent":"476.834204ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:45:19.865288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.389948Z","time spent":"475.266987ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:19.865308Z","caller":"traceutil/trace.go:171","msg":"trace[1514976216] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"476.796452ms","start":"2026-07-23T23:45:19.388455Z","end":"2026-07-23T23:45:19.865252Z","steps":["trace[1514976216] 'process raft request' (duration: 476.072136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.865333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.375267Z","time spent":"490.025791ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:45:19.865416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.388447Z","time spent":"476.917506ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:19.934595Z","caller":"traceutil/trace.go:171","msg":"trace[816962472] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"329.799651ms","start":"2026-07-23T23:45:19.604761Z","end":"2026-07-23T23:45:19.934561Z","steps":["trace[816962472] 'process raft request' (duration: 329.240471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:19.93475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:19.604732Z","time spent":"329.949296ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:45:38.397616Z","caller":"traceutil/trace.go:171","msg":"trace[1252694935] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"298.224992ms","start":"2026-07-23T23:45:38.099366Z","end":"2026-07-23T23:45:38.397591Z","steps":["trace[1252694935] 'read index received' (duration: 298.009066ms)","trace[1252694935] 'applied index is now lower than readState.Index' (duration: 214.986µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:38.397744Z","caller":"traceutil/trace.go:171","msg":"trace[2132117301] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"311.57984ms","start":"2026-07-23T23:45:38.086141Z","end":"2026-07-23T23:45:38.397721Z","steps":["trace[2132117301] 'process raft request' (duration: 311.299962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:38.397852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.458919ms","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-07-23T23:45:38.397956Z","caller":"traceutil/trace.go:171","msg":"trace[1048332826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:397; }","duration":"298.603474ms","start":"2026-07-23T23:45:38.099332Z","end":"2026-07-23T23:45:38.397935Z","steps":["trace[1048332826] 'agreement among raft nodes before linearized reading' (duration: 298.397627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:38.398195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:38.086115Z","time spent":"311.696804ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:45:38.807102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.187182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:38.807211Z","caller":"traceutil/trace.go:171","msg":"trace[353628174] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"404.649465ms","start":"2026-07-23T23:45:38.402543Z","end":"2026-07-23T23:45:38.807193Z","steps":["trace[353628174] 'process raft request' (duration: 63.280177ms)","trace[353628174] 'compare' (duration: 341.052729ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:38.807272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:38.402523Z","time spent":"404.720947ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:45:48.484376Z","caller":"traceutil/trace.go:171","msg":"trace[2039707349] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"503.857433ms","start":"2026-07-23T23:45:47.980488Z","end":"2026-07-23T23:45:48.484345Z","steps":["trace[2039707349] 'process raft request' (duration: 503.684198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:48.484564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:47.98046Z","time spent":"504.007307ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:45:48.487611Z","caller":"traceutil/trace.go:171","msg":"trace[600770490] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:443; }","duration":"330.759459ms","start":"2026-07-23T23:45:48.156812Z","end":"2026-07-23T23:45:48.487571Z","steps":["trace[600770490] 'read index received' (duration: 327.456309ms)","trace[600770490] 'applied index is now lower than readState.Index' (duration: 3.30166ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:48.487698Z","caller":"traceutil/trace.go:171","msg":"trace[362919860] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"503.272196ms","start":"2026-07-23T23:45:47.984395Z","end":"2026-07-23T23:45:48.487668Z","steps":["trace[362919860] 'process raft request' (duration: 502.972888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:48.487872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:47.984358Z","time spent":"503.434461ms","remote":"127.0.0.1:60464","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-07-23T23:45:48.487875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.485416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:45:48.488002Z","caller":"traceutil/trace.go:171","msg":"trace[695498122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"290.62862ms","start":"2026-07-23T23:45:48.197329Z","end":"2026-07-23T23:45:48.487957Z","steps":["trace[695498122] 'agreement among raft nodes before linearized reading' (duration: 290.457056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:48.488111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.254503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12665"} {"level":"info","ts":"2026-07-23T23:45:48.488213Z","caller":"traceutil/trace.go:171","msg":"trace[542399535] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:425; }","duration":"331.415917ms","start":"2026-07-23T23:45:48.15674Z","end":"2026-07-23T23:45:48.488156Z","steps":["trace[542399535] 'agreement among raft nodes before linearized reading' (duration: 331.022566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:48.488331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:48.156714Z","time spent":"331.596042ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12688,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-07-23T23:45:50.804156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.377959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:50.804421Z","caller":"traceutil/trace.go:171","msg":"trace[35024850] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"281.153206ms","start":"2026-07-23T23:45:50.523235Z","end":"2026-07-23T23:45:50.804389Z","steps":["trace[35024850] 'process raft request' (duration: 82.430148ms)","trace[35024850] 'compare' (duration: 198.194574ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:51.826058Z","caller":"traceutil/trace.go:171","msg":"trace[911500102] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"100.860416ms","start":"2026-07-23T23:45:51.725169Z","end":"2026-07-23T23:45:51.826029Z","steps":["trace[911500102] 'process raft request' (duration: 56.670978ms)","trace[911500102] 'compare' (duration: 44.033663ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:52.024856Z","caller":"traceutil/trace.go:171","msg":"trace[1656208134] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"158.481342ms","start":"2026-07-23T23:45:51.866348Z","end":"2026-07-23T23:45:52.02483Z","steps":["trace[1656208134] 'process raft request' (duration: 133.821376ms)","trace[1656208134] 'compare' (duration: 24.479402ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:52.094434Z","caller":"traceutil/trace.go:171","msg":"trace[621069019] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"191.952651ms","start":"2026-07-23T23:45:51.902459Z","end":"2026-07-23T23:45:52.094411Z","steps":["trace[621069019] 'process raft request' (duration: 191.784476ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:52.120752Z","caller":"traceutil/trace.go:171","msg":"trace[466603359] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"113.583385ms","start":"2026-07-23T23:45:52.00714Z","end":"2026-07-23T23:45:52.120723Z","steps":["trace[466603359] 'process raft request' (duration: 112.807795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.203406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.000399ms","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-07-23T23:45:53.203537Z","caller":"traceutil/trace.go:171","msg":"trace[13609692] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:534; }","duration":"860.139722ms","start":"2026-07-23T23:45:52.343378Z","end":"2026-07-23T23:45:53.203518Z","steps":["trace[13609692] 'range keys from in-memory index tree' (duration: 859.985618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.203565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.312217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:53.203739Z","caller":"traceutil/trace.go:171","msg":"trace[1739278491] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:554; }","duration":"964.449854ms","start":"2026-07-23T23:45:52.239263Z","end":"2026-07-23T23:45:53.203713Z","steps":["trace[1739278491] 'read index received' (duration: 25.21327ms)","trace[1739278491] 'applied index is now lower than readState.Index' (duration: 939.235414ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:53.203881Z","caller":"traceutil/trace.go:171","msg":"trace[242361308] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"966.392576ms","start":"2026-07-23T23:45:52.237447Z","end":"2026-07-23T23:45:53.203839Z","steps":["trace[242361308] 'process raft request' (duration: 520.76523ms)","trace[242361308] 'compare' (duration: 445.192314ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:53.204018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.237416Z","time spent":"966.55135ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:45:53.204329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.0623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:45:53.204369Z","caller":"traceutil/trace.go:171","msg":"trace[375538589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"965.164223ms","start":"2026-07-23T23:45:52.239197Z","end":"2026-07-23T23:45:53.204361Z","steps":["trace[375538589] 'agreement among raft nodes before linearized reading' (duration: 964.729982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.204391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.239188Z","time spent":"965.198324ms","remote":"127.0.0.1:60158","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-07-23T23:45:53.23368Z","caller":"traceutil/trace.go:171","msg":"trace[403879756] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"940.49049ms","start":"2026-07-23T23:45:52.293176Z","end":"2026-07-23T23:45:53.233667Z","steps":["trace[403879756] 'process raft request' (duration: 940.259794ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:53.233943Z","caller":"traceutil/trace.go:171","msg":"trace[366634937] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"841.783245ms","start":"2026-07-23T23:45:52.392144Z","end":"2026-07-23T23:45:53.233927Z","steps":["trace[366634937] 'process raft request' (duration: 841.535719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.234066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.392125Z","time spent":"841.871127ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:45:53.234093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.293143Z","time spent":"940.87048ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20851,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:45:53.256548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.702016ms","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-07-23T23:45:53.256605Z","caller":"traceutil/trace.go:171","msg":"trace[1257109712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"731.805728ms","start":"2026-07-23T23:45:52.524787Z","end":"2026-07-23T23:45:53.256593Z","steps":["trace[1257109712] 'agreement among raft nodes before linearized reading' (duration: 731.702756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.256666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.524766Z","time spent":"731.891651ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:45:53.256818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.969385ms","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-07-23T23:45:53.256858Z","caller":"traceutil/trace.go:171","msg":"trace[1052033905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"734.069268ms","start":"2026-07-23T23:45:52.522777Z","end":"2026-07-23T23:45:53.256847Z","steps":["trace[1052033905] 'agreement among raft nodes before linearized reading' (duration: 733.981636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.256881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.522762Z","time spent":"734.113309ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-23T23:45:53.257072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.296202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-23T23:45:53.257103Z","caller":"traceutil/trace.go:171","msg":"trace[909320118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"330.366024ms","start":"2026-07-23T23:45:52.926729Z","end":"2026-07-23T23:45:53.257095Z","steps":["trace[909320118] 'agreement among raft nodes before linearized reading' (duration: 329.674506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.257121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.926705Z","time spent":"330.412125ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-23T23:45:53.257046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.133688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:45:53.257334Z","caller":"traceutil/trace.go:171","msg":"trace[860101469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"448.642822ms","start":"2026-07-23T23:45:52.808662Z","end":"2026-07-23T23:45:53.257305Z","steps":["trace[860101469] 'agreement among raft nodes before linearized reading' (duration: 447.867292ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:53.257916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:52.808641Z","time spent":"449.262498ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:45:53.791766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.892813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:53.791876Z","caller":"traceutil/trace.go:171","msg":"trace[183437762] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"234.862367ms","start":"2026-07-23T23:45:53.556999Z","end":"2026-07-23T23:45:53.791861Z","steps":["trace[183437762] 'read index received' (duration: 15.739678ms)","trace[183437762] 'applied index is now lower than readState.Index' (duration: 219.121679ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:53.792024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.019961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-07-23T23:45:53.792059Z","caller":"traceutil/trace.go:171","msg":"trace[1536459763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:546; }","duration":"235.077043ms","start":"2026-07-23T23:45:53.556972Z","end":"2026-07-23T23:45:53.792049Z","steps":["trace[1536459763] 'agreement among raft nodes before linearized reading' (duration: 234.93587ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:53.79239Z","caller":"traceutil/trace.go:171","msg":"trace[1893668596] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"247.496976ms","start":"2026-07-23T23:45:53.544875Z","end":"2026-07-23T23:45:53.792372Z","steps":["trace[1893668596] 'process raft request' (duration: 27.919545ms)","trace[1893668596] 'compare' (duration: 218.764549ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:54.3472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.162368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:54.347287Z","caller":"traceutil/trace.go:171","msg":"trace[1286644870] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"500.744922ms","start":"2026-07-23T23:45:53.846531Z","end":"2026-07-23T23:45:54.347276Z","steps":["trace[1286644870] 'read index received' (duration: 284.039135ms)","trace[1286644870] 'applied index is now lower than readState.Index' (duration: 216.704617ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:54.347352Z","caller":"traceutil/trace.go:171","msg":"trace[2133021457] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"502.048186ms","start":"2026-07-23T23:45:53.845272Z","end":"2026-07-23T23:45:54.34732Z","steps":["trace[2133021457] 'process raft request' (duration: 285.600956ms)","trace[2133021457] 'compare' (duration: 214.8614ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:54.347424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.886186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-07-23T23:45:54.347476Z","caller":"traceutil/trace.go:171","msg":"trace[611812888] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:547; }","duration":"500.952988ms","start":"2026-07-23T23:45:53.846515Z","end":"2026-07-23T23:45:54.347468Z","steps":["trace[611812888] 'agreement among raft nodes before linearized reading' (duration: 500.792474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:54.347508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:53.846508Z","time spent":"500.991529ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":98736,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-07-23T23:45:54.347508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:53.845259Z","time spent":"502.156479ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:45:54.747383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.529603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:45:54.747428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.645316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:45:54.747477Z","caller":"traceutil/trace.go:171","msg":"trace[2013198395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:547; }","duration":"183.733039ms","start":"2026-07-23T23:45:54.563734Z","end":"2026-07-23T23:45:54.747467Z","steps":["trace[2013198395] 'count revisions from in-memory index tree' (duration: 183.520253ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:54.747475Z","caller":"traceutil/trace.go:171","msg":"trace[804639488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:547; }","duration":"183.645577ms","start":"2026-07-23T23:45:54.563812Z","end":"2026-07-23T23:45:54.747458Z","steps":["trace[804639488] 'range keys from in-memory index tree' (duration: 183.473501ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:54.747543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.114102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:45:54.747636Z","caller":"traceutil/trace.go:171","msg":"trace[195864703] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:547; }","duration":"183.248286ms","start":"2026-07-23T23:45:54.564366Z","end":"2026-07-23T23:45:54.747614Z","steps":["trace[195864703] 'range keys from in-memory index tree' (duration: 183.067762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:54.747762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.71031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-07-23T23:45:54.747894Z","caller":"traceutil/trace.go:171","msg":"trace[2030956874] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:547; }","duration":"199.903895ms","start":"2026-07-23T23:45:54.547965Z","end":"2026-07-23T23:45:54.747869Z","steps":["trace[2030956874] 'range keys from in-memory index tree' (duration: 199.436223ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.650213Z","caller":"traceutil/trace.go:171","msg":"trace[1845362362] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"455.155974ms","start":"2026-07-23T23:45:59.195039Z","end":"2026-07-23T23:45:59.650195Z","steps":["trace[1845362362] 'read index received' (duration: 454.479437ms)","trace[1845362362] 'applied index is now lower than readState.Index' (duration: 676.027µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:45:59.650337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.292907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:45:59.650322Z","caller":"traceutil/trace.go:171","msg":"trace[196782590] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"475.016694ms","start":"2026-07-23T23:45:59.175266Z","end":"2026-07-23T23:45:59.650283Z","steps":["trace[196782590] 'process raft request' (duration: 474.531322ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.650434Z","caller":"traceutil/trace.go:171","msg":"trace[180271059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"455.368019ms","start":"2026-07-23T23:45:59.194982Z","end":"2026-07-23T23:45:59.65035Z","steps":["trace[180271059] 'agreement among raft nodes before linearized reading' (duration: 455.307148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:59.650468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.19496Z","time spent":"455.497782ms","remote":"127.0.0.1:60158","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-07-23T23:45:59.650489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.388612ms","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-07-23T23:45:59.650546Z","caller":"traceutil/trace.go:171","msg":"trace[1474200776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"316.503665ms","start":"2026-07-23T23:45:59.334028Z","end":"2026-07-23T23:45:59.650531Z","steps":["trace[1474200776] 'agreement among raft nodes before linearized reading' (duration: 316.30185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:59.65054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.175239Z","time spent":"475.198818ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:45:59.650579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.334017Z","time spent":"316.555236ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-23T23:45:59.650581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.267491ms","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-07-23T23:45:59.65069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.545796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:45:59.650778Z","caller":"traceutil/trace.go:171","msg":"trace[603651151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"316.843923ms","start":"2026-07-23T23:45:59.333911Z","end":"2026-07-23T23:45:59.650755Z","steps":["trace[603651151] 'agreement among raft nodes before linearized reading' (duration: 316.593607ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:59.650754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.510672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hm4zq\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-07-23T23:45:59.650829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.333877Z","time spent":"316.944236ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-23T23:45:59.650855Z","caller":"traceutil/trace.go:171","msg":"trace[1877620970] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hm4zq; range_end:; response_count:1; response_revision:575; }","duration":"266.694146ms","start":"2026-07-23T23:45:59.384136Z","end":"2026-07-23T23:45:59.650831Z","steps":["trace[1877620970] 'agreement among raft nodes before linearized reading' (duration: 266.356868ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.65064Z","caller":"traceutil/trace.go:171","msg":"trace[798017627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"312.341302ms","start":"2026-07-23T23:45:59.338279Z","end":"2026-07-23T23:45:59.650621Z","steps":["trace[798017627] 'agreement among raft nodes before linearized reading' (duration: 312.166128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:59.651365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.338272Z","time spent":"313.07608ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:45:59.653826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.620683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-23T23:45:59.653937Z","caller":"traceutil/trace.go:171","msg":"trace[1668574001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"315.721886ms","start":"2026-07-23T23:45:59.338168Z","end":"2026-07-23T23:45:59.65389Z","steps":["trace[1668574001] 'agreement among raft nodes before linearized reading' (duration: 312.280781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:45:59.653993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:45:59.338115Z","time spent":"315.863569ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-23T23:45:59.941715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.869381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:45:59.941865Z","caller":"traceutil/trace.go:171","msg":"trace[1781026433] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"286.065754ms","start":"2026-07-23T23:45:59.655782Z","end":"2026-07-23T23:45:59.941848Z","steps":["trace[1781026433] 'process raft request' (duration: 91.981958ms)","trace[1781026433] 'compare' (duration: 193.733267ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:45:59.942129Z","caller":"traceutil/trace.go:171","msg":"trace[1166600474] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"285.87955ms","start":"2026-07-23T23:45:59.656239Z","end":"2026-07-23T23:45:59.942118Z","steps":["trace[1166600474] 'process raft request' (duration: 285.566482ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.942226Z","caller":"traceutil/trace.go:171","msg":"trace[1724861128] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"285.871189ms","start":"2026-07-23T23:45:59.656332Z","end":"2026-07-23T23:45:59.942204Z","steps":["trace[1724861128] 'process raft request' (duration: 285.682444ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.942286Z","caller":"traceutil/trace.go:171","msg":"trace[851224763] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"280.23255ms","start":"2026-07-23T23:45:59.662047Z","end":"2026-07-23T23:45:59.942279Z","steps":["trace[851224763] 'process raft request' (duration: 280.113567ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.942263Z","caller":"traceutil/trace.go:171","msg":"trace[236988927] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"235.242311ms","start":"2026-07-23T23:45:59.707001Z","end":"2026-07-23T23:45:59.942243Z","steps":["trace[236988927] 'process raft request' (duration: 235.19019ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.942238Z","caller":"traceutil/trace.go:171","msg":"trace[1353948606] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"280.313392ms","start":"2026-07-23T23:45:59.661902Z","end":"2026-07-23T23:45:59.942215Z","steps":["trace[1353948606] 'process raft request' (duration: 280.21011ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:45:59.966888Z","caller":"traceutil/trace.go:171","msg":"trace[1033753863] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"217.600926ms","start":"2026-07-23T23:45:59.749264Z","end":"2026-07-23T23:45:59.966865Z","steps":["trace[1033753863] 'process raft request' (duration: 217.36451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:00.403858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.094984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:46:00.403914Z","caller":"traceutil/trace.go:171","msg":"trace[633587094] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"207.158125ms","start":"2026-07-23T23:46:00.196743Z","end":"2026-07-23T23:46:00.403901Z","steps":["trace[633587094] 'range keys from in-memory index tree' (duration: 207.011622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.200967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000011924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-23T23:46:03.20107Z","caller":"traceutil/trace.go:171","msg":"trace[1284492213] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000162367s","start":"2026-07-23T23:46:01.200883Z","end":"2026-07-23T23:46:03.201045Z","steps":["trace[1284492213] 'agreement among raft nodes before linearized reading' (duration: 2.000038305s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.201134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:01.200865Z","time spent":"2.000254229s","remote":"127.0.0.1:60174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/23 23:46:03 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-23T23:46:03.713956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370318139s","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-07-23T23:46:03.714149Z","caller":"traceutil/trace.go:171","msg":"trace[877203793] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:583; }","duration":"1.370459082s","start":"2026-07-23T23:46:02.343609Z","end":"2026-07-23T23:46:03.714069Z","steps":["trace[877203793] 'range keys from in-memory index tree' (duration: 1.370302899s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.715929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.147970156s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:46:03.716572Z","caller":"traceutil/trace.go:171","msg":"trace[509041123] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"3.216247956s","start":"2026-07-23T23:46:00.500279Z","end":"2026-07-23T23:46:03.716527Z","steps":["trace[509041123] 'process raft request' (duration: 67.622804ms)","trace[509041123] 'compare' (duration: 3.146098692s)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:46:03.716632Z","caller":"traceutil/trace.go:171","msg":"trace[315639677] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"2.515686436s","start":"2026-07-23T23:46:01.200923Z","end":"2026-07-23T23:46:03.716609Z","steps":["trace[315639677] 'read index received' (duration: 48.651µs)","trace[315639677] 'applied index is now lower than readState.Index' (duration: 2.515633905s)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:46:03.717402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:00.500231Z","time spent":"3.21641076s","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:46:03.852897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.904197862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-23T23:46:03.85292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.555604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:46:03.852939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.904417547s","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-07-23T23:46:03.852984Z","caller":"traceutil/trace.go:171","msg":"trace[1027841789] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"135.974344ms","start":"2026-07-23T23:46:03.716672Z","end":"2026-07-23T23:46:03.852647Z","steps":["trace[1027841789] 'read index received' (duration: 75.02206ms)","trace[1027841789] 'applied index is now lower than readState.Index' (duration: 60.950094ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:46:03.853079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906802646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:46:03.853134Z","caller":"traceutil/trace.go:171","msg":"trace[2138391805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"1.906897778s","start":"2026-07-23T23:46:01.946223Z","end":"2026-07-23T23:46:03.853121Z","steps":["trace[2138391805] 'agreement among raft nodes before linearized reading' (duration: 1.906754305s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:03.852986Z","caller":"traceutil/trace.go:171","msg":"trace[2028694556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.904314616s","start":"2026-07-23T23:46:01.948651Z","end":"2026-07-23T23:46:03.852966Z","steps":["trace[2028694556] 'agreement among raft nodes before linearized reading' (duration: 1.90406975s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.853202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:01.9462Z","time spent":"1.90699242s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-23T23:46:03.853269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.357682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-23T23:46:03.853316Z","caller":"traceutil/trace.go:171","msg":"trace[1545012756] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:584; }","duration":"133.435073ms","start":"2026-07-23T23:46:03.71987Z","end":"2026-07-23T23:46:03.853305Z","steps":["trace[1545012756] 'agreement among raft nodes before linearized reading' (duration: 133.33989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.853241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:01.948641Z","time spent":"1.904582402s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-23T23:46:03.852896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.90410465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-23T23:46:03.853429Z","caller":"traceutil/trace.go:171","msg":"trace[1372632432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"1.904697544s","start":"2026-07-23T23:46:01.948716Z","end":"2026-07-23T23:46:03.853413Z","steps":["trace[1372632432] 'agreement among raft nodes before linearized reading' (duration: 1.903982207s)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:03.853003Z","caller":"traceutil/trace.go:171","msg":"trace[1654389491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"651.699467ms","start":"2026-07-23T23:46:03.201282Z","end":"2026-07-23T23:46:03.852981Z","steps":["trace[1654389491] 'agreement among raft nodes before linearized reading' (duration: 651.542793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.853668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:03.20126Z","time spent":"652.396183ms","remote":"127.0.0.1:60158","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-07-23T23:46:03.853006Z","caller":"traceutil/trace.go:171","msg":"trace[439175776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.90453001s","start":"2026-07-23T23:46:01.94846Z","end":"2026-07-23T23:46:03.85299Z","steps":["trace[439175776] 'agreement among raft nodes before linearized reading' (duration: 1.904317755s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:03.853821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:01.948438Z","time spent":"1.90535583s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-23T23:46:03.853512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:01.948696Z","time spent":"1.904801216s","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-23T23:46:06.818024Z","caller":"traceutil/trace.go:171","msg":"trace[422843672] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"161.207795ms","start":"2026-07-23T23:46:06.656792Z","end":"2026-07-23T23:46:06.817999Z","steps":["trace[422843672] 'process raft request' (duration: 161.071671ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:13.331431Z","caller":"traceutil/trace.go:171","msg":"trace[1340385950] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:729; }","duration":"133.879652ms","start":"2026-07-23T23:46:13.197526Z","end":"2026-07-23T23:46:13.331406Z","steps":["trace[1340385950] 'read index received' (duration: 131.601242ms)","trace[1340385950] 'applied index is now lower than readState.Index' (duration: 2.27742ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:46:13.331572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.042496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:46:13.331561Z","caller":"traceutil/trace.go:171","msg":"trace[1010430702] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"186.192336ms","start":"2026-07-23T23:46:13.145338Z","end":"2026-07-23T23:46:13.33153Z","steps":["trace[1010430702] 'process raft request' (duration: 183.704281ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:13.331606Z","caller":"traceutil/trace.go:171","msg":"trace[46383169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:703; }","duration":"134.134698ms","start":"2026-07-23T23:46:13.197462Z","end":"2026-07-23T23:46:13.331597Z","steps":["trace[46383169] 'agreement among raft nodes before linearized reading' (duration: 134.042706ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:13.347493Z","caller":"traceutil/trace.go:171","msg":"trace[1538369848] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"143.202868ms","start":"2026-07-23T23:46:13.204272Z","end":"2026-07-23T23:46:13.347475Z","steps":["trace[1538369848] 'process raft request' (duration: 142.972043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:19.089914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656054232291858236,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-23T23:46:19.234946Z","caller":"traceutil/trace.go:171","msg":"trace[407064931] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:774; }","duration":"646.087808ms","start":"2026-07-23T23:46:18.588831Z","end":"2026-07-23T23:46:19.234919Z","steps":["trace[407064931] 'read index received' (duration: 645.919535ms)","trace[407064931] 'applied index is now lower than readState.Index' (duration: 166.683µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:46:19.23505Z","caller":"traceutil/trace.go:171","msg":"trace[2003489975] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"746.127965ms","start":"2026-07-23T23:46:18.488894Z","end":"2026-07-23T23:46:19.235021Z","steps":["trace[2003489975] 'process raft request' (duration: 745.853709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:19.235187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:18.488874Z","time spent":"746.235086ms","remote":"127.0.0.1:60372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:46:19.235243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.398095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-23T23:46:19.235297Z","caller":"traceutil/trace.go:171","msg":"trace[325949074] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:747; }","duration":"646.501637ms","start":"2026-07-23T23:46:18.58878Z","end":"2026-07-23T23:46:19.235282Z","steps":["trace[325949074] 'agreement among raft nodes before linearized reading' (duration: 646.321503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:19.235358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:18.588764Z","time spent":"646.579859ms","remote":"127.0.0.1:60464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-23T23:46:19.235436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.833139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:46:19.235524Z","caller":"traceutil/trace.go:171","msg":"trace[78821087] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:747; }","duration":"523.977633ms","start":"2026-07-23T23:46:18.711528Z","end":"2026-07-23T23:46:19.235505Z","steps":["trace[78821087] 'agreement among raft nodes before linearized reading' (duration: 523.806909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:46:19.23557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:46:18.71151Z","time spent":"524.050484ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-07-23T23:46:19.443474Z","caller":"traceutil/trace.go:171","msg":"trace[118680057] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"203.991365ms","start":"2026-07-23T23:46:19.239454Z","end":"2026-07-23T23:46:19.443446Z","steps":["trace[118680057] 'process raft request' (duration: 191.880739ms)","trace[118680057] 'compare' (duration: 11.993553ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:46:35.786244Z","caller":"traceutil/trace.go:171","msg":"trace[380946634] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"124.164654ms","start":"2026-07-23T23:46:35.662059Z","end":"2026-07-23T23:46:35.786223Z","steps":["trace[380946634] 'process raft request' (duration: 124.048022ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:46:49.985491Z","caller":"traceutil/trace.go:171","msg":"trace[39295689] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"153.153738ms","start":"2026-07-23T23:46:49.832315Z","end":"2026-07-23T23:46:49.985469Z","steps":["trace[39295689] 'process raft request' (duration: 153.016946ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:47:04.453839Z","caller":"traceutil/trace.go:171","msg":"trace[1883113353] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1066; }","duration":"147.407362ms","start":"2026-07-23T23:47:04.306399Z","end":"2026-07-23T23:47:04.453806Z","steps":["trace[1883113353] 'read index received' (duration: 1.727058ms)","trace[1883113353] 'applied index is now lower than readState.Index' (duration: 145.679014ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:47:04.45399Z","caller":"traceutil/trace.go:171","msg":"trace[251501742] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"149.226751ms","start":"2026-07-23T23:47:04.304729Z","end":"2026-07-23T23:47:04.453956Z","steps":["trace[251501742] 'process raft request' (duration: 147.614405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:47:04.454156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.721967ms","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-07-23T23:47:04.454228Z","caller":"traceutil/trace.go:171","msg":"trace[1028306420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1028; }","duration":"147.846529ms","start":"2026-07-23T23:47:04.306353Z","end":"2026-07-23T23:47:04.4542Z","steps":["trace[1028306420] 'agreement among raft nodes before linearized reading' (duration: 147.576745ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:47:15.920642Z","caller":"traceutil/trace.go:171","msg":"trace[2075570001] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"111.491065ms","start":"2026-07-23T23:47:15.809128Z","end":"2026-07-23T23:47:15.920619Z","steps":["trace[2075570001] 'process raft request' (duration: 111.230641ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:47:16.832825Z","caller":"traceutil/trace.go:171","msg":"trace[526248618] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"236.519226ms","start":"2026-07-23T23:47:16.596276Z","end":"2026-07-23T23:47:16.832795Z","steps":["trace[526248618] 'process raft request' (duration: 206.998741ms)","trace[526248618] 'compare' (duration: 29.341922ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:47:42.708382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.843506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-23T23:47:42.708515Z","caller":"traceutil/trace.go:171","msg":"trace[2042804422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1151; }","duration":"140.970938ms","start":"2026-07-23T23:47:42.567502Z","end":"2026-07-23T23:47:42.708473Z","steps":["trace[2042804422] 'range keys from in-memory index tree' (duration: 140.677643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:47:42.780118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.000472ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-23T23:47:42.780559Z","caller":"traceutil/trace.go:171","msg":"trace[1945043498] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"175.302462ms","start":"2026-07-23T23:47:42.605232Z","end":"2026-07-23T23:47:42.780534Z","steps":["trace[1945043498] 'process raft request' (duration: 175.012668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:47:47.17266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.650397ms","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-07-23T23:47:47.172753Z","caller":"traceutil/trace.go:171","msg":"trace[211397601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1166; }","duration":"107.811519ms","start":"2026-07-23T23:47:47.064922Z","end":"2026-07-23T23:47:47.172733Z","steps":["trace[211397601] 'range keys from in-memory index tree' (duration: 107.445134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:47:47.174177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.521667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-07-23T23:47:47.174343Z","caller":"traceutil/trace.go:171","msg":"trace[199608145] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1166; }","duration":"151.76113ms","start":"2026-07-23T23:47:47.022555Z","end":"2026-07-23T23:47:47.174316Z","steps":["trace[199608145] 'range keys from in-memory index tree' (duration: 149.849733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:06.898344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.51101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-23T23:48:06.898425Z","caller":"traceutil/trace.go:171","msg":"trace[434425097] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1261; }","duration":"126.656682ms","start":"2026-07-23T23:48:06.771753Z","end":"2026-07-23T23:48:06.89841Z","steps":["trace[434425097] 'count revisions from in-memory index tree' (duration: 126.425319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:33.972518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.829307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-scheduler\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-07-23T23:48:33.972624Z","caller":"traceutil/trace.go:171","msg":"trace[1233907312] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-scheduler; range_end:; response_count:1; response_revision:1362; }","duration":"101.007279ms","start":"2026-07-23T23:48:33.871594Z","end":"2026-07-23T23:48:33.972601Z","steps":["trace[1233907312] 'range keys from in-memory index tree' (duration: 100.703165ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:35.564226Z","caller":"traceutil/trace.go:171","msg":"trace[1901236611] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"113.526484ms","start":"2026-07-23T23:48:35.450673Z","end":"2026-07-23T23:48:35.564199Z","steps":["trace[1901236611] 'process raft request' (duration: 113.388642ms)"],"step_count":1}