{"level":"warn","ts":"2026-08-18T23:25:25.240296Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-18T23:25:25.240406Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-18T23:25:25.240479Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-18T23:25:25.240495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-08-18T23:25:25.240515Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-18T23:25:25.241277Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-08-18T23:25:25.241364Z","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.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-18T23:25:25.245891Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.26297ms"} {"level":"info","ts":"2026-08-18T23:25:25.258221Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-08-18T23:25:25.258289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-08-18T23:25:25.25831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-08-18T23:25:25.25832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-18T23:25:25.258328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-08-18T23:25:25.258362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-08-18T23:25:25.264941Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-18T23:25:25.267279Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-18T23:25:25.268547Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-18T23:25:25.27073Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-18T23:25:25.271572Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-18T23:25:25.271675Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-18T23:25:25.272306Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-18T23:25:25.272341Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-18T23:25:25.276438Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-18T23:25:25.27673Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-08-18T23:25:25.27677Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-08-18T23:25:25.277964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-08-18T23:25:25.278175Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-08-18T23:25:25.278172Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-18T23:25:25.278213Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-18T23:25:26.158932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-08-18T23:25:26.158986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-18T23:25:26.159027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-08-18T23:25:26.159067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-08-18T23:25:26.159078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-08-18T23:25:26.159094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-08-18T23:25:26.159107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-08-18T23:25:26.251008Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-08-18T23:25:26.251029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-18T23:25:26.251106Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-18T23:25:26.25111Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-18T23:25:26.251365Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-18T23:25:26.2514Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-18T23:25:26.2547Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-18T23:25:26.255116Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-08-18T23:25:26.266649Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-08-18T23:25:26.266782Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-18T23:25:26.266814Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-18T23:25:26.721579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.671317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.721715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.796411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.721839Z","caller":"traceutil/trace.go:171","msg":"trace[1283483559] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"157.931264ms","start":"2026-08-18T23:25:26.563866Z","end":"2026-08-18T23:25:26.721798Z","steps":["trace[1283483559] 'count revisions from in-memory index tree' (duration: 157.75111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.72188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.831101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.721789Z","caller":"traceutil/trace.go:171","msg":"trace[807133912] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"206.028205ms","start":"2026-08-18T23:25:26.515735Z","end":"2026-08-18T23:25:26.721764Z","steps":["trace[807133912] 'range keys from in-memory index tree' (duration: 205.552375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.721979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.518153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.721998Z","caller":"traceutil/trace.go:171","msg":"trace[1175748196] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"134.569155ms","start":"2026-08-18T23:25:26.587425Z","end":"2026-08-18T23:25:26.721995Z","steps":["trace[1175748196] 'range keys from in-memory index tree' (duration: 134.436011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.722143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.014214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.722258Z","caller":"traceutil/trace.go:171","msg":"trace[794823136] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"109.171647ms","start":"2026-08-18T23:25:26.613057Z","end":"2026-08-18T23:25:26.722229Z","steps":["trace[794823136] 'range keys from in-memory index tree' (duration: 108.89237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.722222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.167603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.722416Z","caller":"traceutil/trace.go:171","msg":"trace[860057587] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"122.441819ms","start":"2026-08-18T23:25:26.59994Z","end":"2026-08-18T23:25:26.722382Z","steps":["trace[860057587] 'count revisions from in-memory index tree' (duration: 122.090071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.722515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.969714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.722534Z","caller":"traceutil/trace.go:171","msg":"trace[1217216204] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1; }","duration":"135.005575ms","start":"2026-08-18T23:25:26.587523Z","end":"2026-08-18T23:25:26.722529Z","steps":["trace[1217216204] 'count revisions from in-memory index tree' (duration: 134.937804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.722551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.416078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.722599Z","caller":"traceutil/trace.go:171","msg":"trace[1902195522] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1; }","duration":"122.48445ms","start":"2026-08-18T23:25:26.600092Z","end":"2026-08-18T23:25:26.722576Z","steps":["trace[1902195522] 'range keys from in-memory index tree' (duration: 122.339067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.722637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.839176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.722656Z","caller":"traceutil/trace.go:171","msg":"trace[2000995] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"323.881588ms","start":"2026-08-18T23:25:26.398769Z","end":"2026-08-18T23:25:26.72265Z","steps":["trace[2000995] 'range keys from in-memory index tree' (duration: 323.749104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.724311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.398756Z","time spent":"325.372743ms","remote":"127.0.0.1:46796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":26,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.724352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.989371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.725148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.996174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.725245Z","caller":"traceutil/trace.go:171","msg":"trace[944998231] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1; }","duration":"112.428724ms","start":"2026-08-18T23:25:26.612774Z","end":"2026-08-18T23:25:26.725203Z","steps":["trace[944998231] 'count revisions from in-memory index tree' (duration: 111.437561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.725247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.719476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.725363Z","caller":"traceutil/trace.go:171","msg":"trace[1967701848] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"285.30551ms","start":"2026-08-18T23:25:26.440028Z","end":"2026-08-18T23:25:26.725333Z","steps":["trace[1967701848] 'count revisions from in-memory index tree' (duration: 281.89946ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:26.72539Z","caller":"traceutil/trace.go:171","msg":"trace[1564647107] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"273.285028ms","start":"2026-08-18T23:25:26.45127Z","end":"2026-08-18T23:25:26.724555Z","steps":["trace[1564647107] 'range keys from in-memory index tree' (duration: 272.909169ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.726256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.15235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.726317Z","caller":"traceutil/trace.go:171","msg":"trace[1304019252] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"351.278562ms","start":"2026-08-18T23:25:26.375023Z","end":"2026-08-18T23:25:26.726302Z","steps":["trace[1304019252] 'range keys from in-memory index tree' (duration: 351.097248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.726363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.375012Z","time spent":"351.329854ms","remote":"127.0.0.1:46776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.727022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.225684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.727097Z","caller":"traceutil/trace.go:171","msg":"trace[779333967] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"366.323007ms","start":"2026-08-18T23:25:26.360762Z","end":"2026-08-18T23:25:26.727085Z","steps":["trace[779333967] 'range keys from in-memory index tree' (duration: 366.184103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.727137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.360749Z","time spent":"366.371267ms","remote":"127.0.0.1:46766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.727314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.659742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.727393Z","caller":"traceutil/trace.go:171","msg":"trace[961074780] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"266.750244ms","start":"2026-08-18T23:25:26.46062Z","end":"2026-08-18T23:25:26.72737Z","steps":["trace[961074780] 'range keys from in-memory index tree' (duration: 266.56801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.727455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.149485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.727507Z","caller":"traceutil/trace.go:171","msg":"trace[910221041] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"276.231667ms","start":"2026-08-18T23:25:26.451263Z","end":"2026-08-18T23:25:26.727495Z","steps":["trace[910221041] 'count revisions from in-memory index tree' (duration: 276.078064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.72823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.22965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.721927Z","caller":"traceutil/trace.go:171","msg":"trace[1730552011] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"157.900714ms","start":"2026-08-18T23:25:26.564017Z","end":"2026-08-18T23:25:26.721918Z","steps":["trace[1730552011] 'range keys from in-memory index tree' (duration: 157.808351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.721948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.403892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.721965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.25944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.728349Z","caller":"traceutil/trace.go:171","msg":"trace[1084413460] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"342.365073ms","start":"2026-08-18T23:25:26.385957Z","end":"2026-08-18T23:25:26.728322Z","steps":["trace[1084413460] 'range keys from in-memory index tree' (duration: 342.143807ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.72842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.385939Z","time spent":"342.457505ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.728422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.755688ms","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:4"} {"level":"info","ts":"2026-08-18T23:25:26.728478Z","caller":"traceutil/trace.go:171","msg":"trace[944685762] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"267.82769ms","start":"2026-08-18T23:25:26.460629Z","end":"2026-08-18T23:25:26.728457Z","steps":["trace[944685762] 'count revisions from in-memory index tree' (duration: 267.505542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.72861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.68703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.728669Z","caller":"traceutil/trace.go:171","msg":"trace[385618715] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"288.763362ms","start":"2026-08-18T23:25:26.439878Z","end":"2026-08-18T23:25:26.728641Z","steps":["trace[385618715] 'range keys from in-memory index tree' (duration: 288.614669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.730047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.366443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.730123Z","caller":"traceutil/trace.go:171","msg":"trace[1180065896] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"237.446685ms","start":"2026-08-18T23:25:26.492639Z","end":"2026-08-18T23:25:26.730086Z","steps":["trace[1180065896] 'count revisions from in-memory index tree' (duration: 237.287671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.730262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.327977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.730339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.123464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.730379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.490257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.728282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.111456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.730605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.148646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.73073Z","caller":"traceutil/trace.go:171","msg":"trace[2134971212] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"369.436639ms","start":"2026-08-18T23:25:26.360872Z","end":"2026-08-18T23:25:26.730309Z","steps":["trace[2134971212] 'count revisions from in-memory index tree' (duration: 367.954455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.73084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.360861Z","time spent":"369.907011ms","remote":"127.0.0.1:46766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":26,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-08-18T23:25:26.730789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.203731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.730953Z","caller":"traceutil/trace.go:171","msg":"trace[603082866] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"215.354175ms","start":"2026-08-18T23:25:26.515563Z","end":"2026-08-18T23:25:26.730917Z","steps":["trace[603082866] 'count revisions from in-memory index tree' (duration: 215.14291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.730969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.578296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.731139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.282658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.731184Z","caller":"traceutil/trace.go:171","msg":"trace[1941797720] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"307.348289ms","start":"2026-08-18T23:25:26.423828Z","end":"2026-08-18T23:25:26.731176Z","steps":["trace[1941797720] 'count revisions from in-memory index tree' (duration: 307.213635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.423819Z","time spent":"307.410701ms","remote":"127.0.0.1:46820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-08-18T23:25:26.731421Z","caller":"traceutil/trace.go:171","msg":"trace[482691516] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"155.707512ms","start":"2026-08-18T23:25:26.575698Z","end":"2026-08-18T23:25:26.731406Z","steps":["trace[482691516] 'count revisions from in-memory index tree' (duration: 146.202958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.645852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.731647Z","caller":"traceutil/trace.go:171","msg":"trace[634636111] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"249.680183ms","start":"2026-08-18T23:25:26.481961Z","end":"2026-08-18T23:25:26.731642Z","steps":["trace[634636111] 'count revisions from in-memory index tree' (duration: 249.609571ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.055012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.731704Z","caller":"traceutil/trace.go:171","msg":"trace[974240128] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"239.101574ms","start":"2026-08-18T23:25:26.492596Z","end":"2026-08-18T23:25:26.731697Z","steps":["trace[974240128] 'range keys from in-memory index tree' (duration: 238.996191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.59069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.731745Z","caller":"traceutil/trace.go:171","msg":"trace[1318632153] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"317.647242ms","start":"2026-08-18T23:25:26.414094Z","end":"2026-08-18T23:25:26.731741Z","steps":["trace[1318632153] 'range keys from in-memory index tree' (duration: 317.538648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.414086Z","time spent":"317.672402ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":26,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.731832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.009435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.73185Z","caller":"traceutil/trace.go:171","msg":"trace[1424938260] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"308.037215ms","start":"2026-08-18T23:25:26.423809Z","end":"2026-08-18T23:25:26.731846Z","steps":["trace[1424938260] 'range keys from in-memory index tree' (duration: 307.987664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.423804Z","time spent":"308.055586ms","remote":"127.0.0.1:46820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 "} {"level":"warn","ts":"2026-08-18T23:25:26.731913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.904048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.731945Z","caller":"traceutil/trace.go:171","msg":"trace[527694521] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"249.956319ms","start":"2026-08-18T23:25:26.481983Z","end":"2026-08-18T23:25:26.731939Z","steps":["trace[527694521] 'range keys from in-memory index tree' (duration: 249.853207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.904657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.732014Z","caller":"traceutil/trace.go:171","msg":"trace[872267463] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"260.944957ms","start":"2026-08-18T23:25:26.471064Z","end":"2026-08-18T23:25:26.732009Z","steps":["trace[872267463] 'count revisions from in-memory index tree' (duration: 260.844915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.731925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.896876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:26.732127Z","caller":"traceutil/trace.go:171","msg":"trace[1806552354] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"261.114472ms","start":"2026-08-18T23:25:26.471006Z","end":"2026-08-18T23:25:26.73212Z","steps":["trace[1806552354] 'range keys from in-memory index tree' (duration: 260.806334ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:26.731999Z","caller":"traceutil/trace.go:171","msg":"trace[1599989651] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"317.927228ms","start":"2026-08-18T23:25:26.414056Z","end":"2026-08-18T23:25:26.731983Z","steps":["trace[1599989651] 'count revisions from in-memory index tree' (duration: 316.493644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.732158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.861266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:26.732177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.414046Z","time spent":"318.124743ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-08-18T23:25:26.732192Z","caller":"traceutil/trace.go:171","msg":"trace[1034239222] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"229.907417ms","start":"2026-08-18T23:25:26.502275Z","end":"2026-08-18T23:25:26.732183Z","steps":["trace[1034239222] 'range keys from in-memory index tree' (duration: 229.829615ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:26.732886Z","caller":"traceutil/trace.go:171","msg":"trace[1883922754] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"344.195656ms","start":"2026-08-18T23:25:26.386171Z","end":"2026-08-18T23:25:26.730367Z","steps":["trace[1883922754] 'count revisions from in-memory index tree' (duration: 344.036123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.732913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.386153Z","time spent":"346.753736ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-08-18T23:25:26.732947Z","caller":"traceutil/trace.go:171","msg":"trace[1152104047] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"331.561259ms","start":"2026-08-18T23:25:26.398843Z","end":"2026-08-18T23:25:26.730404Z","steps":["trace[1152104047] 'count revisions from in-memory index tree' (duration: 331.440546ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:26.732971Z","caller":"traceutil/trace.go:171","msg":"trace[234551448] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"355.361469ms","start":"2026-08-18T23:25:26.375134Z","end":"2026-08-18T23:25:26.730496Z","steps":["trace[234551448] 'count revisions from in-memory index tree' (duration: 352.566303ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:26.732992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.375127Z","time spent":"357.860137ms","remote":"127.0.0.1:46776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-08-18T23:25:26.732982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:26.398825Z","time spent":"334.14901ms","remote":"127.0.0.1:46796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":26,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-08-18T23:25:26.733054Z","caller":"traceutil/trace.go:171","msg":"trace[748281284] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"228.237008ms","start":"2026-08-18T23:25:26.502404Z","end":"2026-08-18T23:25:26.730641Z","steps":["trace[748281284] 'count revisions from in-memory index tree' (duration: 228.117115ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:26.73327Z","caller":"traceutil/trace.go:171","msg":"trace[1853024418] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"155.167499ms","start":"2026-08-18T23:25:26.575523Z","end":"2026-08-18T23:25:26.73069Z","steps":["trace[1853024418] 'range keys from in-memory index tree' (duration: 146.357951ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:27.805915Z","caller":"traceutil/trace.go:171","msg":"trace[437426182] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"302.749442ms","start":"2026-08-18T23:25:27.503137Z","end":"2026-08-18T23:25:27.805886Z","steps":["trace[437426182] 'process raft request' (duration: 302.492376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:27.806943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.503125Z","time spent":"302.879604ms","remote":"127.0.0.1:46744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:25:28.256111Z","caller":"traceutil/trace.go:171","msg":"trace[377525222] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"740.267664ms","start":"2026-08-18T23:25:27.515822Z","end":"2026-08-18T23:25:28.256089Z","steps":["trace[377525222] 'read index received' (duration: 290.026903ms)","trace[377525222] 'applied index is now lower than readState.Index' (duration: 450.239471ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:28.256226Z","caller":"traceutil/trace.go:171","msg":"trace[501596130] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"752.46182ms","start":"2026-08-18T23:25:27.503754Z","end":"2026-08-18T23:25:28.256216Z","steps":["trace[501596130] 'process raft request' (duration: 751.955718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.256323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.503742Z","time spent":"752.512392ms","remote":"127.0.0.1:46742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:25:28.25656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.56771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:28.256599Z","caller":"traceutil/trace.go:171","msg":"trace[1276709547] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"703.636172ms","start":"2026-08-18T23:25:27.552953Z","end":"2026-08-18T23:25:28.256589Z","steps":["trace[1276709547] 'agreement among raft nodes before linearized reading' (duration: 703.577671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.256627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.552933Z","time spent":"703.687914ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-18T23:25:28.256679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.739075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:28.256825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.796217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:28.256859Z","caller":"traceutil/trace.go:171","msg":"trace[1126821902] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"675.88264ms","start":"2026-08-18T23:25:27.580946Z","end":"2026-08-18T23:25:28.256829Z","steps":["trace[1126821902] 'process raft request' (duration: 674.872676ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.256886Z","caller":"traceutil/trace.go:171","msg":"trace[21210030] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"624.88283ms","start":"2026-08-18T23:25:27.63199Z","end":"2026-08-18T23:25:28.256873Z","steps":["trace[21210030] 'agreement among raft nodes before linearized reading' (duration: 624.804058ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.256825Z","caller":"traceutil/trace.go:171","msg":"trace[1182083554] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"741.028392ms","start":"2026-08-18T23:25:27.515771Z","end":"2026-08-18T23:25:28.256799Z","steps":["trace[1182083554] 'agreement among raft nodes before linearized reading' (duration: 740.672574ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.25693Z","caller":"traceutil/trace.go:171","msg":"trace[1804362455] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"663.15011ms","start":"2026-08-18T23:25:27.593721Z","end":"2026-08-18T23:25:28.256871Z","steps":["trace[1804362455] 'process raft request' (duration: 662.340361ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.256972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.49301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:28.257045Z","caller":"traceutil/trace.go:171","msg":"trace[1670054562] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:0; response_revision:11; }","duration":"678.577263ms","start":"2026-08-18T23:25:27.578445Z","end":"2026-08-18T23:25:28.257023Z","steps":["trace[1670054562] 'agreement among raft nodes before linearized reading' (duration: 678.45737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.578404Z","time spent":"678.684145ms","remote":"127.0.0.1:46714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.177\" "} {"level":"warn","ts":"2026-08-18T23:25:28.2571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.59371Z","time spent":"663.307253ms","remote":"127.0.0.1:46956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:25:28.256933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.63198Z","time spent":"624.941431ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-18T23:25:28.257172Z","caller":"traceutil/trace.go:171","msg":"trace[1236564156] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"664.423999ms","start":"2026-08-18T23:25:27.592736Z","end":"2026-08-18T23:25:28.25716Z","steps":["trace[1236564156] 'process raft request' (duration: 663.298773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.592723Z","time spent":"664.489292ms","remote":"127.0.0.1:46870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:25:28.257313Z","caller":"traceutil/trace.go:171","msg":"trace[1570239585] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"671.978668ms","start":"2026-08-18T23:25:27.585318Z","end":"2026-08-18T23:25:28.257296Z","steps":["trace[1570239585] 'process raft request' (duration: 670.569004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.567065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:28.257394Z","caller":"traceutil/trace.go:171","msg":"trace[417545642] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"676.625337ms","start":"2026-08-18T23:25:27.580756Z","end":"2026-08-18T23:25:28.257381Z","steps":["trace[417545642] 'agreement among raft nodes before linearized reading' (duration: 676.562455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.585301Z","time spent":"672.062899ms","remote":"127.0.0.1:47216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:25:28.256979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.580935Z","time spent":"675.972831ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:25:28.257436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.580741Z","time spent":"676.684488ms","remote":"127.0.0.1:46762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-08-18T23:25:28.25748Z","caller":"traceutil/trace.go:171","msg":"trace[1005359721] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"672.08895ms","start":"2026-08-18T23:25:27.585379Z","end":"2026-08-18T23:25:28.257468Z","steps":["trace[1005359721] 'process raft request' (duration: 670.540353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.464807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-18T23:25:28.257556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.585364Z","time spent":"672.154722ms","remote":"127.0.0.1:47216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:25:28.257043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.51576Z","time spent":"741.225976ms","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-08-18T23:25:28.257596Z","caller":"traceutil/trace.go:171","msg":"trace[1171728126] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"677.523007ms","start":"2026-08-18T23:25:27.580063Z","end":"2026-08-18T23:25:28.257586Z","steps":["trace[1171728126] 'agreement among raft nodes before linearized reading' (duration: 677.469836ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.257597Z","caller":"traceutil/trace.go:171","msg":"trace[632953320] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"672.421057ms","start":"2026-08-18T23:25:27.585162Z","end":"2026-08-18T23:25:28.257583Z","steps":["trace[632953320] 'process raft request' (duration: 670.692147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.580052Z","time spent":"677.566759ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-18T23:25:28.25767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.585146Z","time spent":"672.49011ms","remote":"127.0.0.1:47216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:25:28.257793Z","caller":"traceutil/trace.go:171","msg":"trace[448091753] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"672.332966ms","start":"2026-08-18T23:25:27.585451Z","end":"2026-08-18T23:25:28.257783Z","steps":["trace[448091753] 'process raft request' (duration: 670.555814ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.257854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.585443Z","time spent":"672.383347ms","remote":"127.0.0.1:47216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:25:28.256427Z","caller":"traceutil/trace.go:171","msg":"trace[70407534] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"670.941663ms","start":"2026-08-18T23:25:27.585421Z","end":"2026-08-18T23:25:28.256363Z","steps":["trace[70407534] 'process raft request' (duration: 670.565704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.258603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:27.585411Z","time spent":"673.099253ms","remote":"127.0.0.1:47216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:25:28.513843Z","caller":"traceutil/trace.go:171","msg":"trace[1840831916] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"251.000564ms","start":"2026-08-18T23:25:28.262814Z","end":"2026-08-18T23:25:28.513814Z","steps":["trace[1840831916] 'process raft request' (duration: 243.308503ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514223Z","caller":"traceutil/trace.go:171","msg":"trace[907419931] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"193.461431ms","start":"2026-08-18T23:25:28.320741Z","end":"2026-08-18T23:25:28.514203Z","steps":["trace[907419931] 'process raft request' (duration: 193.432661ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514301Z","caller":"traceutil/trace.go:171","msg":"trace[344335384] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"249.51339ms","start":"2026-08-18T23:25:28.264759Z","end":"2026-08-18T23:25:28.514273Z","steps":["trace[344335384] 'process raft request' (duration: 249.272844ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514334Z","caller":"traceutil/trace.go:171","msg":"trace[1456976264] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"250.188135ms","start":"2026-08-18T23:25:28.264136Z","end":"2026-08-18T23:25:28.514324Z","steps":["trace[1456976264] 'process raft request' (duration: 249.813236ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514445Z","caller":"traceutil/trace.go:171","msg":"trace[48532564] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"249.402797ms","start":"2026-08-18T23:25:28.265032Z","end":"2026-08-18T23:25:28.514434Z","steps":["trace[48532564] 'process raft request' (duration: 249.024238ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514472Z","caller":"traceutil/trace.go:171","msg":"trace[40832844] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"250.239866ms","start":"2026-08-18T23:25:28.264225Z","end":"2026-08-18T23:25:28.514464Z","steps":["trace[40832844] 'process raft request' (duration: 249.747015ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514559Z","caller":"traceutil/trace.go:171","msg":"trace[701403264] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"250.027381ms","start":"2026-08-18T23:25:28.264527Z","end":"2026-08-18T23:25:28.514554Z","steps":["trace[701403264] 'process raft request' (duration: 249.478999ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.51477Z","caller":"traceutil/trace.go:171","msg":"trace[332022229] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"251.796443ms","start":"2026-08-18T23:25:28.262969Z","end":"2026-08-18T23:25:28.514765Z","steps":["trace[332022229] 'process raft request' (duration: 250.936613ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:28.514819Z","caller":"traceutil/trace.go:171","msg":"trace[1355349044] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"251.789473ms","start":"2026-08-18T23:25:28.263024Z","end":"2026-08-18T23:25:28.514814Z","steps":["trace[1355349044] 'read index received' (duration: 26.033152ms)","trace[1355349044] 'applied index is now lower than readState.Index' (duration: 225.755291ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:28.514872Z","caller":"traceutil/trace.go:171","msg":"trace[1941272076] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"246.285164ms","start":"2026-08-18T23:25:28.268583Z","end":"2026-08-18T23:25:28.514868Z","steps":["trace[1941272076] 'process raft request' (duration: 245.542726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.514952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.917836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-18T23:25:28.514976Z","caller":"traceutil/trace.go:171","msg":"trace[1162563513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"251.983947ms","start":"2026-08-18T23:25:28.262983Z","end":"2026-08-18T23:25:28.514967Z","steps":["trace[1162563513] 'agreement among raft nodes before linearized reading' (duration: 251.930696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.515108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.147218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-nrl88\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-18T23:25:28.515131Z","caller":"traceutil/trace.go:171","msg":"trace[2056714234] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-nrl88; range_end:; response_count:1; response_revision:20; }","duration":"251.181909ms","start":"2026-08-18T23:25:28.263944Z","end":"2026-08-18T23:25:28.515126Z","steps":["trace[2056714234] 'agreement among raft nodes before linearized reading' (duration: 251.139378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.515335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.278321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-08-18T23:25:28.51538Z","caller":"traceutil/trace.go:171","msg":"trace[1128350739] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"251.360083ms","start":"2026-08-18T23:25:28.264009Z","end":"2026-08-18T23:25:28.515369Z","steps":["trace[1128350739] 'agreement among raft nodes before linearized reading' (duration: 251.275351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:28.515432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.447497ms","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-08-18T23:25:28.515488Z","caller":"traceutil/trace.go:171","msg":"trace[866171399] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:20; }","duration":"223.522258ms","start":"2026-08-18T23:25:28.29195Z","end":"2026-08-18T23:25:28.515472Z","steps":["trace[866171399] 'agreement among raft nodes before linearized reading' (duration: 223.448906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:32.747209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.517811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-18T23:25:32.747298Z","caller":"traceutil/trace.go:171","msg":"trace[569655562] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:279; }","duration":"221.672005ms","start":"2026-08-18T23:25:32.525606Z","end":"2026-08-18T23:25:32.747278Z","steps":["trace[569655562] 'range keys from in-memory index tree' (duration: 221.405339ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:34.348035Z","caller":"traceutil/trace.go:171","msg":"trace[1795744584] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:300; }","duration":"472.862813ms","start":"2026-08-18T23:25:33.875144Z","end":"2026-08-18T23:25:34.348006Z","steps":["trace[1795744584] 'read index received' (duration: 472.034334ms)","trace[1795744584] 'applied index is now lower than readState.Index' (duration: 827.379µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:34.348192Z","caller":"traceutil/trace.go:171","msg":"trace[1501553182] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"488.620455ms","start":"2026-08-18T23:25:33.859537Z","end":"2026-08-18T23:25:34.348158Z","steps":["trace[1501553182] 'process raft request' (duration: 487.712143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:34.348242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.071618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-18T23:25:34.348279Z","caller":"traceutil/trace.go:171","msg":"trace[1775580644] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:290; }","duration":"473.14705ms","start":"2026-08-18T23:25:33.87512Z","end":"2026-08-18T23:25:34.348267Z","steps":["trace[1775580644] 'agreement among raft nodes before linearized reading' (duration: 473.033458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:34.348313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:33.875109Z","time spent":"473.196261ms","remote":"127.0.0.1:46782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-18T23:25:34.348391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:33.859521Z","time spent":"488.742127ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:25:34.816429Z","caller":"traceutil/trace.go:171","msg":"trace[1132970242] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"129.852525ms","start":"2026-08-18T23:25:34.686548Z","end":"2026-08-18T23:25:34.816401Z","steps":["trace[1132970242] 'process raft request' (duration: 129.609429ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:46.886229Z","caller":"traceutil/trace.go:171","msg":"trace[236313212] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"306.92838ms","start":"2026-08-18T23:25:46.579277Z","end":"2026-08-18T23:25:46.886205Z","steps":["trace[236313212] 'read index received' (duration: 306.762796ms)","trace[236313212] 'applied index is now lower than readState.Index' (duration: 164.604µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:46.886278Z","caller":"traceutil/trace.go:171","msg":"trace[233872393] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"411.548991ms","start":"2026-08-18T23:25:46.474693Z","end":"2026-08-18T23:25:46.886242Z","steps":["trace[233872393] 'process raft request' (duration: 411.352346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:46.886428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.474664Z","time spent":"411.692875ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:25:46.886451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.183196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-18T23:25:46.886459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.164965ms","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-08-18T23:25:46.886527Z","caller":"traceutil/trace.go:171","msg":"trace[2112006677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"290.292109ms","start":"2026-08-18T23:25:46.596225Z","end":"2026-08-18T23:25:46.886517Z","steps":["trace[2112006677] 'agreement among raft nodes before linearized reading' (duration: 290.175437ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:46.886561Z","caller":"traceutil/trace.go:171","msg":"trace[1477166522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:379; }","duration":"307.307989ms","start":"2026-08-18T23:25:46.579226Z","end":"2026-08-18T23:25:46.886534Z","steps":["trace[1477166522] 'agreement among raft nodes before linearized reading' (duration: 307.145925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:46.886614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.579206Z","time spent":"307.395861ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-18T23:25:47.095488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.272587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-18T23:25:47.095607Z","caller":"traceutil/trace.go:171","msg":"trace[1576700223] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"200.201219ms","start":"2026-08-18T23:25:46.895382Z","end":"2026-08-18T23:25:47.095584Z","steps":["trace[1576700223] 'process raft request' (duration: 74.526973ms)","trace[1576700223] 'compare' (duration: 125.091492ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:47.467197Z","caller":"traceutil/trace.go:171","msg":"trace[1946306280] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:394; }","duration":"553.558511ms","start":"2026-08-18T23:25:46.913611Z","end":"2026-08-18T23:25:47.467169Z","steps":["trace[1946306280] 'read index received' (duration: 56.311304ms)","trace[1946306280] 'applied index is now lower than readState.Index' (duration: 497.246197ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:47.467267Z","caller":"traceutil/trace.go:171","msg":"trace[1004484252] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"569.723942ms","start":"2026-08-18T23:25:46.897507Z","end":"2026-08-18T23:25:47.467231Z","steps":["trace[1004484252] 'process raft request' (duration: 483.109644ms)","trace[1004484252] 'compare' (duration: 86.414133ms)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:25:47.467347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.711735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-18T23:25:47.467401Z","caller":"traceutil/trace.go:171","msg":"trace[1819661763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:381; }","duration":"553.817237ms","start":"2026-08-18T23:25:46.913569Z","end":"2026-08-18T23:25:47.467386Z","steps":["trace[1819661763] 'agreement among raft nodes before linearized reading' (duration: 553.699974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:25:47.467421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.897491Z","time spent":"569.850235ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:25:47.467457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:25:46.913556Z","time spent":"553.8859ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-18T23:25:51.547618Z","caller":"traceutil/trace.go:171","msg":"trace[585603560] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"137.029193ms","start":"2026-08-18T23:25:51.410563Z","end":"2026-08-18T23:25:51.547592Z","steps":["trace[585603560] 'read index received' (duration: 109.811723ms)","trace[585603560] 'applied index is now lower than readState.Index' (duration: 27.21643ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:25:51.54775Z","caller":"traceutil/trace.go:171","msg":"trace[1372125061] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"138.043007ms","start":"2026-08-18T23:25:51.40967Z","end":"2026-08-18T23:25:51.547713Z","steps":["trace[1372125061] 'process raft request' (duration: 110.700704ms)","trace[1372125061] 'compare' (duration: 27.095637ms)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:25:51.547799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.205917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-08-18T23:25:51.548026Z","caller":"traceutil/trace.go:171","msg":"trace[98920480] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:419; }","duration":"137.473814ms","start":"2026-08-18T23:25:51.410541Z","end":"2026-08-18T23:25:51.548015Z","steps":["trace[98920480] 'agreement among raft nodes before linearized reading' (duration: 137.180817ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:25:51.550453Z","caller":"traceutil/trace.go:171","msg":"trace[1005989475] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"132.880546ms","start":"2026-08-18T23:25:51.41755Z","end":"2026-08-18T23:25:51.550431Z","steps":["trace[1005989475] 'process raft request' (duration: 132.326373ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.559152Z","caller":"traceutil/trace.go:171","msg":"trace[1322171303] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"316.884704ms","start":"2026-08-18T23:26:04.242246Z","end":"2026-08-18T23:26:04.55913Z","steps":["trace[1322171303] 'process raft request' (duration: 316.724951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:04.559279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.242227Z","time spent":"316.993226ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:26:04.57036Z","caller":"traceutil/trace.go:171","msg":"trace[1946842808] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"323.602472ms","start":"2026-08-18T23:26:04.246724Z","end":"2026-08-18T23:26:04.570327Z","steps":["trace[1946842808] 'process raft request' (duration: 323.309615ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.570626Z","caller":"traceutil/trace.go:171","msg":"trace[1757210294] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"320.839408ms","start":"2026-08-18T23:26:04.24976Z","end":"2026-08-18T23:26:04.5706Z","steps":["trace[1757210294] 'process raft request' (duration: 320.408767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:04.570737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.249742Z","time spent":"320.94227ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:26:04.570848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.246716Z","time spent":"323.727016ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:26:04.570833Z","caller":"traceutil/trace.go:171","msg":"trace[1846738557] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"313.967456ms","start":"2026-08-18T23:26:04.25681Z","end":"2026-08-18T23:26:04.570777Z","steps":["trace[1846738557] 'process raft request' (duration: 313.771001ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.570776Z","caller":"traceutil/trace.go:171","msg":"trace[1940480241] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"316.011794ms","start":"2026-08-18T23:26:04.254737Z","end":"2026-08-18T23:26:04.570749Z","steps":["trace[1940480241] 'process raft request' (duration: 315.791029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:04.571087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.256803Z","time spent":"314.118249ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:26:04.571019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.254726Z","time spent":"316.214699ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:26:04.571611Z","caller":"traceutil/trace.go:171","msg":"trace[593862957] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"313.720571ms","start":"2026-08-18T23:26:04.257858Z","end":"2026-08-18T23:26:04.571578Z","steps":["trace[593862957] 'process raft request' (duration: 313.357272ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.571689Z","caller":"traceutil/trace.go:171","msg":"trace[1311289060] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"309.620344ms","start":"2026-08-18T23:26:04.262046Z","end":"2026-08-18T23:26:04.571666Z","steps":["trace[1311289060] 'process raft request' (duration: 309.45772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:04.571707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.257851Z","time spent":"313.812143ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:26:04.571761Z","caller":"traceutil/trace.go:171","msg":"trace[1448292390] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"309.646685ms","start":"2026-08-18T23:26:04.262098Z","end":"2026-08-18T23:26:04.571745Z","steps":["trace[1448292390] 'process raft request' (duration: 309.485171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:04.57177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.262029Z","time spent":"309.701345ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:26:04.571834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:04.262095Z","time spent":"309.707946ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-18T23:26:04.571878Z","caller":"traceutil/trace.go:171","msg":"trace[1544207186] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"288.444236ms","start":"2026-08-18T23:26:04.283393Z","end":"2026-08-18T23:26:04.571838Z","steps":["trace[1544207186] 'process raft request' (duration: 288.279472ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.571924Z","caller":"traceutil/trace.go:171","msg":"trace[729749057] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"288.425725ms","start":"2026-08-18T23:26:04.283487Z","end":"2026-08-18T23:26:04.571913Z","steps":["trace[729749057] 'process raft request' (duration: 288.334043ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.579885Z","caller":"traceutil/trace.go:171","msg":"trace[71694047] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"250.905802ms","start":"2026-08-18T23:26:04.328962Z","end":"2026-08-18T23:26:04.579868Z","steps":["trace[71694047] 'process raft request' (duration: 250.578785ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:04.580064Z","caller":"traceutil/trace.go:171","msg":"trace[241540621] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"152.883947ms","start":"2026-08-18T23:26:04.427168Z","end":"2026-08-18T23:26:04.580052Z","steps":["trace[241540621] 'process raft request' (duration: 152.58712ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:10.666604Z","caller":"traceutil/trace.go:171","msg":"trace[1113780823] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"363.656695ms","start":"2026-08-18T23:26:10.302897Z","end":"2026-08-18T23:26:10.666554Z","steps":["trace[1113780823] 'process raft request' (duration: 363.322087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:10.66675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:10.302873Z","time spent":"363.800238ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:11.066514Z","caller":"traceutil/trace.go:171","msg":"trace[1882459495] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"711.98448ms","start":"2026-08-18T23:26:10.354479Z","end":"2026-08-18T23:26:11.066464Z","steps":["trace[1882459495] 'process raft request' (duration: 711.370365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:11.066675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.427457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-18T23:26:11.066746Z","caller":"traceutil/trace.go:171","msg":"trace[1738775594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"470.53808ms","start":"2026-08-18T23:26:10.596192Z","end":"2026-08-18T23:26:11.06673Z","steps":["trace[1738775594] 'agreement among raft nodes before linearized reading' (duration: 470.412037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:11.066785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:10.596176Z","time spent":"470.601981ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-18T23:26:11.066982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:10.35445Z","time spent":"712.263257ms","remote":"127.0.0.1:46766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:11.066492Z","caller":"traceutil/trace.go:171","msg":"trace[1609598388] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"470.167731ms","start":"2026-08-18T23:26:10.596227Z","end":"2026-08-18T23:26:11.066395Z","steps":["trace[1609598388] 'read index received' (duration: 69.590117ms)","trace[1609598388] 'applied index is now lower than readState.Index' (duration: 400.576594ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:26:11.591725Z","caller":"traceutil/trace.go:171","msg":"trace[1453619196] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"291.542492ms","start":"2026-08-18T23:26:11.300162Z","end":"2026-08-18T23:26:11.591705Z","steps":["trace[1453619196] 'read index received' (duration: 281.907881ms)","trace[1453619196] 'applied index is now lower than readState.Index' (duration: 9.633861ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:26:11.591913Z","caller":"traceutil/trace.go:171","msg":"trace[2108128249] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"456.23151ms","start":"2026-08-18T23:26:11.135666Z","end":"2026-08-18T23:26:11.591897Z","steps":["trace[2108128249] 'process raft request' (duration: 446.446395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:11.591929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.755057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-18T23:26:11.591963Z","caller":"traceutil/trace.go:171","msg":"trace[418004851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"291.847099ms","start":"2026-08-18T23:26:11.300106Z","end":"2026-08-18T23:26:11.591953Z","steps":["trace[418004851] 'agreement among raft nodes before linearized reading' (duration: 291.684875ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:11.591999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:11.13565Z","time spent":"456.306742ms","remote":"127.0.0.1:47200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:26:12.92078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212993237s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-18T23:26:12.921499Z","caller":"traceutil/trace.go:171","msg":"trace[1613253681] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.229300826s","start":"2026-08-18T23:26:11.692155Z","end":"2026-08-18T23:26:12.921456Z","steps":["trace[1613253681] 'process raft request' (duration: 15.532711ms)","trace[1613253681] 'compare' (duration: 1.212673669s)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:26:12.921737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:11.692138Z","time spent":"1.229511381s","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:12.922021Z","caller":"traceutil/trace.go:171","msg":"trace[883294322] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"901.079198ms","start":"2026-08-18T23:26:12.020926Z","end":"2026-08-18T23:26:12.922005Z","steps":["trace[883294322] 'process raft request' (duration: 900.138945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:12.922098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:12.020894Z","time spent":"901.16829ms","remote":"127.0.0.1:46766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:12.931466Z","caller":"traceutil/trace.go:171","msg":"trace[1678550258] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:625; }","duration":"334.686003ms","start":"2026-08-18T23:26:12.596765Z","end":"2026-08-18T23:26:12.931451Z","steps":["trace[1678550258] 'read index received' (duration: 195.095815ms)","trace[1678550258] 'applied index is now lower than readState.Index' (duration: 139.589308ms)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:26:12.931651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.842947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-18T23:26:12.931938Z","caller":"traceutil/trace.go:171","msg":"trace[1341921857] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"607.514687ms","start":"2026-08-18T23:26:12.324402Z","end":"2026-08-18T23:26:12.931917Z","steps":["trace[1341921857] 'process raft request' (duration: 606.864552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:12.93205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:12.324372Z","time spent":"607.62045ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:12.931676Z","caller":"traceutil/trace.go:171","msg":"trace[105581764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"334.94261ms","start":"2026-08-18T23:26:12.596728Z","end":"2026-08-18T23:26:12.93167Z","steps":["trace[105581764] 'agreement among raft nodes before linearized reading' (duration: 334.797356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:12.932532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:12.596711Z","time spent":"335.81399ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-18T23:26:27.707441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605187232717049932,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-18T23:26:27.775657Z","caller":"traceutil/trace.go:171","msg":"trace[1656612550] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"568.79171ms","start":"2026-08-18T23:26:27.206845Z","end":"2026-08-18T23:26:27.775636Z","steps":["trace[1656612550] 'read index received' (duration: 568.674427ms)","trace[1656612550] 'applied index is now lower than readState.Index' (duration: 116.213µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:26:27.775794Z","caller":"traceutil/trace.go:171","msg":"trace[354801474] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"790.977213ms","start":"2026-08-18T23:26:26.984788Z","end":"2026-08-18T23:26:27.775765Z","steps":["trace[354801474] 'process raft request' (duration: 790.705447ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:27.775884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.020646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-18T23:26:27.775936Z","caller":"traceutil/trace.go:171","msg":"trace[891346454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"569.121968ms","start":"2026-08-18T23:26:27.2068Z","end":"2026-08-18T23:26:27.775922Z","steps":["trace[891346454] 'agreement among raft nodes before linearized reading' (duration: 568.958054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:27.775975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:26.984776Z","time spent":"791.099107ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:26:27.775952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.496815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mdjwx\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-18T23:26:27.776053Z","caller":"traceutil/trace.go:171","msg":"trace[60538032] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mdjwx; range_end:; response_count:1; response_revision:752; }","duration":"387.637138ms","start":"2026-08-18T23:26:27.388393Z","end":"2026-08-18T23:26:27.77603Z","steps":["trace[60538032] 'agreement among raft nodes before linearized reading' (duration: 387.409333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:27.775982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:27.206783Z","time spent":"569.19087ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-18T23:26:27.776124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:27.388376Z","time spent":"387.733101ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mdjwx\" "} {"level":"info","ts":"2026-08-18T23:26:41.937967Z","caller":"traceutil/trace.go:171","msg":"trace[1340520380] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"104.209791ms","start":"2026-08-18T23:26:41.833738Z","end":"2026-08-18T23:26:41.937948Z","steps":["trace[1340520380] 'process raft request' (duration: 104.006156ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:41.95674Z","caller":"traceutil/trace.go:171","msg":"trace[1899076578] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"119.953368ms","start":"2026-08-18T23:26:41.836769Z","end":"2026-08-18T23:26:41.956723Z","steps":["trace[1899076578] 'process raft request' (duration: 119.830145ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:55.590697Z","caller":"traceutil/trace.go:171","msg":"trace[1565807665] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"429.362788ms","start":"2026-08-18T23:26:55.1613Z","end":"2026-08-18T23:26:55.590663Z","steps":["trace[1565807665] 'process raft request' (duration: 429.219804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:55.590838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:55.161277Z","time spent":"429.48849ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:26:56.377556Z","caller":"traceutil/trace.go:171","msg":"trace[1364969950] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:985; }","duration":"316.939948ms","start":"2026-08-18T23:26:56.060601Z","end":"2026-08-18T23:26:56.377541Z","steps":["trace[1364969950] 'read index received' (duration: 316.834126ms)","trace[1364969950] 'applied index is now lower than readState.Index' (duration: 104.712µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:26:56.377645Z","caller":"traceutil/trace.go:171","msg":"trace[1491721780] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"355.516411ms","start":"2026-08-18T23:26:56.022122Z","end":"2026-08-18T23:26:56.377639Z","steps":["trace[1491721780] 'process raft request' (duration: 355.308586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:56.377715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:56.022111Z","time spent":"355.550871ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:26:56.377866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.48573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-18T23:26:56.377941Z","caller":"traceutil/trace.go:171","msg":"trace[930327849] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:945; }","duration":"314.588642ms","start":"2026-08-18T23:26:56.063337Z","end":"2026-08-18T23:26:56.377925Z","steps":["trace[930327849] 'agreement among raft nodes before linearized reading' (duration: 314.378477ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:56.377985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:56.063285Z","time spent":"314.692405ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-18T23:26:56.378085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.483931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-18T23:26:56.378117Z","caller":"traceutil/trace.go:171","msg":"trace[1261294853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:945; }","duration":"317.545753ms","start":"2026-08-18T23:26:56.060564Z","end":"2026-08-18T23:26:56.378109Z","steps":["trace[1261294853] 'agreement among raft nodes before linearized reading' (duration: 317.482052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:56.378136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:56.060545Z","time spent":"317.584504ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-18T23:26:56.37855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.174856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-18T23:26:56.378593Z","caller":"traceutil/trace.go:171","msg":"trace[1558051015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:945; }","duration":"310.234497ms","start":"2026-08-18T23:26:56.068347Z","end":"2026-08-18T23:26:56.378582Z","steps":["trace[1558051015] 'agreement among raft nodes before linearized reading' (duration: 309.821267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:26:56.378623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:26:56.068338Z","time spent":"310.278189ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-18T23:26:56.630259Z","caller":"traceutil/trace.go:171","msg":"trace[639677001] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"248.203886ms","start":"2026-08-18T23:26:56.382019Z","end":"2026-08-18T23:26:56.630223Z","steps":["trace[639677001] 'process raft request' (duration: 238.145625ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:56.657369Z","caller":"traceutil/trace.go:171","msg":"trace[1236147928] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"274.401341ms","start":"2026-08-18T23:26:56.382948Z","end":"2026-08-18T23:26:56.657349Z","steps":["trace[1236147928] 'process raft request' (duration: 274.36173ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:56.657723Z","caller":"traceutil/trace.go:171","msg":"trace[1858236] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"274.899344ms","start":"2026-08-18T23:26:56.382813Z","end":"2026-08-18T23:26:56.657713Z","steps":["trace[1858236] 'process raft request' (duration: 274.357401ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:26:56.657861Z","caller":"traceutil/trace.go:171","msg":"trace[1188370414] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"274.951055ms","start":"2026-08-18T23:26:56.382899Z","end":"2026-08-18T23:26:56.65785Z","steps":["trace[1188370414] 'process raft request' (duration: 274.376882ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:14.80231Z","caller":"traceutil/trace.go:171","msg":"trace[1577743978] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1053; }","duration":"308.311333ms","start":"2026-08-18T23:27:14.49397Z","end":"2026-08-18T23:27:14.802281Z","steps":["trace[1577743978] 'read index received' (duration: 210.396742ms)","trace[1577743978] 'applied index is now lower than readState.Index' (duration: 97.913031ms)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:27:14.802836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.860596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-18T23:27:14.802896Z","caller":"traceutil/trace.go:171","msg":"trace[206623223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"308.932548ms","start":"2026-08-18T23:27:14.493948Z","end":"2026-08-18T23:27:14.802881Z","steps":["trace[206623223] 'agreement among raft nodes before linearized reading' (duration: 308.445676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:14.802928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:14.493889Z","time spent":"309.031971ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-18T23:27:14.937829Z","caller":"traceutil/trace.go:171","msg":"trace[1313075199] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"130.704366ms","start":"2026-08-18T23:27:14.807093Z","end":"2026-08-18T23:27:14.937797Z","steps":["trace[1313075199] 'process raft request' (duration: 130.525582ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:15.154438Z","caller":"traceutil/trace.go:171","msg":"trace[1096001517] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"347.259935ms","start":"2026-08-18T23:27:14.807144Z","end":"2026-08-18T23:27:15.154404Z","steps":["trace[1096001517] 'process raft request' (duration: 347.037199ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:15.154474Z","caller":"traceutil/trace.go:171","msg":"trace[1156397122] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"346.464986ms","start":"2026-08-18T23:27:14.807987Z","end":"2026-08-18T23:27:15.154452Z","steps":["trace[1156397122] 'process raft request' (duration: 346.374254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:15.154602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:14.807976Z","time spent":"346.557378ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:15.15485Z","caller":"traceutil/trace.go:171","msg":"trace[1355923515] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"347.681454ms","start":"2026-08-18T23:27:14.807158Z","end":"2026-08-18T23:27:15.15484Z","steps":["trace[1355923515] 'process raft request' (duration: 347.161312ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:15.154908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:14.807136Z","time spent":"347.746836ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:27:15.154619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:14.807124Z","time spent":"347.401928ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:15.155155Z","caller":"traceutil/trace.go:171","msg":"trace[496999638] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"346.224709ms","start":"2026-08-18T23:27:14.808909Z","end":"2026-08-18T23:27:15.155134Z","steps":["trace[496999638] 'process raft request' (duration: 345.505972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:15.155338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:14.8089Z","time spent":"346.332562ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:33.493774Z","caller":"traceutil/trace.go:171","msg":"trace[415246682] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"237.757586ms","start":"2026-08-18T23:27:33.255982Z","end":"2026-08-18T23:27:33.49374Z","steps":["trace[415246682] 'process raft request' (duration: 237.557001ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:33.493728Z","caller":"traceutil/trace.go:171","msg":"trace[2110574223] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"212.989997ms","start":"2026-08-18T23:27:33.280709Z","end":"2026-08-18T23:27:33.493699Z","steps":["trace[2110574223] 'read index received' (duration: 212.794842ms)","trace[2110574223] 'applied index is now lower than readState.Index' (duration: 194.085µs)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:27:33.493968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.240434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-18T23:27:33.494033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.797362ms","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-08-18T23:27:33.494042Z","caller":"traceutil/trace.go:171","msg":"trace[2135105507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1120; }","duration":"213.330396ms","start":"2026-08-18T23:27:33.280697Z","end":"2026-08-18T23:27:33.494027Z","steps":["trace[2135105507] 'agreement among raft nodes before linearized reading' (duration: 213.120431ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:33.494071Z","caller":"traceutil/trace.go:171","msg":"trace[795620182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1120; }","duration":"188.900525ms","start":"2026-08-18T23:27:33.305156Z","end":"2026-08-18T23:27:33.494057Z","steps":["trace[795620182] 'agreement among raft nodes before linearized reading' (duration: 188.755771ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:33.494078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.055411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-18T23:27:33.494149Z","caller":"traceutil/trace.go:171","msg":"trace[1308030639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1120; }","duration":"183.144743ms","start":"2026-08-18T23:27:33.310988Z","end":"2026-08-18T23:27:33.494132Z","steps":["trace[1308030639] 'agreement among raft nodes before linearized reading' (duration: 182.959589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:34.888465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.957195ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-18T23:27:34.888809Z","caller":"traceutil/trace.go:171","msg":"trace[985696595] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"400.504467ms","start":"2026-08-18T23:27:34.488285Z","end":"2026-08-18T23:27:34.88879Z","steps":["trace[985696595] 'process raft request' (duration: 400.323442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:34.88893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:34.488245Z","time spent":"400.602149ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:51.56517Z","caller":"traceutil/trace.go:171","msg":"trace[253149941] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"453.546632ms","start":"2026-08-18T23:27:51.111597Z","end":"2026-08-18T23:27:51.565144Z","steps":["trace[253149941] 'process raft request' (duration: 453.367167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:51.565336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:51.11158Z","time spent":"453.683085ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:52.204652Z","caller":"traceutil/trace.go:171","msg":"trace[392750251] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"136.101907ms","start":"2026-08-18T23:27:52.068525Z","end":"2026-08-18T23:27:52.204627Z","steps":["trace[392750251] 'process raft request' (duration: 135.946923ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:52.685508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.348629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-18T23:27:52.685597Z","caller":"traceutil/trace.go:171","msg":"trace[632162215] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1196; }","duration":"264.485923ms","start":"2026-08-18T23:27:52.421086Z","end":"2026-08-18T23:27:52.685572Z","steps":["trace[632162215] 'count revisions from in-memory index tree' (duration: 264.237577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:52.685857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.228521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-08-18T23:27:52.6859Z","caller":"traceutil/trace.go:171","msg":"trace[800839231] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1196; }","duration":"337.277553ms","start":"2026-08-18T23:27:52.34861Z","end":"2026-08-18T23:27:52.685888Z","steps":["trace[800839231] 'range keys from in-memory index tree' (duration: 337.067107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:52.685965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:52.348555Z","time spent":"337.367344ms","remote":"127.0.0.1:46870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5353,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-18T23:27:52.904705Z","caller":"traceutil/trace.go:171","msg":"trace[132604529] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"210.199248ms","start":"2026-08-18T23:27:52.694477Z","end":"2026-08-18T23:27:52.904676Z","steps":["trace[132604529] 'process raft request' (duration: 210.018203ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:53.873434Z","caller":"traceutil/trace.go:171","msg":"trace[157311347] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"299.591256ms","start":"2026-08-18T23:27:53.573818Z","end":"2026-08-18T23:27:53.873409Z","steps":["trace[157311347] 'process raft request' (duration: 299.440522ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:54.233988Z","caller":"traceutil/trace.go:171","msg":"trace[495833490] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1253; }","duration":"512.016809ms","start":"2026-08-18T23:27:53.721943Z","end":"2026-08-18T23:27:54.23396Z","steps":["trace[495833490] 'read index received' (duration: 151.376632ms)","trace[495833490] 'applied index is now lower than readState.Index' (duration: 360.638477ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:27:54.234041Z","caller":"traceutil/trace.go:171","msg":"trace[154081203] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"581.229691ms","start":"2026-08-18T23:27:53.652748Z","end":"2026-08-18T23:27:54.233978Z","steps":["trace[154081203] 'process raft request' (duration: 563.29723ms)","trace[154081203] 'compare' (duration: 17.49034ms)"],"step_count":2} {"level":"warn","ts":"2026-08-18T23:27:54.234303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.325467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-18T23:27:54.234822Z","caller":"traceutil/trace.go:171","msg":"trace[1708047635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1200; }","duration":"512.883391ms","start":"2026-08-18T23:27:53.721911Z","end":"2026-08-18T23:27:54.234795Z","steps":["trace[1708047635] 'agreement among raft nodes before linearized reading' (duration: 512.130382ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.234883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.721895Z","time spent":"512.975703ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-18T23:27:54.234338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.65272Z","time spent":"581.547659ms","remote":"127.0.0.1:46752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-18T23:27:54.332103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.097507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-18T23:27:54.332183Z","caller":"traceutil/trace.go:171","msg":"trace[1040328355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1201; }","duration":"559.21504ms","start":"2026-08-18T23:27:53.772948Z","end":"2026-08-18T23:27:54.332163Z","steps":["trace[1040328355] 'agreement among raft nodes before linearized reading' (duration: 558.994055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.332229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.772935Z","time spent":"559.285111ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-18T23:27:54.332328Z","caller":"traceutil/trace.go:171","msg":"trace[1379171440] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"428.767782ms","start":"2026-08-18T23:27:53.903533Z","end":"2026-08-18T23:27:54.332301Z","steps":["trace[1379171440] 'process raft request' (duration: 428.28335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.332429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.681326ms","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-08-18T23:27:54.332461Z","caller":"traceutil/trace.go:171","msg":"trace[421566616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1201; }","duration":"536.743227ms","start":"2026-08-18T23:27:53.79571Z","end":"2026-08-18T23:27:54.332453Z","steps":["trace[421566616] 'agreement among raft nodes before linearized reading' (duration: 536.568413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.332479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.795686Z","time spent":"536.788209ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-18T23:27:54.332468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.247582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-08-18T23:27:54.332515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.903509Z","time spent":"428.943717ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-18T23:27:54.332551Z","caller":"traceutil/trace.go:171","msg":"trace[459297005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1201; }","duration":"533.355574ms","start":"2026-08-18T23:27:53.799172Z","end":"2026-08-18T23:27:54.332527Z","steps":["trace[459297005] 'agreement among raft nodes before linearized reading' (duration: 533.086807ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.332611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:27:53.799165Z","time spent":"533.436626ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-18T23:27:54.465616Z","caller":"traceutil/trace.go:171","msg":"trace[1840829400] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"167.884097ms","start":"2026-08-18T23:27:54.297712Z","end":"2026-08-18T23:27:54.465596Z","steps":["trace[1840829400] 'process raft request' (duration: 167.747534ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:54.465618Z","caller":"traceutil/trace.go:171","msg":"trace[1585128983] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"226.402436ms","start":"2026-08-18T23:27:54.239186Z","end":"2026-08-18T23:27:54.465589Z","steps":["trace[1585128983] 'process raft request' (duration: 208.999178ms)","trace[1585128983] 'compare' (duration: 17.10417ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:27:54.465767Z","caller":"traceutil/trace.go:171","msg":"trace[782636362] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"129.633676ms","start":"2026-08-18T23:27:54.336099Z","end":"2026-08-18T23:27:54.465733Z","steps":["trace[782636362] 'process raft request' (duration: 129.425951ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:54.465831Z","caller":"traceutil/trace.go:171","msg":"trace[123303640] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"129.710268ms","start":"2026-08-18T23:27:54.3361Z","end":"2026-08-18T23:27:54.46581Z","steps":["trace[123303640] 'process raft request' (duration: 129.457762ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:27:54.466035Z","caller":"traceutil/trace.go:171","msg":"trace[1666730618] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"129.829581ms","start":"2026-08-18T23:27:54.336189Z","end":"2026-08-18T23:27:54.466018Z","steps":["trace[1666730618] 'process raft request' (duration: 129.497273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:27:54.644828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.680104ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-08-18T23:28:02.097383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605187232717051087,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-18T23:28:02.240982Z","caller":"traceutil/trace.go:171","msg":"trace[2119201] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"644.199149ms","start":"2026-08-18T23:28:01.596762Z","end":"2026-08-18T23:28:02.240961Z","steps":["trace[2119201] 'read index received' (duration: 644.028245ms)","trace[2119201] 'applied index is now lower than readState.Index' (duration: 170.004µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:28:02.241118Z","caller":"traceutil/trace.go:171","msg":"trace[677288846] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"881.262138ms","start":"2026-08-18T23:28:01.359764Z","end":"2026-08-18T23:28:02.241026Z","steps":["trace[677288846] 'process raft request' (duration: 881.067273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:28:02.24126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:28:01.359736Z","time spent":"881.447582ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13709,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-18T23:28:02.241164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.378123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-18T23:28:02.241413Z","caller":"traceutil/trace.go:171","msg":"trace[2046025649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"644.676931ms","start":"2026-08-18T23:28:01.596715Z","end":"2026-08-18T23:28:02.241392Z","steps":["trace[2046025649] 'agreement among raft nodes before linearized reading' (duration: 644.349493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:28:02.241468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:28:01.596695Z","time spent":"644.762343ms","remote":"127.0.0.1:46690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-18T23:28:02.464154Z","caller":"traceutil/trace.go:171","msg":"trace[1547030205] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1324; }","duration":"223.096105ms","start":"2026-08-18T23:28:02.241038Z","end":"2026-08-18T23:28:02.464134Z","steps":["trace[1547030205] 'read index received' (duration: 219.826525ms)","trace[1547030205] 'applied index is now lower than readState.Index' (duration: 3.26826ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:28:02.464245Z","caller":"traceutil/trace.go:171","msg":"trace[718529488] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"251.764531ms","start":"2026-08-18T23:28:02.212455Z","end":"2026-08-18T23:28:02.46422Z","steps":["trace[718529488] 'process raft request' (duration: 248.357237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:28:02.46433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.51496ms","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-08-18T23:28:02.464364Z","caller":"traceutil/trace.go:171","msg":"trace[2007484620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1268; }","duration":"562.603533ms","start":"2026-08-18T23:28:01.901753Z","end":"2026-08-18T23:28:02.464357Z","steps":["trace[2007484620] 'agreement among raft nodes before linearized reading' (duration: 562.452999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:28:02.464389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-18T23:28:01.901738Z","time spent":"562.646124ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-18T23:28:02.466117Z","caller":"traceutil/trace.go:171","msg":"trace[1714365724] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"103.69231ms","start":"2026-08-18T23:28:02.362413Z","end":"2026-08-18T23:28:02.466105Z","steps":["trace[1714365724] 'process raft request' (duration: 103.656119ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:28:02.466329Z","caller":"traceutil/trace.go:171","msg":"trace[539944775] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"220.216434ms","start":"2026-08-18T23:28:02.246106Z","end":"2026-08-18T23:28:02.466322Z","steps":["trace[539944775] 'process raft request' (duration: 219.809844ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:28:02.466475Z","caller":"traceutil/trace.go:171","msg":"trace[1825545634] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"219.244751ms","start":"2026-08-18T23:28:02.247223Z","end":"2026-08-18T23:28:02.466468Z","steps":["trace[1825545634] 'process raft request' (duration: 218.759479ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:28:02.466641Z","caller":"traceutil/trace.go:171","msg":"trace[285163784] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"215.066868ms","start":"2026-08-18T23:28:02.251567Z","end":"2026-08-18T23:28:02.466634Z","steps":["trace[285163784] 'process raft request' (duration: 214.458523ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:31:19.879502Z","caller":"traceutil/trace.go:171","msg":"trace[1602354393] linearizableReadLoop","detail":"{readStateIndex:2305; appliedIndex:2304; }","duration":"166.862236ms","start":"2026-08-18T23:31:19.712622Z","end":"2026-08-18T23:31:19.879484Z","steps":["trace[1602354393] 'read index received' (duration: 166.729653ms)","trace[1602354393] 'applied index is now lower than readState.Index' (duration: 131.493µs)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:31:19.879609Z","caller":"traceutil/trace.go:171","msg":"trace[1228473189] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"167.469401ms","start":"2026-08-18T23:31:19.71213Z","end":"2026-08-18T23:31:19.8796Z","steps":["trace[1228473189] 'process raft request' (duration: 167.244686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:31:19.879771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.145194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-18T23:31:19.879804Z","caller":"traceutil/trace.go:171","msg":"trace[1427181221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2207; }","duration":"167.216074ms","start":"2026-08-18T23:31:19.712572Z","end":"2026-08-18T23:31:19.879788Z","steps":["trace[1427181221] 'agreement among raft nodes before linearized reading' (duration: 167.120452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:31:19.880057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.206674ms","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-08-18T23:31:19.880119Z","caller":"traceutil/trace.go:171","msg":"trace[84203529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2207; }","duration":"149.334488ms","start":"2026-08-18T23:31:19.730772Z","end":"2026-08-18T23:31:19.880106Z","steps":["trace[84203529] 'agreement among raft nodes before linearized reading' (duration: 149.147494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-18T23:31:20.048166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.929886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-18T23:31:20.04864Z","caller":"traceutil/trace.go:171","msg":"trace[473077857] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"163.842294ms","start":"2026-08-18T23:31:19.884779Z","end":"2026-08-18T23:31:20.048621Z","steps":["trace[473077857] 'process raft request' (duration: 163.781513ms)"],"step_count":1} {"level":"info","ts":"2026-08-18T23:31:20.048646Z","caller":"traceutil/trace.go:171","msg":"trace[1478634812] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"164.90413ms","start":"2026-08-18T23:31:19.883705Z","end":"2026-08-18T23:31:20.048609Z","steps":["trace[1478634812] 'process raft request' (duration: 31.442041ms)","trace[1478634812] 'compare' (duration: 132.768392ms)"],"step_count":2} {"level":"info","ts":"2026-08-18T23:31:20.048704Z","caller":"traceutil/trace.go:171","msg":"trace[2118248584] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"164.651693ms","start":"2026-08-18T23:31:19.884015Z","end":"2026-08-18T23:31:20.048667Z","steps":["trace[2118248584] 'process raft request' (duration: 164.336006ms)"],"step_count":1}