{"level":"warn","ts":"2026-10-07T03:56:10.711742Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-07T03:56:10.711845Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.5: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://162.253.55.5:2380","--initial-cluster=instance=https://162.253.55.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.5: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-10-07T03:56:10.711924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-07T03:56:10.711937Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.5:2380"]} {"level":"info","ts":"2026-10-07T03:56:10.711964Z","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-10-07T03:56:10.712779Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"]} {"level":"info","ts":"2026-10-07T03:56:10.712869Z","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://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.5: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-10-07T03:56:10.717837Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.693372ms"} {"level":"info","ts":"2026-10-07T03:56:10.726359Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b512f7d8ac93be25","cluster-id":"e1953d9a3e7368e5"} {"level":"info","ts":"2026-10-07T03:56:10.72648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=()"} {"level":"info","ts":"2026-10-07T03:56:10.726511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 0"} {"level":"info","ts":"2026-10-07T03:56:10.726556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b512f7d8ac93be25 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-07T03:56:10.726573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 1"} {"level":"info","ts":"2026-10-07T03:56:10.726613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"} {"level":"warn","ts":"2026-10-07T03:56:10.73609Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-07T03:56:10.737814Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-07T03:56:10.739516Z","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-10-07T03:56:10.741886Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b512f7d8ac93be25","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-07T03:56:10.742461Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b512f7d8ac93be25","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-07T03:56:10.742452Z","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-10-07T03:56:10.742545Z","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-10-07T03:56:10.742574Z","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-10-07T03:56:10.74284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"} {"level":"info","ts":"2026-10-07T03:56:10.743405Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","added-peer-id":"b512f7d8ac93be25","added-peer-peer-urls":["https://162.253.55.5:2380"]} {"level":"info","ts":"2026-10-07T03:56:10.746538Z","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-10-07T03:56:10.746607Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.5:2380"} {"level":"info","ts":"2026-10-07T03:56:10.747024Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.5:2380"} {"level":"info","ts":"2026-10-07T03:56:10.747279Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b512f7d8ac93be25","initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-07T03:56:10.747353Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-07T03:56:11.027311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 is starting a new election at term 1"} {"level":"info","ts":"2026-10-07T03:56:11.027376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-07T03:56:11.027397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgPreVoteResp from b512f7d8ac93be25 at term 1"} {"level":"info","ts":"2026-10-07T03:56:11.027411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became candidate at term 2"} {"level":"info","ts":"2026-10-07T03:56:11.027417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgVoteResp from b512f7d8ac93be25 at term 2"} {"level":"info","ts":"2026-10-07T03:56:11.027427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became leader at term 2"} {"level":"info","ts":"2026-10-07T03:56:11.027436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b512f7d8ac93be25 elected leader b512f7d8ac93be25 at term 2"} {"level":"info","ts":"2026-10-07T03:56:11.028365Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T03:56:11.029305Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T03:56:11.029294Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b512f7d8ac93be25","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.5:2379]}","request-path":"/0/members/b512f7d8ac93be25/attributes","cluster-id":"e1953d9a3e7368e5","publish-timeout":"7s"} {"level":"info","ts":"2026-10-07T03:56:11.029462Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T03:56:11.029648Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T03:56:11.02975Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T03:56:11.029781Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T03:56:11.029821Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-07T03:56:11.029869Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-07T03:56:11.032903Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.5:2379"} {"level":"info","ts":"2026-10-07T03:56:11.0329Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-07T03:56:13.559317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13701534550782797439,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-07T03:56:13.726674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.096379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-07T03:56:13.726704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.917758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.5\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-07T03:56:13.72677Z","caller":"traceutil/trace.go:171","msg":"trace[471859824] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"669.239271ms","start":"2026-10-07T03:56:13.05751Z","end":"2026-10-07T03:56:13.72675Z","steps":["trace[471859824] 'range keys from in-memory index tree' (duration: 669.029377ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:13.726753Z","caller":"traceutil/trace.go:171","msg":"trace[13278629] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"668.869034ms","start":"2026-10-07T03:56:13.057849Z","end":"2026-10-07T03:56:13.726718Z","steps":["trace[13278629] 'process raft request' (duration: 656.431331ms)","trace[13278629] 'compare' (duration: 12.250899ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:56:13.726814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.05749Z","time spent":"669.314873ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-07T03:56:13.726845Z","caller":"traceutil/trace.go:171","msg":"trace[654105018] range","detail":"{range_begin:/registry/masterleases/162.253.55.5; range_end:; response_count:0; response_revision:3; }","duration":"671.170924ms","start":"2026-10-07T03:56:13.055641Z","end":"2026-10-07T03:56:13.726812Z","steps":["trace[654105018] 'range keys from in-memory index tree' (duration: 670.832366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.726962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.055629Z","time spent":"671.294676ms","remote":"127.0.0.1:53720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/162.253.55.5\" "} {"level":"warn","ts":"2026-10-07T03:56:13.728253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.057835Z","time spent":"669.011916ms","remote":"127.0.0.1:54164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:13.729106Z","caller":"traceutil/trace.go:171","msg":"trace[1896069701] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"670.09362ms","start":"2026-10-07T03:56:13.058972Z","end":"2026-10-07T03:56:13.729065Z","steps":["trace[1896069701] 'process raft request' (duration: 669.956357ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:13.729138Z","caller":"traceutil/trace.go:171","msg":"trace[1972390351] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"670.282185ms","start":"2026-10-07T03:56:13.058818Z","end":"2026-10-07T03:56:13.7291Z","steps":["trace[1972390351] 'process raft request' (duration: 670.001889ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:13.729181Z","caller":"traceutil/trace.go:171","msg":"trace[2012823493] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"670.095271ms","start":"2026-10-07T03:56:13.059048Z","end":"2026-10-07T03:56:13.729144Z","steps":["trace[2012823493] 'process raft request' (duration: 669.962028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.058811Z","time spent":"670.385897ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:13.729236Z","caller":"traceutil/trace.go:171","msg":"trace[1430376251] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"670.770835ms","start":"2026-10-07T03:56:13.058426Z","end":"2026-10-07T03:56:13.729197Z","steps":["trace[1430376251] 'read index received' (duration: 655.863279ms)","trace[1430376251] 'applied index is now lower than readState.Index' (duration: 14.906646ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:56:13.729362Z","caller":"traceutil/trace.go:171","msg":"trace[617161370] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"670.212233ms","start":"2026-10-07T03:56:13.059139Z","end":"2026-10-07T03:56:13.729351Z","steps":["trace[617161370] 'process raft request' (duration: 669.896746ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.72942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.059024Z","time spent":"670.238993ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:13.729425Z","caller":"traceutil/trace.go:171","msg":"trace[1923947739] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"649.870897ms","start":"2026-10-07T03:56:13.07953Z","end":"2026-10-07T03:56:13.7294Z","steps":["trace[1923947739] 'process raft request' (duration: 649.562291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.058951Z","time spent":"670.234684ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:13.729537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.079515Z","time spent":"649.9522ms","remote":"127.0.0.1:53948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:13.729536Z","caller":"traceutil/trace.go:171","msg":"trace[596118399] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"670.476999ms","start":"2026-10-07T03:56:13.059045Z","end":"2026-10-07T03:56:13.729522Z","steps":["trace[596118399] 'process raft request' (duration: 669.921427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.059134Z","time spent":"670.262624ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:13.729606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.166983ms","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-10-07T03:56:13.729628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.059038Z","time spent":"670.55313ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:13.729647Z","caller":"traceutil/trace.go:171","msg":"trace[688044987] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"671.221034ms","start":"2026-10-07T03:56:13.058411Z","end":"2026-10-07T03:56:13.729632Z","steps":["trace[688044987] 'agreement among raft nodes before linearized reading' (duration: 671.078371ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.058405Z","time spent":"671.263865ms","remote":"127.0.0.1:53758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-10-07T03:56:13.729827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.459814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-07T03:56:13.729835Z","caller":"traceutil/trace.go:171","msg":"trace[880178468] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"658.099598ms","start":"2026-10-07T03:56:13.071722Z","end":"2026-10-07T03:56:13.729822Z","steps":["trace[880178468] 'process raft request' (duration: 657.336712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.630798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-07T03:56:13.7299Z","caller":"traceutil/trace.go:171","msg":"trace[1478852728] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"588.548256ms","start":"2026-10-07T03:56:13.141313Z","end":"2026-10-07T03:56:13.729861Z","steps":["trace[1478852728] 'agreement among raft nodes before linearized reading' (duration: 588.435024ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:13.729911Z","caller":"traceutil/trace.go:171","msg":"trace[1825100225] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"588.72566ms","start":"2026-10-07T03:56:13.141161Z","end":"2026-10-07T03:56:13.729886Z","steps":["trace[1825100225] 'agreement among raft nodes before linearized reading' (duration: 588.585437ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.729943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.141305Z","time spent":"588.628138ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-07T03:56:13.72996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.141136Z","time spent":"588.816082ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-07T03:56:13.730019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.144723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-07T03:56:13.730063Z","caller":"traceutil/trace.go:171","msg":"trace[198123531] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"591.194554ms","start":"2026-10-07T03:56:13.138857Z","end":"2026-10-07T03:56:13.730052Z","steps":["trace[198123531] 'agreement among raft nodes before linearized reading' (duration: 591.097782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.730097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.138847Z","time spent":"591.243995ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-07T03:56:13.730103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.367998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-07T03:56:13.73015Z","caller":"traceutil/trace.go:171","msg":"trace[723234845] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"655.44985ms","start":"2026-10-07T03:56:13.074689Z","end":"2026-10-07T03:56:13.730138Z","steps":["trace[723234845] 'agreement among raft nodes before linearized reading' (duration: 655.374528ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.730143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.386933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-07T03:56:13.730176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.074675Z","time spent":"655.495091ms","remote":"127.0.0.1:54100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-10-07T03:56:13.730189Z","caller":"traceutil/trace.go:171","msg":"trace[1452400923] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"620.433214ms","start":"2026-10-07T03:56:13.109746Z","end":"2026-10-07T03:56:13.730179Z","steps":["trace[1452400923] 'agreement among raft nodes before linearized reading' (duration: 620.359772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:13.730215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.109727Z","time spent":"620.481665ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-07T03:56:13.729904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:13.071705Z","time spent":"658.173399ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:18.572904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.466206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-07T03:56:18.573069Z","caller":"traceutil/trace.go:171","msg":"trace[1875797431] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:269; }","duration":"397.715871ms","start":"2026-10-07T03:56:18.175322Z","end":"2026-10-07T03:56:18.573037Z","steps":["trace[1875797431] 'range keys from in-memory index tree' (duration: 397.252611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:18.573131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:18.175293Z","time spent":"397.826774ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-07T03:56:18.988413Z","caller":"traceutil/trace.go:171","msg":"trace[1956272303] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"411.282068ms","start":"2026-10-07T03:56:18.577108Z","end":"2026-10-07T03:56:18.988391Z","steps":["trace[1956272303] 'process raft request' (duration: 410.826619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:18.988543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:18.577075Z","time spent":"411.40264ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:19.494456Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13701534550782797948,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-07T03:56:19.670068Z","caller":"traceutil/trace.go:171","msg":"trace[1698068162] linearizableReadLoop","detail":"{readStateIndex:282; appliedIndex:281; }","duration":"675.958268ms","start":"2026-10-07T03:56:18.99408Z","end":"2026-10-07T03:56:19.670039Z","steps":["trace[1698068162] 'read index received' (duration: 596.712794ms)","trace[1698068162] 'applied index is now lower than readState.Index' (duration: 79.244314ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:56:19.67024Z","caller":"traceutil/trace.go:171","msg":"trace[1437576671] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"678.318361ms","start":"2026-10-07T03:56:18.991889Z","end":"2026-10-07T03:56:19.670207Z","steps":["trace[1437576671] 'process raft request' (duration: 598.981345ms)","trace[1437576671] 'compare' (duration: 79.04546ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:56:19.670274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.179324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:19.670322Z","caller":"traceutil/trace.go:171","msg":"trace[2062902054] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:271; }","duration":"676.290816ms","start":"2026-10-07T03:56:18.994019Z","end":"2026-10-07T03:56:19.67031Z","steps":["trace[2062902054] 'agreement among raft nodes before linearized reading' (duration: 676.178954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:19.670357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:18.993997Z","time spent":"676.352787ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-10-07T03:56:19.670397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.458779ms","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-10-07T03:56:19.670492Z","caller":"traceutil/trace.go:171","msg":"trace[986688195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:271; }","duration":"644.598962ms","start":"2026-10-07T03:56:19.025864Z","end":"2026-10-07T03:56:19.670463Z","steps":["trace[986688195] 'agreement among raft nodes before linearized reading' (duration: 644.379738ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:19.670505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.527214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-07T03:56:19.670551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:19.025851Z","time spent":"644.690064ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-07T03:56:19.670567Z","caller":"traceutil/trace.go:171","msg":"trace[1514509514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:271; }","duration":"337.610936ms","start":"2026-10-07T03:56:19.332936Z","end":"2026-10-07T03:56:19.670547Z","steps":["trace[1514509514] 'agreement among raft nodes before linearized reading' (duration: 337.471403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:19.670602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:19.332925Z","time spent":"337.669717ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-07T03:56:19.670595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:18.991868Z","time spent":"678.452533ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:56:19.67075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.592637ms","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-10-07T03:56:19.670863Z","caller":"traceutil/trace.go:171","msg":"trace[223011550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:271; }","duration":"370.817702ms","start":"2026-10-07T03:56:19.300015Z","end":"2026-10-07T03:56:19.670833Z","steps":["trace[223011550] 'agreement among raft nodes before linearized reading' (duration: 370.438634ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:19.670937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:19.299953Z","time spent":"370.971565ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-07T03:56:19.947378Z","caller":"traceutil/trace.go:171","msg":"trace[454202367] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"273.519293ms","start":"2026-10-07T03:56:19.673839Z","end":"2026-10-07T03:56:19.947358Z","steps":["trace[454202367] 'process raft request' (duration: 270.331194ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:19.951303Z","caller":"traceutil/trace.go:171","msg":"trace[2046639747] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"275.485817ms","start":"2026-10-07T03:56:19.675802Z","end":"2026-10-07T03:56:19.951287Z","steps":["trace[2046639747] 'process raft request' (duration: 275.336954ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:19.9516Z","caller":"traceutil/trace.go:171","msg":"trace[364649318] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"275.503697ms","start":"2026-10-07T03:56:19.676063Z","end":"2026-10-07T03:56:19.951567Z","steps":["trace[364649318] 'process raft request' (duration: 275.17415ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:19.952476Z","caller":"traceutil/trace.go:171","msg":"trace[182856103] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"276.317546ms","start":"2026-10-07T03:56:19.676133Z","end":"2026-10-07T03:56:19.952451Z","steps":["trace[182856103] 'process raft request' (duration: 275.333164ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:54.9292Z","caller":"traceutil/trace.go:171","msg":"trace[1239946093] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"171.725771ms","start":"2026-10-07T03:56:54.757448Z","end":"2026-10-07T03:56:54.929174Z","steps":["trace[1239946093] 'process raft request' (duration: 171.393324ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:54.929313Z","caller":"traceutil/trace.go:171","msg":"trace[1551606081] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"164.237618ms","start":"2026-10-07T03:56:54.76505Z","end":"2026-10-07T03:56:54.929288Z","steps":["trace[1551606081] 'process raft request' (duration: 164.067703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:55.157853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.365865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T03:56:55.158165Z","caller":"traceutil/trace.go:171","msg":"trace[243914489] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"386.048476ms","start":"2026-10-07T03:56:54.772097Z","end":"2026-10-07T03:56:55.158145Z","steps":["trace[243914489] 'process raft request' (duration: 271.166759ms)","trace[243914489] 'compare' (duration: 114.231263ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:56:55.158237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:54.772088Z","time spent":"386.119207ms","remote":"127.0.0.1:53720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:56:55.158683Z","caller":"traceutil/trace.go:171","msg":"trace[274441529] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"381.764461ms","start":"2026-10-07T03:56:54.776898Z","end":"2026-10-07T03:56:55.158663Z","steps":["trace[274441529] 'process raft request' (duration: 381.117317ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:55.159239Z","caller":"traceutil/trace.go:171","msg":"trace[1706271771] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"347.861313ms","start":"2026-10-07T03:56:54.811359Z","end":"2026-10-07T03:56:55.159221Z","steps":["trace[1706271771] 'process raft request' (duration: 347.229068ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:55.159336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:54.811343Z","time spent":"347.952944ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:56:55.160152Z","caller":"traceutil/trace.go:171","msg":"trace[488492619] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:563; }","duration":"301.366125ms","start":"2026-10-07T03:56:54.858745Z","end":"2026-10-07T03:56:55.160111Z","steps":["trace[488492619] 'read index received' (duration: 70.050256ms)","trace[488492619] 'applied index is now lower than readState.Index' (duration: 231.249577ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:56:55.160469Z","caller":"traceutil/trace.go:171","msg":"trace[820864815] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"331.845048ms","start":"2026-10-07T03:56:54.828601Z","end":"2026-10-07T03:56:55.160446Z","steps":["trace[820864815] 'process raft request' (duration: 330.539309ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:55.16054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:54.828589Z","time spent":"331.91119ms","remote":"127.0.0.1:53756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:55.160584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:54.77688Z","time spent":"383.612902ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:56:55.162089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.33792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-07T03:56:55.162157Z","caller":"traceutil/trace.go:171","msg":"trace[2010623076] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:545; }","duration":"303.422721ms","start":"2026-10-07T03:56:54.858708Z","end":"2026-10-07T03:56:55.162131Z","steps":["trace[2010623076] 'agreement among raft nodes before linearized reading' (duration: 302.676604ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:55.162189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:54.858695Z","time spent":"303.487683ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-07T03:56:55.197495Z","caller":"traceutil/trace.go:171","msg":"trace[785140225] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"205.307695ms","start":"2026-10-07T03:56:54.992153Z","end":"2026-10-07T03:56:55.197461Z","steps":["trace[785140225] 'process raft request' (duration: 204.357444ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:55.197904Z","caller":"traceutil/trace.go:171","msg":"trace[1445408256] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"185.474955ms","start":"2026-10-07T03:56:55.012377Z","end":"2026-10-07T03:56:55.197852Z","steps":["trace[1445408256] 'process raft request' (duration: 184.372032ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:55.197749Z","caller":"traceutil/trace.go:171","msg":"trace[2090522781] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"161.438575ms","start":"2026-10-07T03:56:55.03622Z","end":"2026-10-07T03:56:55.197659Z","steps":["trace[2090522781] 'process raft request' (duration: 160.630888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.017306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.631906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T03:56:56.017478Z","caller":"traceutil/trace.go:171","msg":"trace[765664536] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"808.452804ms","start":"2026-10-07T03:56:55.209008Z","end":"2026-10-07T03:56:56.017461Z","steps":["trace[765664536] 'process raft request' (duration: 808.399743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.017535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.208957Z","time spent":"808.553626ms","remote":"127.0.0.1:54258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:56:56.017886Z","caller":"traceutil/trace.go:171","msg":"trace[1909760333] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"829.354565ms","start":"2026-10-07T03:56:55.188517Z","end":"2026-10-07T03:56:56.017872Z","steps":["trace[1909760333] 'process raft request' (duration: 83.066985ms)","trace[1909760333] 'compare' (duration: 744.832658ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:56:56.017941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.188487Z","time spent":"829.422896ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:56:56.018094Z","caller":"traceutil/trace.go:171","msg":"trace[1882675649] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"821.071762ms","start":"2026-10-07T03:56:55.19701Z","end":"2026-10-07T03:56:56.018082Z","steps":["trace[1882675649] 'read index received' (duration: 74.628408ms)","trace[1882675649] 'applied index is now lower than readState.Index' (duration: 746.442034ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:56:56.019139Z","caller":"traceutil/trace.go:171","msg":"trace[401669450] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"712.114696ms","start":"2026-10-07T03:56:55.307009Z","end":"2026-10-07T03:56:56.019124Z","steps":["trace[401669450] 'process raft request' (duration: 712.005004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.019234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.306954Z","time spent":"712.24336ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T03:56:56.019997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.030553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:56.020069Z","caller":"traceutil/trace.go:171","msg":"trace[833847518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:551; }","duration":"836.161186ms","start":"2026-10-07T03:56:55.183889Z","end":"2026-10-07T03:56:56.02005Z","steps":["trace[833847518] 'agreement among raft nodes before linearized reading' (duration: 835.903279ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.02014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.18388Z","time spent":"836.248388ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-07T03:56:56.020465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.447746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:56.020497Z","caller":"traceutil/trace.go:171","msg":"trace[233257944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"819.564548ms","start":"2026-10-07T03:56:55.200922Z","end":"2026-10-07T03:56:56.020486Z","steps":["trace[233257944] 'agreement among raft nodes before linearized reading' (duration: 819.493757ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.02052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.200902Z","time spent":"819.61249ms","remote":"127.0.0.1:53692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T03:56:56.020661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.955923ms","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-10-07T03:56:56.020741Z","caller":"traceutil/trace.go:171","msg":"trace[421197766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"155.133026ms","start":"2026-10-07T03:56:55.865588Z","end":"2026-10-07T03:56:56.020721Z","steps":["trace[421197766] 'agreement among raft nodes before linearized reading' (duration: 154.915312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.02034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.953319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"warn","ts":"2026-10-07T03:56:56.020771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.578339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-smwx7\" ","response":"range_response_count:1 size:4675"} {"level":"info","ts":"2026-10-07T03:56:56.020807Z","caller":"traceutil/trace.go:171","msg":"trace[1204008624] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-smwx7; range_end:; response_count:1; response_revision:551; }","duration":"464.61312ms","start":"2026-10-07T03:56:55.556184Z","end":"2026-10-07T03:56:56.020797Z","steps":["trace[1204008624] 'agreement among raft nodes before linearized reading' (duration: 464.485667ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.020836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.556139Z","time spent":"464.691292ms","remote":"127.0.0.1:53858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4699,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-smwx7\" "} {"level":"warn","ts":"2026-10-07T03:56:56.02102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.087173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"} {"level":"info","ts":"2026-10-07T03:56:56.020799Z","caller":"traceutil/trace.go:171","msg":"trace[960311785] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:551; }","duration":"859.43998ms","start":"2026-10-07T03:56:55.161344Z","end":"2026-10-07T03:56:56.020784Z","steps":["trace[960311785] 'agreement among raft nodes before linearized reading' (duration: 858.55768ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:56.021095Z","caller":"traceutil/trace.go:171","msg":"trace[839185037] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:551; }","duration":"725.221646ms","start":"2026-10-07T03:56:55.295853Z","end":"2026-10-07T03:56:56.021075Z","steps":["trace[839185037] 'agreement among raft nodes before linearized reading' (duration: 724.94539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:56.021136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.29583Z","time spent":"725.297517ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":150519,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-10-07T03:56:56.021139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:55.161331Z","time spent":"859.793947ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-10-07T03:56:56.159808Z","caller":"traceutil/trace.go:171","msg":"trace[56739022] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"122.721959ms","start":"2026-10-07T03:56:56.037065Z","end":"2026-10-07T03:56:56.159787Z","steps":["trace[56739022] 'process raft request' (duration: 115.418538ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:56.160656Z","caller":"traceutil/trace.go:171","msg":"trace[286581668] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"114.509929ms","start":"2026-10-07T03:56:56.046088Z","end":"2026-10-07T03:56:56.160598Z","steps":["trace[286581668] 'process raft request' (duration: 114.190172ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:56.160795Z","caller":"traceutil/trace.go:171","msg":"trace[700075278] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"118.023747ms","start":"2026-10-07T03:56:56.042705Z","end":"2026-10-07T03:56:56.160729Z","steps":["trace[700075278] 'process raft request' (duration: 117.416204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.429788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.189434ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:57.429911Z","caller":"traceutil/trace.go:171","msg":"trace[807078513] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:599; }","duration":"269.321757ms","start":"2026-10-07T03:56:57.160569Z","end":"2026-10-07T03:56:57.429891Z","steps":["trace[807078513] 'range keys from in-memory index tree' (duration: 269.152673ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:57.434138Z","caller":"traceutil/trace.go:171","msg":"trace[436798635] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"591.752889ms","start":"2026-10-07T03:56:56.842356Z","end":"2026-10-07T03:56:57.434109Z","steps":["trace[436798635] 'process raft request' (duration: 590.858099ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.43431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:56.842333Z","time spent":"591.883031ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:56:57.45868Z","caller":"traceutil/trace.go:171","msg":"trace[1973465423] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"491.479963ms","start":"2026-10-07T03:56:56.967136Z","end":"2026-10-07T03:56:57.458616Z","steps":["trace[1973465423] 'read index received' (duration: 465.417328ms)","trace[1973465423] 'applied index is now lower than readState.Index' (duration: 26.061515ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:56:57.458907Z","caller":"traceutil/trace.go:171","msg":"trace[204832314] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"347.75669ms","start":"2026-10-07T03:56:57.111116Z","end":"2026-10-07T03:56:57.458873Z","steps":["trace[204832314] 'process raft request' (duration: 347.420623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.459157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:57.111087Z","time spent":"347.964534ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:56:57.459238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.720996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:57.459289Z","caller":"traceutil/trace.go:171","msg":"trace[1254452364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"312.794017ms","start":"2026-10-07T03:56:57.146472Z","end":"2026-10-07T03:56:57.459267Z","steps":["trace[1254452364] 'agreement among raft nodes before linearized reading' (duration: 312.733246ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.459327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:57.146451Z","time spent":"312.867419ms","remote":"127.0.0.1:53684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T03:56:57.459722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.305315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:56:57.459168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.017535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:56:57.459928Z","caller":"traceutil/trace.go:171","msg":"trace[726255237] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"492.749332ms","start":"2026-10-07T03:56:56.967106Z","end":"2026-10-07T03:56:57.459855Z","steps":["trace[726255237] 'agreement among raft nodes before linearized reading' (duration: 491.946694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.460118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:56.967098Z","time spent":"492.925385ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-10-07T03:56:57.459777Z","caller":"traceutil/trace.go:171","msg":"trace[465716022] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:602; }","duration":"292.375107ms","start":"2026-10-07T03:56:57.167387Z","end":"2026-10-07T03:56:57.459762Z","steps":["trace[465716022] 'agreement among raft nodes before linearized reading' (duration: 292.311015ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:56:57.459945Z","caller":"traceutil/trace.go:171","msg":"trace[633670782] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"536.093638ms","start":"2026-10-07T03:56:56.923605Z","end":"2026-10-07T03:56:57.459698Z","steps":["trace[633670782] 'process raft request' (duration: 532.530909ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:56:57.461637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:56:56.92358Z","time spent":"537.994271ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-07T03:57:04.011085Z","caller":"traceutil/trace.go:171","msg":"trace[796267768] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"411.61384ms","start":"2026-10-07T03:57:03.599054Z","end":"2026-10-07T03:57:04.010668Z","steps":["trace[796267768] 'process raft request' (duration: 411.446355ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:04.011245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:03.599025Z","time spent":"412.149831ms","remote":"127.0.0.1:53858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:57:06.00808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.757459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:06.008267Z","caller":"traceutil/trace.go:171","msg":"trace[1694704210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"860.959633ms","start":"2026-10-07T03:57:05.147244Z","end":"2026-10-07T03:57:06.008203Z","steps":["trace[1694704210] 'range keys from in-memory index tree' (duration: 860.599695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:06.009348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:05.147223Z","time spent":"862.105439ms","remote":"127.0.0.1:53684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T03:57:06.008433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.669359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T03:57:06.010093Z","caller":"traceutil/trace.go:171","msg":"trace[38830533] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"490.84389ms","start":"2026-10-07T03:57:05.519218Z","end":"2026-10-07T03:57:06.010061Z","steps":["trace[38830533] 'process raft request' (duration: 279.474052ms)","trace[38830533] 'compare' (duration: 209.198849ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:57:06.010263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:05.519178Z","time spent":"490.979943ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:57:22.413809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.356219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.413893Z","caller":"traceutil/trace.go:171","msg":"trace[708704071] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:785; }","duration":"164.477282ms","start":"2026-10-07T03:57:22.249395Z","end":"2026-10-07T03:57:22.413872Z","steps":["trace[708704071] 'range keys from in-memory index tree' (duration: 164.298188ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.413868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.341088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:57:22.413939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.90447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.41402Z","caller":"traceutil/trace.go:171","msg":"trace[577700668] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:785; }","duration":"164.054894ms","start":"2026-10-07T03:57:22.249949Z","end":"2026-10-07T03:57:22.414004Z","steps":["trace[577700668] 'range keys from in-memory index tree' (duration: 163.808708ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.414004Z","caller":"traceutil/trace.go:171","msg":"trace[1677929498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:785; }","duration":"130.502483ms","start":"2026-10-07T03:57:22.283484Z","end":"2026-10-07T03:57:22.413986Z","steps":["trace[1677929498] 'range keys from in-memory index tree' (duration: 130.250957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.450252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.414113Z","caller":"traceutil/trace.go:171","msg":"trace[2029529200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:785; }","duration":"130.559654ms","start":"2026-10-07T03:57:22.283534Z","end":"2026-10-07T03:57:22.414093Z","steps":["trace[2029529200] 'count revisions from in-memory index tree' (duration: 130.420361ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.663998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jm772\" ","response":"range_response_count:1 size:3963"} {"level":"warn","ts":"2026-10-07T03:57:22.414227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.685817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.414281Z","caller":"traceutil/trace.go:171","msg":"trace[498206451] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:785; }","duration":"164.78272ms","start":"2026-10-07T03:57:22.249489Z","end":"2026-10-07T03:57:22.414271Z","steps":["trace[498206451] 'count revisions from in-memory index tree' (duration: 164.603245ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.528531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:57:22.414381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.62559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:57:22.414386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.93839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.41459Z","caller":"traceutil/trace.go:171","msg":"trace[57971498] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:785; }","duration":"670.836864ms","start":"2026-10-07T03:57:21.743744Z","end":"2026-10-07T03:57:22.414581Z","steps":["trace[57971498] 'count revisions from in-memory index tree' (duration: 670.524298ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.414593Z","caller":"traceutil/trace.go:171","msg":"trace[1986792429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:785; }","duration":"130.169615ms","start":"2026-10-07T03:57:22.284415Z","end":"2026-10-07T03:57:22.414585Z","steps":["trace[1986792429] 'range keys from in-memory index tree' (duration: 129.90904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:21.743684Z","time spent":"670.924817ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-10-07T03:57:22.414624Z","caller":"traceutil/trace.go:171","msg":"trace[1791110040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"110.764296ms","start":"2026-10-07T03:57:22.303612Z","end":"2026-10-07T03:57:22.414376Z","steps":["trace[1791110040] 'range keys from in-memory index tree' (duration: 110.309107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.025001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.414714Z","caller":"traceutil/trace.go:171","msg":"trace[883681430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"111.106373ms","start":"2026-10-07T03:57:22.3036Z","end":"2026-10-07T03:57:22.414707Z","steps":["trace[883681430] 'count revisions from in-memory index tree' (duration: 110.95493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.41474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.663393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:57:22.414759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.238896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.414769Z","caller":"traceutil/trace.go:171","msg":"trace[168517127] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:785; }","duration":"604.721405ms","start":"2026-10-07T03:57:21.810037Z","end":"2026-10-07T03:57:22.414758Z","steps":["trace[168517127] 'range keys from in-memory index tree' (duration: 604.52802ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.4148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:21.810014Z","time spent":"604.777316ms","remote":"127.0.0.1:58430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-10-07T03:57:22.414835Z","caller":"traceutil/trace.go:171","msg":"trace[1281419787] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:785; }","duration":"288.321328ms","start":"2026-10-07T03:57:22.126464Z","end":"2026-10-07T03:57:22.414785Z","steps":["trace[1281419787] 'range keys from in-memory index tree' (duration: 288.163224ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.557071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.414871Z","caller":"traceutil/trace.go:171","msg":"trace[393317249] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:785; }","duration":"604.726465ms","start":"2026-10-07T03:57:21.810135Z","end":"2026-10-07T03:57:22.414861Z","steps":["trace[393317249] 'count revisions from in-memory index tree' (duration: 604.522761ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.414912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:21.810129Z","time spent":"604.770326ms","remote":"127.0.0.1:58430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-07T03:57:22.414995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.241414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T03:57:22.415013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.942848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.415033Z","caller":"traceutil/trace.go:171","msg":"trace[476669779] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:785; }","duration":"604.295245ms","start":"2026-10-07T03:57:21.810728Z","end":"2026-10-07T03:57:22.415024Z","steps":["trace[476669779] 'range keys from in-memory index tree' (duration: 604.203733ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.41504Z","caller":"traceutil/trace.go:171","msg":"trace[1419102525] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:785; }","duration":"287.989129ms","start":"2026-10-07T03:57:22.127043Z","end":"2026-10-07T03:57:22.415032Z","steps":["trace[1419102525] 'range keys from in-memory index tree' (duration: 287.891457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.41506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:21.810721Z","time spent":"604.331125ms","remote":"127.0.0.1:58430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-10-07T03:57:22.414249Z","caller":"traceutil/trace.go:171","msg":"trace[92502454] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jm772; range_end:; response_count:1; response_revision:785; }","duration":"731.705279ms","start":"2026-10-07T03:57:21.682533Z","end":"2026-10-07T03:57:22.414238Z","steps":["trace[92502454] 'range keys from in-memory index tree' (duration: 731.500884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.415192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.982932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.415223Z","caller":"traceutil/trace.go:171","msg":"trace[560173553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:785; }","duration":"395.033234ms","start":"2026-10-07T03:57:22.020182Z","end":"2026-10-07T03:57:22.415215Z","steps":["trace[560173553] 'count revisions from in-memory index tree' (duration: 394.943132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.415254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:22.020173Z","time spent":"395.073244ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-10-07T03:57:22.415205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:21.682471Z","time spent":"732.72151ms","remote":"127.0.0.1:53858","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-jm772\" "} {"level":"warn","ts":"2026-10-07T03:57:22.414679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.226755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.415463Z","caller":"traceutil/trace.go:171","msg":"trace[569185011] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:785; }","duration":"289.029714ms","start":"2026-10-07T03:57:22.126418Z","end":"2026-10-07T03:57:22.415448Z","steps":["trace[569185011] 'count revisions from in-memory index tree' (duration: 288.179644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.415144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.380161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.415589Z","caller":"traceutil/trace.go:171","msg":"trace[633004567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:785; }","duration":"395.858463ms","start":"2026-10-07T03:57:22.019722Z","end":"2026-10-07T03:57:22.41558Z","steps":["trace[633004567] 'range keys from in-memory index tree' (duration: 395.31798ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:57:22.41562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:57:22.019703Z","time spent":"395.904533ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-10-07T03:57:22.415747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.651375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:57:22.41579Z","caller":"traceutil/trace.go:171","msg":"trace[1652810508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:785; }","duration":"111.739748ms","start":"2026-10-07T03:57:22.304042Z","end":"2026-10-07T03:57:22.415782Z","steps":["trace[1652810508] 'range keys from in-memory index tree' (duration: 111.497802ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.611838Z","caller":"traceutil/trace.go:171","msg":"trace[415023865] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"186.976449ms","start":"2026-10-07T03:57:22.424842Z","end":"2026-10-07T03:57:22.611818Z","steps":["trace[415023865] 'process raft request' (duration: 186.855206ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.618534Z","caller":"traceutil/trace.go:171","msg":"trace[218408827] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"193.450453ms","start":"2026-10-07T03:57:22.425064Z","end":"2026-10-07T03:57:22.618514Z","steps":["trace[218408827] 'process raft request' (duration: 192.302158ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.618723Z","caller":"traceutil/trace.go:171","msg":"trace[1114918652] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"193.624296ms","start":"2026-10-07T03:57:22.425088Z","end":"2026-10-07T03:57:22.618712Z","steps":["trace[1114918652] 'process raft request' (duration: 193.098224ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.618829Z","caller":"traceutil/trace.go:171","msg":"trace[1350061729] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"192.40986ms","start":"2026-10-07T03:57:22.426412Z","end":"2026-10-07T03:57:22.618822Z","steps":["trace[1350061729] 'process raft request' (duration: 191.816936ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.618926Z","caller":"traceutil/trace.go:171","msg":"trace[1529049303] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"191.474509ms","start":"2026-10-07T03:57:22.427443Z","end":"2026-10-07T03:57:22.618918Z","steps":["trace[1529049303] 'process raft request' (duration: 190.812874ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:57:22.619049Z","caller":"traceutil/trace.go:171","msg":"trace[85843227] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"188.745568ms","start":"2026-10-07T03:57:22.430293Z","end":"2026-10-07T03:57:22.619039Z","steps":["trace[85843227] 'process raft request' (duration: 187.993231ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:00.994746Z","caller":"traceutil/trace.go:171","msg":"trace[1311239949] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"166.411844ms","start":"2026-10-07T03:58:00.828266Z","end":"2026-10-07T03:58:00.994678Z","steps":["trace[1311239949] 'read index received' (duration: 157.999757ms)","trace[1311239949] 'applied index is now lower than readState.Index' (duration: 8.410217ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:58:00.995205Z","caller":"traceutil/trace.go:171","msg":"trace[1068457891] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"170.052647ms","start":"2026-10-07T03:58:00.825132Z","end":"2026-10-07T03:58:00.995184Z","steps":["trace[1068457891] 'process raft request' (duration: 161.128448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:00.995558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.279633ms","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-10-07T03:58:00.995625Z","caller":"traceutil/trace.go:171","msg":"trace[437812315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"167.381596ms","start":"2026-10-07T03:58:00.828228Z","end":"2026-10-07T03:58:00.99561Z","steps":["trace[437812315] 'agreement among raft nodes before linearized reading' (duration: 167.214342ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:01.087247Z","caller":"traceutil/trace.go:171","msg":"trace[170878029] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"155.315968ms","start":"2026-10-07T03:58:00.931905Z","end":"2026-10-07T03:58:01.08722Z","steps":["trace[170878029] 'process raft request' (duration: 155.269647ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:01.087489Z","caller":"traceutil/trace.go:171","msg":"trace[311277803] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"259.167895ms","start":"2026-10-07T03:58:00.828297Z","end":"2026-10-07T03:58:01.087464Z","steps":["trace[311277803] 'process raft request' (duration: 258.746025ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:01.087811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.400813ms","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-10-07T03:58:01.087846Z","caller":"traceutil/trace.go:171","msg":"trace[1724535113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1063; }","duration":"251.482475ms","start":"2026-10-07T03:58:00.836353Z","end":"2026-10-07T03:58:01.087835Z","steps":["trace[1724535113] 'agreement among raft nodes before linearized reading' (duration: 251.355802ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:01.088039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.568984ms","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-10-07T03:58:01.088068Z","caller":"traceutil/trace.go:171","msg":"trace[596494376] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1063; }","duration":"250.620114ms","start":"2026-10-07T03:58:00.837439Z","end":"2026-10-07T03:58:01.08806Z","steps":["trace[596494376] 'agreement among raft nodes before linearized reading' (duration: 250.539313ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:03.327084Z","caller":"traceutil/trace.go:171","msg":"trace[1569772980] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"324.25985ms","start":"2026-10-07T03:58:03.002795Z","end":"2026-10-07T03:58:03.327055Z","steps":["trace[1569772980] 'process raft request' (duration: 324.096166ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:03.327241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:03.002767Z","time spent":"324.389652ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:58:03.327377Z","caller":"traceutil/trace.go:171","msg":"trace[1309881800] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1108; }","duration":"257.320412ms","start":"2026-10-07T03:58:03.070047Z","end":"2026-10-07T03:58:03.327368Z","steps":["trace[1309881800] 'read index received' (duration: 257.316142ms)","trace[1309881800] 'applied index is now lower than readState.Index' (duration: 3.39µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:58:03.327457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.412686ms","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-10-07T03:58:03.327546Z","caller":"traceutil/trace.go:171","msg":"trace[775490949] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1067; }","duration":"257.540168ms","start":"2026-10-07T03:58:03.069994Z","end":"2026-10-07T03:58:03.327534Z","steps":["trace[775490949] 'agreement among raft nodes before linearized reading' (duration: 257.425076ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:03.379103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.514047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-07T03:58:03.379135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.616934ms","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-10-07T03:58:03.379185Z","caller":"traceutil/trace.go:171","msg":"trace[1730947365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1068; }","duration":"288.626038ms","start":"2026-10-07T03:58:03.090538Z","end":"2026-10-07T03:58:03.379164Z","steps":["trace[1730947365] 'agreement among raft nodes before linearized reading' (duration: 288.398454ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:03.379182Z","caller":"traceutil/trace.go:171","msg":"trace[125291098] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"286.343197ms","start":"2026-10-07T03:58:03.092816Z","end":"2026-10-07T03:58:03.379159Z","steps":["trace[125291098] 'process raft request' (duration: 286.00979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:03.379347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.213526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:58:03.379373Z","caller":"traceutil/trace.go:171","msg":"trace[1710109261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"232.286668ms","start":"2026-10-07T03:58:03.147079Z","end":"2026-10-07T03:58:03.379366Z","steps":["trace[1710109261] 'agreement among raft nodes before linearized reading' (duration: 232.229847ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:03.37919Z","caller":"traceutil/trace.go:171","msg":"trace[1379219737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1068; }","duration":"282.696566ms","start":"2026-10-07T03:58:03.09648Z","end":"2026-10-07T03:58:03.379176Z","steps":["trace[1379219737] 'agreement among raft nodes before linearized reading' (duration: 282.492081ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:03.37956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.713266ms","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-10-07T03:58:03.379628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.247651ms","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-10-07T03:58:03.379645Z","caller":"traceutil/trace.go:171","msg":"trace[1209242554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1068; }","duration":"286.833449ms","start":"2026-10-07T03:58:03.092789Z","end":"2026-10-07T03:58:03.379623Z","steps":["trace[1209242554] 'agreement among raft nodes before linearized reading' (duration: 286.578734ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:03.37967Z","caller":"traceutil/trace.go:171","msg":"trace[14258138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1068; }","duration":"284.306363ms","start":"2026-10-07T03:58:03.095353Z","end":"2026-10-07T03:58:03.37966Z","steps":["trace[14258138] 'agreement among raft nodes before linearized reading' (duration: 284.190341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:20.215499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.376238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T03:58:20.215623Z","caller":"traceutil/trace.go:171","msg":"trace[1610705452] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"692.473995ms","start":"2026-10-07T03:58:19.52312Z","end":"2026-10-07T03:58:20.215594Z","steps":["trace[1610705452] 'read index received' (duration: 347.008995ms)","trace[1610705452] 'applied index is now lower than readState.Index' (duration: 345.46371ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T03:58:20.215701Z","caller":"traceutil/trace.go:171","msg":"trace[1810151424] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"707.231553ms","start":"2026-10-07T03:58:19.508447Z","end":"2026-10-07T03:58:20.215679Z","steps":["trace[1810151424] 'process raft request' (duration: 361.599519ms)","trace[1810151424] 'compare' (duration: 345.284827ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:58:20.215756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.508424Z","time spent":"707.298755ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T03:58:20.215888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.735212ms","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-10-07T03:58:20.215983Z","caller":"traceutil/trace.go:171","msg":"trace[828464248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1126; }","duration":"692.856665ms","start":"2026-10-07T03:58:19.523087Z","end":"2026-10-07T03:58:20.215944Z","steps":["trace[828464248] 'agreement among raft nodes before linearized reading' (duration: 692.604768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:20.216028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.523071Z","time spent":"692.948706ms","remote":"127.0.0.1:53952","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-10-07T03:58:20.844714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.281567ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-07T03:58:20.845Z","caller":"traceutil/trace.go:171","msg":"trace[1993258292] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"625.133491ms","start":"2026-10-07T03:58:20.2198Z","end":"2026-10-07T03:58:20.844934Z","steps":["trace[1993258292] 'process raft request' (duration: 625.013228ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:20.845181Z","caller":"traceutil/trace.go:171","msg":"trace[1604587593] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"629.468447ms","start":"2026-10-07T03:58:20.215651Z","end":"2026-10-07T03:58:20.84512Z","steps":["trace[1604587593] 'read index received' (duration: 333.932775ms)","trace[1604587593] 'applied index is now lower than readState.Index' (duration: 295.532872ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T03:58:20.845337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.259875135s","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-10-07T03:58:20.845384Z","caller":"traceutil/trace.go:171","msg":"trace[1791358339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1127; }","duration":"1.259956806s","start":"2026-10-07T03:58:19.585414Z","end":"2026-10-07T03:58:20.845371Z","steps":["trace[1791358339] 'agreement among raft nodes before linearized reading' (duration: 1.259822913s)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:20.845381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299879413s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-07T03:58:20.845411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.585393Z","time spent":"1.260011258s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-07T03:58:20.84554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261380199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-07T03:58:20.845552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.260078849s","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-10-07T03:58:20.845592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.764096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:58:20.845594Z","caller":"traceutil/trace.go:171","msg":"trace[1150579735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1127; }","duration":"1.26145515s","start":"2026-10-07T03:58:19.58413Z","end":"2026-10-07T03:58:20.845585Z","steps":["trace[1150579735] 'agreement among raft nodes before linearized reading' (duration: 1.261303867s)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:20.845624Z","caller":"traceutil/trace.go:171","msg":"trace[1304513864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1127; }","duration":"698.852307ms","start":"2026-10-07T03:58:20.146762Z","end":"2026-10-07T03:58:20.845615Z","steps":["trace[1304513864] 'agreement among raft nodes before linearized reading' (duration: 698.806956ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:20.845628Z","caller":"traceutil/trace.go:171","msg":"trace[1663504685] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1127; }","duration":"1.260233982s","start":"2026-10-07T03:58:19.585376Z","end":"2026-10-07T03:58:20.84561Z","steps":["trace[1663504685] 'agreement among raft nodes before linearized reading' (duration: 1.260031308s)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:20.845634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.58412Z","time spent":"1.261507121s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-07T03:58:20.845653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:20.146741Z","time spent":"698.906688ms","remote":"127.0.0.1:53684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-07T03:58:20.845668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.585364Z","time spent":"1.260296784s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-07T03:58:20.845419Z","caller":"traceutil/trace.go:171","msg":"trace[1564070064] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1127; }","duration":"1.299978905s","start":"2026-10-07T03:58:19.545429Z","end":"2026-10-07T03:58:20.845408Z","steps":["trace[1564070064] 'agreement among raft nodes before linearized reading' (duration: 1.299817932s)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:20.845799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:19.545406Z","time spent":"1.300381583s","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":105,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-10-07T03:58:20.846149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:20.219781Z","time spent":"625.257794ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:58:21.001586Z","caller":"traceutil/trace.go:171","msg":"trace[2086589930] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"151.936844ms","start":"2026-10-07T03:58:20.849628Z","end":"2026-10-07T03:58:21.001564Z","steps":["trace[2086589930] 'process raft request' (duration: 151.786091ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:21.001781Z","caller":"traceutil/trace.go:171","msg":"trace[1091263870] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"151.414732ms","start":"2026-10-07T03:58:20.850335Z","end":"2026-10-07T03:58:21.00175Z","steps":["trace[1091263870] 'process raft request' (duration: 151.177037ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T03:58:21.946145Z","caller":"traceutil/trace.go:171","msg":"trace[601775169] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"438.949656ms","start":"2026-10-07T03:58:21.507169Z","end":"2026-10-07T03:58:21.946119Z","steps":["trace[601775169] 'process raft request' (duration: 438.809453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:21.946422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:21.507153Z","time spent":"439.064438ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T03:58:25.730694Z","caller":"traceutil/trace.go:171","msg":"trace[1188143091] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"100.4734ms","start":"2026-10-07T03:58:25.630196Z","end":"2026-10-07T03:58:25.730669Z","steps":["trace[1188143091] 'process raft request' (duration: 99.903148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:32.483164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.324068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:58:32.483478Z","caller":"traceutil/trace.go:171","msg":"trace[974635093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"336.697666ms","start":"2026-10-07T03:58:32.146756Z","end":"2026-10-07T03:58:32.483454Z","steps":["trace[974635093] 'range keys from in-memory index tree' (duration: 336.238985ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:32.483536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.146724Z","time spent":"336.799417ms","remote":"127.0.0.1:53684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-07T03:58:32.553978Z","caller":"traceutil/trace.go:171","msg":"trace[1703159256] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"237.563915ms","start":"2026-10-07T03:58:32.316359Z","end":"2026-10-07T03:58:32.553923Z","steps":["trace[1703159256] 'process raft request' (duration: 237.35646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.585071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.224695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-10-07T03:58:33.585156Z","caller":"traceutil/trace.go:171","msg":"trace[1298169461] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1224; }","duration":"667.344888ms","start":"2026-10-07T03:58:32.917793Z","end":"2026-10-07T03:58:33.585138Z","steps":["trace[1298169461] 'range keys from in-memory index tree' (duration: 667.028561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.585197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.917781Z","time spent":"667.404439ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-10-07T03:58:33.585381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.79962ms","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-10-07T03:58:33.585452Z","caller":"traceutil/trace.go:171","msg":"trace[746489055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1224; }","duration":"655.057386ms","start":"2026-10-07T03:58:32.930377Z","end":"2026-10-07T03:58:33.585434Z","steps":["trace[746489055] 'range keys from in-memory index tree' (duration: 654.701938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.585546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.930364Z","time spent":"655.116007ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-07T03:58:33.585728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.174961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:58:33.585763Z","caller":"traceutil/trace.go:171","msg":"trace[1065482526] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1224; }","duration":"915.248951ms","start":"2026-10-07T03:58:32.670501Z","end":"2026-10-07T03:58:33.58575Z","steps":["trace[1065482526] 'count revisions from in-memory index tree' (duration: 915.071308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.585789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.670479Z","time spent":"915.301234ms","remote":"127.0.0.1:58456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-07T03:58:33.586012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.207988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T03:58:33.586048Z","caller":"traceutil/trace.go:171","msg":"trace[2133639079] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1224; }","duration":"877.27464ms","start":"2026-10-07T03:58:32.708764Z","end":"2026-10-07T03:58:33.586039Z","steps":["trace[2133639079] 'count revisions from in-memory index tree' (duration: 877.114126ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.586077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.708748Z","time spent":"877.32125ms","remote":"127.0.0.1:58508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-10-07T03:58:33.586127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.25871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-07T03:58:33.586169Z","caller":"traceutil/trace.go:171","msg":"trace[1856525254] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"533.335722ms","start":"2026-10-07T03:58:33.052822Z","end":"2026-10-07T03:58:33.586157Z","steps":["trace[1856525254] 'range keys from in-memory index tree' (duration: 533.092767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.586195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:33.052783Z","time spent":"533.405204ms","remote":"127.0.0.1:53952","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":"warn","ts":"2026-10-07T03:58:33.586357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.669487ms","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-10-07T03:58:33.586433Z","caller":"traceutil/trace.go:171","msg":"trace[156228019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"527.769439ms","start":"2026-10-07T03:58:33.058645Z","end":"2026-10-07T03:58:33.586414Z","steps":["trace[156228019] 'range keys from in-memory index tree' (duration: 527.508863ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.586471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:33.058634Z","time spent":"527.82796ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-07T03:58:33.586525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.06686ms","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-10-07T03:58:33.586571Z","caller":"traceutil/trace.go:171","msg":"trace[1623180759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1224; }","duration":"689.155302ms","start":"2026-10-07T03:58:32.897402Z","end":"2026-10-07T03:58:33.586558Z","steps":["trace[1623180759] 'range keys from in-memory index tree' (duration: 688.956678ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T03:58:33.586598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:58:32.897378Z","time spent":"689.213044ms","remote":"127.0.0.1:53952","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\" "}