{"level":"warn","ts":"2026-06-09T22:25:04.133328Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:25:04.133459Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.143:2380","--initial-cluster=instance=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143: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-06-09T22:25:04.133556Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:25:04.133574Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-06-09T22:25:04.133599Z","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-06-09T22:25:04.134481Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-06-09T22:25:04.134674Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.143: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-06-09T22:25:04.138638Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.687339ms"} {"level":"info","ts":"2026-06-09T22:25:04.1483Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"} {"level":"info","ts":"2026-06-09T22:25:04.148408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:25:04.148436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 0"} {"level":"info","ts":"2026-06-09T22:25:04.148451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:25:04.148464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 1"} {"level":"info","ts":"2026-06-09T22:25:04.148511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"warn","ts":"2026-06-09T22:25:04.159802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:25:04.163457Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:25:04.164604Z","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-06-09T22:25:04.166799Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:25:04.169903Z","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-06-09T22:25:04.170007Z","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-06-09T22:25:04.170034Z","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-06-09T22:25:04.167875Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:25:04.175869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"info","ts":"2026-06-09T22:25:04.176278Z","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-06-09T22:25:04.176467Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-06-09T22:25:04.176517Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-06-09T22:25:04.176703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-06-09T22:25:04.177187Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:25:04.177218Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:25:04.949561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:25:04.949602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:25:04.949616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"} {"level":"info","ts":"2026-06-09T22:25:04.949627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:25:04.949632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-06-09T22:25:04.94964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became leader at term 2"} {"level":"info","ts":"2026-06-09T22:25:04.949647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-06-09T22:25:04.950487Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:25:04.951221Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.143:2379]}","request-path":"/0/members/e5bed6df0e44a0b1/attributes","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:25:04.95127Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:25:04.951685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:25:04.951765Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:25:04.951856Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:25:04.951878Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:25:04.953262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"info","ts":"2026-06-09T22:25:04.954576Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:25:04.96803Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:25:04.968062Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:25:06.58124Z","caller":"traceutil/trace.go:171","msg":"trace[1413769142] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"397.64912ms","start":"2026-06-09T22:25:06.18357Z","end":"2026-06-09T22:25:06.58122Z","steps":["trace[1413769142] 'read index received' (duration: 397.536107ms)","trace[1413769142] 'applied index is now lower than readState.Index' (duration: 112.373µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:06.58131Z","caller":"traceutil/trace.go:171","msg":"trace[481714672] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"397.730482ms","start":"2026-06-09T22:25:06.183528Z","end":"2026-06-09T22:25:06.581258Z","steps":["trace[481714672] 'process raft request' (duration: 397.555217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:06.581497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.902986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:06.581543Z","caller":"traceutil/trace.go:171","msg":"trace[1743325160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:2; }","duration":"397.979339ms","start":"2026-06-09T22:25:06.183557Z","end":"2026-06-09T22:25:06.581536Z","steps":["trace[1743325160] 'agreement among raft nodes before linearized reading' (duration: 397.754233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:06.581593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.183551Z","time spent":"398.03431ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T22:25:06.582146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.183516Z","time spent":"397.910777ms","remote":"127.0.0.1:34446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:25:07.081366Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579210589209007233,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T22:25:07.259976Z","caller":"traceutil/trace.go:171","msg":"trace[221512615] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.076147535s","start":"2026-06-09T22:25:06.1838Z","end":"2026-06-09T22:25:07.259947Z","steps":["trace[221512615] 'process raft request' (duration: 1.076057212s)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.260281Z","caller":"traceutil/trace.go:171","msg":"trace[1785168506] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.075653842s","start":"2026-06-09T22:25:06.18462Z","end":"2026-06-09T22:25:07.260273Z","steps":["trace[1785168506] 'process raft request' (duration: 1.075264011s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.260334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.184608Z","time spent":"1.075698933s","remote":"127.0.0.1:34644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.260408Z","caller":"traceutil/trace.go:171","msg":"trace[1884202896] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.076625478s","start":"2026-06-09T22:25:06.183751Z","end":"2026-06-09T22:25:07.260376Z","steps":["trace[1884202896] 'process raft request' (duration: 1.076004831s)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.26047Z","caller":"traceutil/trace.go:171","msg":"trace[1965062736] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.075737994s","start":"2026-06-09T22:25:06.184719Z","end":"2026-06-09T22:25:07.260457Z","steps":["trace[1965062736] 'process raft request' (duration: 1.075182568s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.260508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.184714Z","time spent":"1.075776694s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:25:07.260578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.183735Z","time spent":"1.07675452s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.260617Z","caller":"traceutil/trace.go:171","msg":"trace[547379721] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.075768485s","start":"2026-06-09T22:25:06.184845Z","end":"2026-06-09T22:25:07.260613Z","steps":["trace[547379721] 'process raft request' (duration: 1.075094326s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.260644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.184842Z","time spent":"1.075789105s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.260718Z","caller":"traceutil/trace.go:171","msg":"trace[361669046] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.075846346s","start":"2026-06-09T22:25:06.184866Z","end":"2026-06-09T22:25:07.260712Z","steps":["trace[361669046] 'process raft request' (duration: 1.075086686s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.260747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.184863Z","time spent":"1.075872587s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.2606Z","caller":"traceutil/trace.go:171","msg":"trace[1359999694] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.075776365s","start":"2026-06-09T22:25:06.184818Z","end":"2026-06-09T22:25:07.260594Z","steps":["trace[1359999694] 'process raft request' (duration: 1.075104927s)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.260881Z","caller":"traceutil/trace.go:171","msg":"trace[83541640] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.002652095s","start":"2026-06-09T22:25:06.258223Z","end":"2026-06-09T22:25:07.260875Z","steps":["trace[83541640] 'process raft request' (duration: 1.001745241s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.260893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.184814Z","time spent":"1.076047452s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.260984Z","caller":"traceutil/trace.go:171","msg":"trace[901515699] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"991.014705ms","start":"2026-06-09T22:25:06.269963Z","end":"2026-06-09T22:25:07.260978Z","steps":["trace[901515699] 'process raft request' (duration: 990.044738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.261016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.26994Z","time spent":"991.062675ms","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:25:07.260142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074467109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-06-09T22:25:07.261105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.052836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.261124Z","caller":"traceutil/trace.go:171","msg":"trace[1977571821] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"938.092286ms","start":"2026-06-09T22:25:06.323026Z","end":"2026-06-09T22:25:07.261118Z","steps":["trace[1977571821] 'agreement among raft nodes before linearized reading' (duration: 938.058445ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.261134Z","caller":"traceutil/trace.go:171","msg":"trace[431245439] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"1.075481676s","start":"2026-06-09T22:25:06.185634Z","end":"2026-06-09T22:25:07.261116Z","steps":["trace[431245439] 'agreement among raft nodes before linearized reading' (duration: 1.074436098s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.26117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.016974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.261189Z","caller":"traceutil/trace.go:171","msg":"trace[490395815] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"954.073965ms","start":"2026-06-09T22:25:06.30711Z","end":"2026-06-09T22:25:07.261184Z","steps":["trace[490395815] 'agreement among raft nodes before linearized reading' (duration: 954.049054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.261186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.185628Z","time spent":"1.075541028s","remote":"127.0.0.1:34550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-09T22:25:07.26121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.307097Z","time spent":"954.109036ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-09T22:25:07.261304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003394775s","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":"warn","ts":"2026-06-09T22:25:07.260916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.258195Z","time spent":"1.002705498s","remote":"127.0.0.1:34838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:07.261328Z","caller":"traceutil/trace.go:171","msg":"trace[952867468] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.003419305s","start":"2026-06-09T22:25:06.257902Z","end":"2026-06-09T22:25:07.261321Z","steps":["trace[952867468] 'agreement among raft nodes before linearized reading' (duration: 1.003386735s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.26135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.257858Z","time spent":"1.003483638s","remote":"127.0.0.1:34452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-09T22:25:07.261457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005924284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T22:25:07.26115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.322987Z","time spent":"938.158998ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-09T22:25:07.261487Z","caller":"traceutil/trace.go:171","msg":"trace[1766870997] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.005971775s","start":"2026-06-09T22:25:06.255509Z","end":"2026-06-09T22:25:07.261481Z","steps":["trace[1766870997] 'agreement among raft nodes before linearized reading' (duration: 1.005927713s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.261504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.255499Z","time spent":"1.006000575s","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-09T22:25:07.261559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006696944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.261577Z","caller":"traceutil/trace.go:171","msg":"trace[112570444] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:0; response_revision:11; }","duration":"1.006758736s","start":"2026-06-09T22:25:06.254814Z","end":"2026-06-09T22:25:07.261573Z","steps":["trace[112570444] 'agreement among raft nodes before linearized reading' (duration: 1.006732405s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.261594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.254791Z","time spent":"1.006798816s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.143\" "} {"level":"warn","ts":"2026-06-09T22:25:07.26169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074594913s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.26171Z","caller":"traceutil/trace.go:171","msg":"trace[1835231969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"1.074615093s","start":"2026-06-09T22:25:06.18709Z","end":"2026-06-09T22:25:07.261705Z","steps":["trace[1835231969] 'agreement among raft nodes before linearized reading' (duration: 1.074586583s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.261725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.187068Z","time spent":"1.074654495s","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T22:25:07.26185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.183793Z","time spent":"1.076485254s","remote":"127.0.0.1:34430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:25:07.260045Z","caller":"traceutil/trace.go:171","msg":"trace[372076487] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"678.73732ms","start":"2026-06-09T22:25:06.581296Z","end":"2026-06-09T22:25:07.260034Z","steps":["trace[372076487] 'read index received' (duration: 678.415442ms)","trace[372076487] 'applied index is now lower than readState.Index' (duration: 321.308µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:25:07.262297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.719396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.262406Z","caller":"traceutil/trace.go:171","msg":"trace[522226703] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"623.778068ms","start":"2026-06-09T22:25:06.638559Z","end":"2026-06-09T22:25:07.262337Z","steps":["trace[522226703] 'agreement among raft nodes before linearized reading' (duration: 623.692405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.262451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:06.638536Z","time spent":"623.905052ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-09T22:25:07.262659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.309113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.262703Z","caller":"traceutil/trace.go:171","msg":"trace[1959055764] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"107.380495ms","start":"2026-06-09T22:25:07.155311Z","end":"2026-06-09T22:25:07.262692Z","steps":["trace[1959055764] 'agreement among raft nodes before linearized reading' (duration: 107.315774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.262878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.831888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.262919Z","caller":"traceutil/trace.go:171","msg":"trace[933971910] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"107.953581ms","start":"2026-06-09T22:25:07.154955Z","end":"2026-06-09T22:25:07.262909Z","steps":["trace[933971910] 'agreement among raft nodes before linearized reading' (duration: 107.898569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.263325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.095646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.263577Z","caller":"traceutil/trace.go:171","msg":"trace[596410072] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"139.335572ms","start":"2026-06-09T22:25:07.124193Z","end":"2026-06-09T22:25:07.263528Z","steps":["trace[596410072] 'agreement among raft nodes before linearized reading' (duration: 138.998563ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404571Z","caller":"traceutil/trace.go:171","msg":"trace[1024611931] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"136.293832ms","start":"2026-06-09T22:25:07.268246Z","end":"2026-06-09T22:25:07.40454Z","steps":["trace[1024611931] 'process raft request' (duration: 132.139431ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404662Z","caller":"traceutil/trace.go:171","msg":"trace[1077542729] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"136.141188ms","start":"2026-06-09T22:25:07.268512Z","end":"2026-06-09T22:25:07.404654Z","steps":["trace[1077542729] 'process raft request' (duration: 135.922972ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404625Z","caller":"traceutil/trace.go:171","msg":"trace[805448076] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"133.6264ms","start":"2026-06-09T22:25:07.27098Z","end":"2026-06-09T22:25:07.404606Z","steps":["trace[805448076] 'process raft request' (duration: 133.488756ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404793Z","caller":"traceutil/trace.go:171","msg":"trace[726016476] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"133.713752ms","start":"2026-06-09T22:25:07.271013Z","end":"2026-06-09T22:25:07.404727Z","steps":["trace[726016476] 'process raft request' (duration: 133.469746ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404965Z","caller":"traceutil/trace.go:171","msg":"trace[9941381] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"133.659841ms","start":"2026-06-09T22:25:07.271285Z","end":"2026-06-09T22:25:07.404945Z","steps":["trace[9941381] 'process raft request' (duration: 133.257811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.404965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.918937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.405077Z","caller":"traceutil/trace.go:171","msg":"trace[1393257308] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"132.695564ms","start":"2026-06-09T22:25:07.27237Z","end":"2026-06-09T22:25:07.405066Z","steps":["trace[1393257308] 'process raft request' (duration: 132.284494ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.405099Z","caller":"traceutil/trace.go:171","msg":"trace[791651782] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"133.749293ms","start":"2026-06-09T22:25:07.27134Z","end":"2026-06-09T22:25:07.405089Z","steps":["trace[791651782] 'process raft request' (duration: 133.22915ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.40511Z","caller":"traceutil/trace.go:171","msg":"trace[542901547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"134.03617ms","start":"2026-06-09T22:25:07.270978Z","end":"2026-06-09T22:25:07.405015Z","steps":["trace[542901547] 'agreement among raft nodes before linearized reading' (duration: 133.856736ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.404811Z","caller":"traceutil/trace.go:171","msg":"trace[961314410] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"133.709672ms","start":"2026-06-09T22:25:07.271028Z","end":"2026-06-09T22:25:07.404737Z","steps":["trace[961314410] 'read index received' (duration: 129.369856ms)","trace[961314410] 'applied index is now lower than readState.Index' (duration: 4.339046ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:07.405178Z","caller":"traceutil/trace.go:171","msg":"trace[129522764] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"134.079913ms","start":"2026-06-09T22:25:07.271085Z","end":"2026-06-09T22:25:07.405165Z","steps":["trace[129522764] 'process raft request' (duration: 133.426375ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.405389Z","caller":"traceutil/trace.go:171","msg":"trace[1858774392] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"133.512607ms","start":"2026-06-09T22:25:07.271138Z","end":"2026-06-09T22:25:07.40465Z","steps":["trace[1858774392] 'process raft request' (duration: 133.390794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:07.405479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.726223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T22:25:07.405579Z","caller":"traceutil/trace.go:171","msg":"trace[1210701580] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"133.931367ms","start":"2026-06-09T22:25:07.271603Z","end":"2026-06-09T22:25:07.405534Z","steps":["trace[1210701580] 'agreement among raft nodes before linearized reading' (duration: 133.700192ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.405653Z","caller":"traceutil/trace.go:171","msg":"trace[158289062] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"131.799741ms","start":"2026-06-09T22:25:07.273841Z","end":"2026-06-09T22:25:07.40564Z","steps":["trace[158289062] 'process raft request' (duration: 130.830605ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:07.405765Z","caller":"traceutil/trace.go:171","msg":"trace[782823449] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"133.474075ms","start":"2026-06-09T22:25:07.271631Z","end":"2026-06-09T22:25:07.405105Z","steps":["trace[782823449] 'process raft request' (duration: 133.006974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:44.662471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.343236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T22:25:44.662497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.415254ms","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-06-09T22:25:44.662539Z","caller":"traceutil/trace.go:171","msg":"trace[108734044] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:607; }","duration":"174.454819ms","start":"2026-06-09T22:25:44.48807Z","end":"2026-06-09T22:25:44.662525Z","steps":["trace[108734044] 'range keys from in-memory index tree' (duration: 174.233872ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:44.662559Z","caller":"traceutil/trace.go:171","msg":"trace[1930700907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"131.510106ms","start":"2026-06-09T22:25:44.531035Z","end":"2026-06-09T22:25:44.662545Z","steps":["trace[1930700907] 'range keys from in-memory index tree' (duration: 131.214308ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:44.830006Z","caller":"traceutil/trace.go:171","msg":"trace[987535515] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"157.53361ms","start":"2026-06-09T22:25:44.672449Z","end":"2026-06-09T22:25:44.829982Z","steps":["trace[987535515] 'process raft request' (duration: 157.341515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:45.033424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.13663ms","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-06-09T22:25:45.03351Z","caller":"traceutil/trace.go:171","msg":"trace[1496299623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:608; }","duration":"167.269732ms","start":"2026-06-09T22:25:44.866219Z","end":"2026-06-09T22:25:45.033489Z","steps":["trace[1496299623] 'range keys from in-memory index tree' (duration: 166.944815ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:47.710524Z","caller":"traceutil/trace.go:171","msg":"trace[1897285012] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"196.435298ms","start":"2026-06-09T22:25:47.514051Z","end":"2026-06-09T22:25:47.710487Z","steps":["trace[1897285012] 'process raft request' (duration: 195.71968ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:47.818747Z","caller":"traceutil/trace.go:171","msg":"trace[31984669] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"103.595253ms","start":"2026-06-09T22:25:47.715125Z","end":"2026-06-09T22:25:47.81872Z","steps":["trace[31984669] 'process raft request' (duration: 63.665049ms)","trace[31984669] 'compare' (duration: 39.564915ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:25:48.43352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.885426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:25:48.433835Z","caller":"traceutil/trace.go:171","msg":"trace[1155002669] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"664.579472ms","start":"2026-06-09T22:25:47.769225Z","end":"2026-06-09T22:25:48.433804Z","steps":["trace[1155002669] 'process raft request' (duration: 398.209473ms)","trace[1155002669] 'compare' (duration: 265.523967ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:48.433901Z","caller":"traceutil/trace.go:171","msg":"trace[629506219] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"611.152269ms","start":"2026-06-09T22:25:47.822735Z","end":"2026-06-09T22:25:48.433887Z","steps":["trace[629506219] 'process raft request' (duration: 610.880712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:48.433967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:47.822718Z","time spent":"611.2117ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:25:48.433983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:47.769198Z","time spent":"664.716735ms","remote":"127.0.0.1:34890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:25:48.433881Z","caller":"traceutil/trace.go:171","msg":"trace[1772405637] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"406.519219ms","start":"2026-06-09T22:25:48.02732Z","end":"2026-06-09T22:25:48.433839Z","steps":["trace[1772405637] 'read index received' (duration: 140.12681ms)","trace[1772405637] 'applied index is now lower than readState.Index' (duration: 266.387648ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:25:48.434127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.245953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T22:25:48.43416Z","caller":"traceutil/trace.go:171","msg":"trace[2044359846] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:631; }","duration":"320.297525ms","start":"2026-06-09T22:25:48.113853Z","end":"2026-06-09T22:25:48.434151Z","steps":["trace[2044359846] 'agreement among raft nodes before linearized reading' (duration: 320.230524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:48.434188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:48.113841Z","time spent":"320.341517ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.143\" "} {"level":"warn","ts":"2026-06-09T22:25:48.434315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.980282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2wqhw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-09T22:25:48.435318Z","caller":"traceutil/trace.go:171","msg":"trace[976351195] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2wqhw; range_end:; response_count:1; response_revision:631; }","duration":"407.077223ms","start":"2026-06-09T22:25:48.027281Z","end":"2026-06-09T22:25:48.434359Z","steps":["trace[976351195] 'agreement among raft nodes before linearized reading' (duration: 406.715553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:48.435429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:48.027267Z","time spent":"408.145591ms","remote":"127.0.0.1:34562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-2wqhw\" "} {"level":"warn","ts":"2026-06-09T22:26:04.943911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.302224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T22:26:04.943982Z","caller":"traceutil/trace.go:171","msg":"trace[1968723838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"445.422467ms","start":"2026-06-09T22:26:04.498549Z","end":"2026-06-09T22:26:04.943971Z","steps":["trace[1968723838] 'range keys from in-memory index tree' (duration: 445.092888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:04.944002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:26:04.498527Z","time spent":"445.469997ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T22:26:38.634339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.509453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:26:38.634567Z","caller":"traceutil/trace.go:171","msg":"trace[186280215] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"479.413854ms","start":"2026-06-09T22:26:38.155118Z","end":"2026-06-09T22:26:38.634532Z","steps":["trace[186280215] 'process raft request' (duration: 80.600692ms)","trace[186280215] 'compare' (duration: 398.313979ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:26:38.634634Z","caller":"traceutil/trace.go:171","msg":"trace[1788307066] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"335.363631ms","start":"2026-06-09T22:26:38.299253Z","end":"2026-06-09T22:26:38.634617Z","steps":["trace[1788307066] 'process raft request' (duration: 335.260008ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:38.634633Z","caller":"traceutil/trace.go:171","msg":"trace[1268840309] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"475.78311ms","start":"2026-06-09T22:26:38.158812Z","end":"2026-06-09T22:26:38.634595Z","steps":["trace[1268840309] 'read index received' (duration: 76.915837ms)","trace[1268840309] 'applied index is now lower than readState.Index' (duration: 398.863023ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:26:38.634699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:26:38.155093Z","time spent":"479.547907ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:26:38.634718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:26:38.299211Z","time spent":"335.462363ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:26:38.635094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.173399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T22:26:38.635255Z","caller":"traceutil/trace.go:171","msg":"trace[520897545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"476.440277ms","start":"2026-06-09T22:26:38.158748Z","end":"2026-06-09T22:26:38.635188Z","steps":["trace[520897545] 'agreement among raft nodes before linearized reading' (duration: 475.990525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:38.635429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:26:38.158727Z","time spent":"476.685043ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-09T22:26:38.746016Z","caller":"traceutil/trace.go:171","msg":"trace[2139364453] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"104.953928ms","start":"2026-06-09T22:26:38.641037Z","end":"2026-06-09T22:26:38.745991Z","steps":["trace[2139364453] 'read index received' (duration: 104.585788ms)","trace[2139364453] 'applied index is now lower than readState.Index' (duration: 367.03µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:26:38.746093Z","caller":"traceutil/trace.go:171","msg":"trace[338265331] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"106.052367ms","start":"2026-06-09T22:26:38.640002Z","end":"2026-06-09T22:26:38.746054Z","steps":["trace[338265331] 'process raft request' (duration: 105.688077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:38.746147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.085661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-09T22:26:38.746182Z","caller":"traceutil/trace.go:171","msg":"trace[910043865] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1009; }","duration":"105.151873ms","start":"2026-06-09T22:26:38.641019Z","end":"2026-06-09T22:26:38.746171Z","steps":["trace[910043865] 'agreement among raft nodes before linearized reading' (duration: 105.065481ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:02.705445Z","caller":"traceutil/trace.go:171","msg":"trace[2073043879] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"136.429437ms","start":"2026-06-09T22:27:02.568989Z","end":"2026-06-09T22:27:02.705418Z","steps":["trace[2073043879] 'process raft request' (duration: 136.233652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:03.747229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.993915ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-09T22:27:03.747583Z","caller":"traceutil/trace.go:171","msg":"trace[1353757535] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1131; }","duration":"430.045025ms","start":"2026-06-09T22:27:03.317511Z","end":"2026-06-09T22:27:03.747556Z","steps":["trace[1353757535] 'read index received' (duration: 116.726141ms)","trace[1353757535] 'applied index is now lower than readState.Index' (duration: 313.317684ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:27:03.747659Z","caller":"traceutil/trace.go:171","msg":"trace[442120467] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"443.207232ms","start":"2026-06-09T22:27:03.304411Z","end":"2026-06-09T22:27:03.747618Z","steps":["trace[442120467] 'process raft request' (duration: 442.969996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:03.74789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:03.304392Z","time spent":"443.364756ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:27:03.747937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.372903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-09T22:27:03.747967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.429583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:27:03.748068Z","caller":"traceutil/trace.go:171","msg":"trace[1241310567] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1090; }","duration":"428.574426ms","start":"2026-06-09T22:27:03.319472Z","end":"2026-06-09T22:27:03.748046Z","steps":["trace[1241310567] 'agreement among raft nodes before linearized reading' (duration: 428.401342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:03.748117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:03.319459Z","time spent":"428.646698ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-06-09T22:27:03.74801Z","caller":"traceutil/trace.go:171","msg":"trace[1373717689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"430.512666ms","start":"2026-06-09T22:27:03.31748Z","end":"2026-06-09T22:27:03.747992Z","steps":["trace[1373717689] 'agreement among raft nodes before linearized reading' (duration: 430.22751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:03.748217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:03.317458Z","time spent":"430.744123ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T22:27:03.748226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.59455ms","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-06-09T22:27:03.748275Z","caller":"traceutil/trace.go:171","msg":"trace[465016687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"325.680422ms","start":"2026-06-09T22:27:03.422581Z","end":"2026-06-09T22:27:03.748261Z","steps":["trace[465016687] 'agreement among raft nodes before linearized reading' (duration: 325.463446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:03.748314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:03.422563Z","time spent":"325.743664ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T22:27:04.883626Z","caller":"traceutil/trace.go:171","msg":"trace[926772284] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"135.296547ms","start":"2026-06-09T22:27:04.748295Z","end":"2026-06-09T22:27:04.883591Z","steps":["trace[926772284] 'process raft request' (duration: 135.065432ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:20.336845Z","caller":"traceutil/trace.go:171","msg":"trace[1510836434] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"387.950832ms","start":"2026-06-09T22:27:19.948859Z","end":"2026-06-09T22:27:20.336809Z","steps":["trace[1510836434] 'read index received' (duration: 327.187431ms)","trace[1510836434] 'applied index is now lower than readState.Index' (duration: 60.762031ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:27:20.336982Z","caller":"traceutil/trace.go:171","msg":"trace[736899105] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"458.536816ms","start":"2026-06-09T22:27:19.878407Z","end":"2026-06-09T22:27:20.336944Z","steps":["trace[736899105] 'process raft request' (duration: 397.61675ms)","trace[736899105] 'compare' (duration: 60.591377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:27:20.337038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.148517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:27:20.33708Z","caller":"traceutil/trace.go:171","msg":"trace[209975510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1196; }","duration":"388.26977ms","start":"2026-06-09T22:27:19.948798Z","end":"2026-06-09T22:27:20.337067Z","steps":["trace[209975510] 'agreement among raft nodes before linearized reading' (duration: 388.152337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:20.337131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:19.878394Z","time spent":"458.654209ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:27:20.337364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:19.948753Z","time spent":"388.357313ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-06-09T22:27:20.435424Z","caller":"traceutil/trace.go:171","msg":"trace[2028308759] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"132.078055ms","start":"2026-06-09T22:27:20.303326Z","end":"2026-06-09T22:27:20.435405Z","steps":["trace[2028308759] 'process raft request' (duration: 131.970782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:20.435695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.277396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:27:20.435719Z","caller":"traceutil/trace.go:171","msg":"trace[488096819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1197; }","duration":"387.346087ms","start":"2026-06-09T22:27:20.048367Z","end":"2026-06-09T22:27:20.435713Z","steps":["trace[488096819] 'agreement among raft nodes before linearized reading' (duration: 387.291216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:20.435738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:20.048348Z","time spent":"387.384169ms","remote":"127.0.0.1:34352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T22:27:20.435946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.107022ms","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-06-09T22:27:20.43596Z","caller":"traceutil/trace.go:171","msg":"trace[727870918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1197; }","duration":"403.170064ms","start":"2026-06-09T22:27:20.032785Z","end":"2026-06-09T22:27:20.435955Z","steps":["trace[727870918] 'agreement among raft nodes before linearized reading' (duration: 403.080582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:20.435973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:20.032757Z","time spent":"403.212694ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T22:27:20.551394Z","caller":"traceutil/trace.go:171","msg":"trace[208297726] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"111.267461ms","start":"2026-06-09T22:27:20.440104Z","end":"2026-06-09T22:27:20.551371Z","steps":["trace[208297726] 'process raft request' (duration: 111.109357ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:32.531362Z","caller":"traceutil/trace.go:171","msg":"trace[1513198267] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"127.127538ms","start":"2026-06-09T22:27:32.404208Z","end":"2026-06-09T22:27:32.531336Z","steps":["trace[1513198267] 'process raft request' (duration: 126.931452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:40.423395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.790146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:27:40.423502Z","caller":"traceutil/trace.go:171","msg":"trace[134238960] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1297; }","duration":"206.966935ms","start":"2026-06-09T22:27:40.216511Z","end":"2026-06-09T22:27:40.423478Z","steps":["trace[134238960] 'range keys from in-memory index tree' (duration: 206.661889ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:40.709182Z","caller":"traceutil/trace.go:171","msg":"trace[587516835] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"279.394132ms","start":"2026-06-09T22:27:40.429751Z","end":"2026-06-09T22:27:40.709145Z","steps":["trace[587516835] 'process raft request' (duration: 279.241793ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:40.776354Z","caller":"traceutil/trace.go:171","msg":"trace[1607751318] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1349; }","duration":"216.134003ms","start":"2026-06-09T22:27:40.560196Z","end":"2026-06-09T22:27:40.77633Z","steps":["trace[1607751318] 'read index received' (duration: 148.836417ms)","trace[1607751318] 'applied index is now lower than readState.Index' (duration: 67.296656ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:27:40.776512Z","caller":"traceutil/trace.go:171","msg":"trace[268438031] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"346.058413ms","start":"2026-06-09T22:27:40.430445Z","end":"2026-06-09T22:27:40.776503Z","steps":["trace[268438031] 'process raft request' (duration: 343.599544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:40.77659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:27:40.430419Z","time spent":"346.114746ms","remote":"127.0.0.1:34656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:27:40.776824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.62379ms","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-06-09T22:27:40.776847Z","caller":"traceutil/trace.go:171","msg":"trace[495511887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"216.692934ms","start":"2026-06-09T22:27:40.560148Z","end":"2026-06-09T22:27:40.776841Z","steps":["trace[495511887] 'agreement among raft nodes before linearized reading' (duration: 216.573957ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:40.839215Z","caller":"traceutil/trace.go:171","msg":"trace[1183699863] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"125.764474ms","start":"2026-06-09T22:27:40.713409Z","end":"2026-06-09T22:27:40.839174Z","steps":["trace[1183699863] 'process raft request' (duration: 125.573194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:40.839351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.941735ms","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-06-09T22:27:40.83943Z","caller":"traceutil/trace.go:171","msg":"trace[1330450766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1300; }","duration":"190.066304ms","start":"2026-06-09T22:27:40.649345Z","end":"2026-06-09T22:27:40.839412Z","steps":["trace[1330450766] 'agreement among raft nodes before linearized reading' (duration: 189.8298ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:49.190104Z","caller":"traceutil/trace.go:171","msg":"trace[998375904] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1411; }","duration":"245.515872ms","start":"2026-06-09T22:27:48.944563Z","end":"2026-06-09T22:27:49.190079Z","steps":["trace[998375904] 'read index received' (duration: 245.278829ms)","trace[998375904] 'applied index is now lower than readState.Index' (duration: 235.883µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:27:49.190225Z","caller":"traceutil/trace.go:171","msg":"trace[1565324755] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"297.352385ms","start":"2026-06-09T22:27:48.892862Z","end":"2026-06-09T22:27:49.190214Z","steps":["trace[1565324755] 'process raft request' (duration: 297.032718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:27:49.191052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.979508ms","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-06-09T22:27:49.191142Z","caller":"traceutil/trace.go:171","msg":"trace[1468469835] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1358; }","duration":"246.617024ms","start":"2026-06-09T22:27:48.944506Z","end":"2026-06-09T22:27:49.191123Z","steps":["trace[1468469835] 'agreement among raft nodes before linearized reading' (duration: 245.888483ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:49.280882Z","caller":"traceutil/trace.go:171","msg":"trace[679182880] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"250.99023ms","start":"2026-06-09T22:27:49.029859Z","end":"2026-06-09T22:27:49.280849Z","steps":["trace[679182880] 'process raft request' (duration: 205.98975ms)","trace[679182880] 'compare' (duration: 44.793647ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:27:49.281213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.726075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-09T22:27:49.28128Z","caller":"traceutil/trace.go:171","msg":"trace[377027136] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1360; }","duration":"278.81547ms","start":"2026-06-09T22:27:49.002449Z","end":"2026-06-09T22:27:49.281265Z","steps":["trace[377027136] 'agreement among raft nodes before linearized reading' (duration: 278.587617ms)"],"step_count":1}