{"level":"warn","ts":"2026-05-11T05:46:12.255879Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T05:46:12.255992Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-11T05:46:12.25608Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T05:46:12.256096Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-05-11T05:46:12.256116Z","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-05-11T05:46:12.258005Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-05-11T05:46:12.258089Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-11T05:46:12.264897Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.586652ms"} {"level":"info","ts":"2026-05-11T05:46:12.27262Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-05-11T05:46:12.272719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T05:46:12.272751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-05-11T05:46:12.272766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T05:46:12.272779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-05-11T05:46:12.272828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-05-11T05:46:12.277263Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T05:46:12.279693Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T05:46:12.280908Z","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-05-11T05:46:12.283877Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T05:46:12.284953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-05-11T05:46:12.285486Z","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-05-11T05:46:12.285744Z","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-05-11T05:46:12.285779Z","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-05-11T05:46:12.286915Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-05-11T05:46:12.287104Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T05:46:12.290496Z","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-05-11T05:46:12.290661Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-05-11T05:46:12.290694Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-05-11T05:46:12.290794Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T05:46:12.290842Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T05:46:12.373412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T05:46:12.373477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T05:46:12.373515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-05-11T05:46:12.373535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-05-11T05:46:12.373547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-05-11T05:46:12.373564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-05-11T05:46:12.373579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-05-11T05:46:12.374585Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T05:46:12.37541Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T05:46:12.37541Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T05:46:12.37559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T05:46:12.375934Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T05:46:12.375962Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T05:46:12.376215Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T05:46:12.376372Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T05:46:12.376457Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T05:46:12.379237Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T05:46:12.379629Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-05-11T05:46:21.162716Z","caller":"traceutil/trace.go:171","msg":"trace[298760405] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"110.791103ms","start":"2026-05-11T05:46:21.051908Z","end":"2026-05-11T05:46:21.162699Z","steps":["trace[298760405] 'process raft request' (duration: 110.68174ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:21.387126Z","caller":"traceutil/trace.go:171","msg":"trace[2142071120] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:346; }","duration":"167.261457ms","start":"2026-05-11T05:46:21.219832Z","end":"2026-05-11T05:46:21.387093Z","steps":["trace[2142071120] 'read index received' (duration: 167.092713ms)","trace[2142071120] 'applied index is now lower than readState.Index' (duration: 167.524µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:21.387322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.455072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-11T05:46:21.387375Z","caller":"traceutil/trace.go:171","msg":"trace[1729178004] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"186.226935ms","start":"2026-05-11T05:46:21.201113Z","end":"2026-05-11T05:46:21.38734Z","steps":["trace[1729178004] 'process raft request' (duration: 185.796594ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:21.38741Z","caller":"traceutil/trace.go:171","msg":"trace[144661258] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:336; }","duration":"167.591086ms","start":"2026-05-11T05:46:21.219802Z","end":"2026-05-11T05:46:21.387393Z","steps":["trace[144661258] 'agreement among raft nodes before linearized reading' (duration: 167.410861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:21.725447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.16919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:46:21.725567Z","caller":"traceutil/trace.go:171","msg":"trace[1788517080] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"282.839393ms","start":"2026-05-11T05:46:21.442709Z","end":"2026-05-11T05:46:21.725549Z","steps":["trace[1788517080] 'process raft request' (duration: 127.846212ms)","trace[1788517080] 'compare' (duration: 154.026556ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:24.533569Z","caller":"traceutil/trace.go:171","msg":"trace[188594907] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"214.7646ms","start":"2026-05-11T05:46:24.318774Z","end":"2026-05-11T05:46:24.533539Z","steps":["trace[188594907] 'process raft request' (duration: 214.602306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:25.478417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052601074856816,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T05:46:25.978936Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052601074856816,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T05:46:26.008815Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.370200882s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-11T05:46:26.01031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432599958s","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-05-11T05:46:26.010425Z","caller":"traceutil/trace.go:171","msg":"trace[551412313] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:396; }","duration":"1.432822924s","start":"2026-05-11T05:46:24.577573Z","end":"2026-05-11T05:46:26.010396Z","steps":["trace[551412313] 'range keys from in-memory index tree' (duration: 1.432417744s)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:26.010456Z","caller":"traceutil/trace.go:171","msg":"trace[98203946] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"1.032768043s","start":"2026-05-11T05:46:24.977647Z","end":"2026-05-11T05:46:26.010415Z","steps":["trace[98203946] 'read index received' (duration: 1.031435409s)","trace[98203946] 'applied index is now lower than readState.Index' (duration: 1.330774ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:26.010509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:24.577556Z","time spent":"1.432941727s","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-11T05:46:26.010618Z","caller":"traceutil/trace.go:171","msg":"trace[1833111857] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"1.37207316s","start":"2026-05-11T05:46:24.638499Z","end":"2026-05-11T05:46:26.010573Z","steps":["trace[1833111857] 'process raft request' (duration: 1.370654724s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:26.010721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0330404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-11T05:46:26.01077Z","caller":"traceutil/trace.go:171","msg":"trace[2069856555] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:397; }","duration":"1.033153753s","start":"2026-05-11T05:46:24.977603Z","end":"2026-05-11T05:46:26.010757Z","steps":["trace[2069856555] 'agreement among raft nodes before linearized reading' (duration: 1.032998939s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:26.010801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.602428ms","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-05-11T05:46:26.010899Z","caller":"traceutil/trace.go:171","msg":"trace[586543495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:397; }","duration":"557.70146ms","start":"2026-05-11T05:46:25.453168Z","end":"2026-05-11T05:46:26.010869Z","steps":["trace[586543495] 'agreement among raft nodes before linearized reading' (duration: 557.581057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:26.010944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:25.45315Z","time spent":"557.783564ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-11T05:46:26.010809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:24.977582Z","time spent":"1.033218575s","remote":"127.0.0.1:39332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4349,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-05-11T05:46:26.011159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:24.638476Z","time spent":"1.372254014s","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T05:46:26.010905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.843168ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:26.011242Z","caller":"traceutil/trace.go:171","msg":"trace[1853504653] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:397; }","duration":"383.164727ms","start":"2026-05-11T05:46:25.628049Z","end":"2026-05-11T05:46:26.011213Z","steps":["trace[1853504653] 'agreement among raft nodes before linearized reading' (duration: 382.823387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:26.606008Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052601074856829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T05:46:27.106508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052601074856829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T05:46:27.607384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052601074856829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T05:46:27.871582Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.798344946s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-11T05:46:27.879795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.721112548s","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-05-11T05:46:27.879898Z","caller":"traceutil/trace.go:171","msg":"trace[61827173] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:403; }","duration":"1.721236871s","start":"2026-05-11T05:46:26.158649Z","end":"2026-05-11T05:46:27.879886Z","steps":["trace[61827173] 'range keys from in-memory index tree' (duration: 1.721095218s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:27.879964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774580255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-11T05:46:27.880002Z","caller":"traceutil/trace.go:171","msg":"trace[846771037] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:404; }","duration":"1.774667317s","start":"2026-05-11T05:46:26.105326Z","end":"2026-05-11T05:46:27.879993Z","steps":["trace[846771037] 'agreement among raft nodes before linearized reading' (duration: 1.774588075s)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:27.879885Z","caller":"traceutil/trace.go:171","msg":"trace[1804587211] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"1.774476433s","start":"2026-05-11T05:46:26.10539Z","end":"2026-05-11T05:46:27.879867Z","steps":["trace[1804587211] 'read index received' (duration: 1.766362534s)","trace[1804587211] 'applied index is now lower than readState.Index' (duration: 8.113019ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:27.880036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:26.10529Z","time spent":"1.774737329s","remote":"127.0.0.1:39178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-05-11T05:46:27.880422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342872039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T05:46:27.88058Z","caller":"traceutil/trace.go:171","msg":"trace[324349133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:404; }","duration":"1.342933741s","start":"2026-05-11T05:46:26.537517Z","end":"2026-05-11T05:46:27.880451Z","steps":["trace[324349133] 'agreement among raft nodes before linearized reading' (duration: 1.342597722s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:27.880614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:26.537501Z","time spent":"1.343104875s","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T05:46:27.880162Z","caller":"traceutil/trace.go:171","msg":"trace[630858002] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"1.80699726s","start":"2026-05-11T05:46:26.073134Z","end":"2026-05-11T05:46:27.880131Z","steps":["trace[630858002] 'process raft request' (duration: 1.798715066s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:27.883282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:26.073119Z","time spent":"1.809988526s","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T05:46:46.109981Z","caller":"traceutil/trace.go:171","msg":"trace[587355546] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"132.570473ms","start":"2026-05-11T05:46:45.977378Z","end":"2026-05-11T05:46:46.109948Z","steps":["trace[587355546] 'read index received' (duration: 75.030392ms)","trace[587355546] 'applied index is now lower than readState.Index' (duration: 57.538911ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:46.11011Z","caller":"traceutil/trace.go:171","msg":"trace[1339809843] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"135.821536ms","start":"2026-05-11T05:46:45.974278Z","end":"2026-05-11T05:46:46.110099Z","steps":["trace[1339809843] 'process raft request' (duration: 132.641315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:46.110295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.899722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:46.110325Z","caller":"traceutil/trace.go:171","msg":"trace[217508313] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:513; }","duration":"132.958763ms","start":"2026-05-11T05:46:45.977358Z","end":"2026-05-11T05:46:46.110317Z","steps":["trace[217508313] 'agreement among raft nodes before linearized reading' (duration: 132.883541ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:47.260075Z","caller":"traceutil/trace.go:171","msg":"trace[883163908] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"136.759501ms","start":"2026-05-11T05:46:47.123285Z","end":"2026-05-11T05:46:47.260045Z","steps":["trace[883163908] 'process raft request' (duration: 73.469821ms)","trace[883163908] 'compare' (duration: 62.468609ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:47.260305Z","caller":"traceutil/trace.go:171","msg":"trace[856501210] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"108.71287ms","start":"2026-05-11T05:46:47.151584Z","end":"2026-05-11T05:46:47.260297Z","steps":["trace[856501210] 'process raft request' (duration: 107.865768ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.251155Z","caller":"traceutil/trace.go:171","msg":"trace[430421728] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"100.961689ms","start":"2026-05-11T05:46:52.15017Z","end":"2026-05-11T05:46:52.251132Z","steps":["trace[430421728] 'read index received' (duration: 72.263221ms)","trace[430421728] 'applied index is now lower than readState.Index' (duration: 28.697778ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:52.251405Z","caller":"traceutil/trace.go:171","msg":"trace[55389156] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"104.301135ms","start":"2026-05-11T05:46:52.147095Z","end":"2026-05-11T05:46:52.251397Z","steps":["trace[55389156] 'process raft request' (duration: 75.402741ms)","trace[55389156] 'compare' (duration: 28.529985ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:52.251553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.36153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.251576Z","caller":"traceutil/trace.go:171","msg":"trace[338639290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:619; }","duration":"101.441652ms","start":"2026-05-11T05:46:52.150129Z","end":"2026-05-11T05:46:52.251571Z","steps":["trace[338639290] 'agreement among raft nodes before linearized reading' (duration: 101.382891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.251683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.436142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.253031Z","caller":"traceutil/trace.go:171","msg":"trace[802392165] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:619; }","duration":"102.802997ms","start":"2026-05-11T05:46:52.150219Z","end":"2026-05-11T05:46:52.253022Z","steps":["trace[802392165] 'agreement among raft nodes before linearized reading' (duration: 101.450783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.252923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.646527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.253079Z","caller":"traceutil/trace.go:171","msg":"trace[410502484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:619; }","duration":"101.867783ms","start":"2026-05-11T05:46:52.151206Z","end":"2026-05-11T05:46:52.253074Z","steps":["trace[410502484] 'agreement among raft nodes before linearized reading' (duration: 101.622306ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.498979Z","caller":"traceutil/trace.go:171","msg":"trace[1196637625] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"241.896269ms","start":"2026-05-11T05:46:52.25705Z","end":"2026-05-11T05:46:52.498946Z","steps":["trace[1196637625] 'process raft request' (duration: 241.657003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.499331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.168981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.499444Z","caller":"traceutil/trace.go:171","msg":"trace[594796946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"229.352336ms","start":"2026-05-11T05:46:52.270031Z","end":"2026-05-11T05:46:52.499383Z","steps":["trace[594796946] 'agreement among raft nodes before linearized reading' (duration: 229.024388ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.499222Z","caller":"traceutil/trace.go:171","msg":"trace[1192251838] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"228.828933ms","start":"2026-05-11T05:46:52.270074Z","end":"2026-05-11T05:46:52.498903Z","steps":["trace[1192251838] 'read index received' (duration: 15.252714ms)","trace[1192251838] 'applied index is now lower than readState.Index' (duration: 213.575319ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:52.721937Z","caller":"traceutil/trace.go:171","msg":"trace[877914538] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"222.294234ms","start":"2026-05-11T05:46:52.499616Z","end":"2026-05-11T05:46:52.72191Z","steps":["trace[877914538] 'read index received' (duration: 221.398541ms)","trace[877914538] 'applied index is now lower than readState.Index' (duration: 893.863µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:52.722192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.352138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.722249Z","caller":"traceutil/trace.go:171","msg":"trace[195459104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"424.638605ms","start":"2026-05-11T05:46:52.297587Z","end":"2026-05-11T05:46:52.722226Z","steps":["trace[195459104] 'agreement among raft nodes before linearized reading' (duration: 424.576563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.722283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.297574Z","time spent":"424.702326ms","remote":"127.0.0.1:34076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-11T05:46:52.72231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.66096ms","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-05-11T05:46:52.722412Z","caller":"traceutil/trace.go:171","msg":"trace[945811220] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"397.796723ms","start":"2026-05-11T05:46:52.324596Z","end":"2026-05-11T05:46:52.722393Z","steps":["trace[945811220] 'agreement among raft nodes before linearized reading' (duration: 397.562317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.722461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.949411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T05:46:52.722513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.550393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.722535Z","caller":"traceutil/trace.go:171","msg":"trace[287240576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"424.588864ms","start":"2026-05-11T05:46:52.29794Z","end":"2026-05-11T05:46:52.722529Z","steps":["trace[287240576] 'agreement among raft nodes before linearized reading' (duration: 424.554953ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.722545Z","caller":"traceutil/trace.go:171","msg":"trace[156541684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"329.179156ms","start":"2026-05-11T05:46:52.393347Z","end":"2026-05-11T05:46:52.722526Z","steps":["trace[156541684] 'agreement among raft nodes before linearized reading' (duration: 328.993702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.722554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.297932Z","time spent":"424.616764ms","remote":"127.0.0.1:34076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-11T05:46:52.722576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.393324Z","time spent":"329.244479ms","remote":"127.0.0.1:34094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-11T05:46:52.722585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.324591Z","time spent":"397.971657ms","remote":"127.0.0.1:34078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-11T05:46:52.722879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.860901ms","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-05-11T05:46:52.722906Z","caller":"traceutil/trace.go:171","msg":"trace[1442588552] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"205.915203ms","start":"2026-05-11T05:46:52.516985Z","end":"2026-05-11T05:46:52.722901Z","steps":["trace[1442588552] 'agreement among raft nodes before linearized reading' (duration: 205.874652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.722774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.752636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.723028Z","caller":"traceutil/trace.go:171","msg":"trace[1605472887] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"329.106254ms","start":"2026-05-11T05:46:52.393891Z","end":"2026-05-11T05:46:52.722997Z","steps":["trace[1605472887] 'agreement among raft nodes before linearized reading' (duration: 328.405007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.723124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.393855Z","time spent":"329.246168ms","remote":"127.0.0.1:34094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-11T05:46:52.722065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.739966ms","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":"warn","ts":"2026-05-11T05:46:52.723288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.005866ms","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-05-11T05:46:52.72331Z","caller":"traceutil/trace.go:171","msg":"trace[629849653] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"206.066326ms","start":"2026-05-11T05:46:52.517238Z","end":"2026-05-11T05:46:52.723304Z","steps":["trace[629849653] 'agreement among raft nodes before linearized reading' (duration: 206.028975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.723206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.075407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.723367Z","caller":"traceutil/trace.go:171","msg":"trace[2006365404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"453.250502ms","start":"2026-05-11T05:46:52.27011Z","end":"2026-05-11T05:46:52.72336Z","steps":["trace[2006365404] 'agreement among raft nodes before linearized reading' (duration: 452.909873ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.723286Z","caller":"traceutil/trace.go:171","msg":"trace[1328037424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"398.001158ms","start":"2026-05-11T05:46:52.325262Z","end":"2026-05-11T05:46:52.723264Z","steps":["trace[1328037424] 'agreement among raft nodes before linearized reading' (duration: 396.691224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.723419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.270106Z","time spent":"453.276372ms","remote":"127.0.0.1:34060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-11T05:46:52.723433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.325255Z","time spent":"398.170453ms","remote":"127.0.0.1:34078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-11T05:46:52.723325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.930486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T05:46:52.723447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.85618ms","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":"info","ts":"2026-05-11T05:46:52.723486Z","caller":"traceutil/trace.go:171","msg":"trace[924572857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"330.118921ms","start":"2026-05-11T05:46:52.393361Z","end":"2026-05-11T05:46:52.72348Z","steps":["trace[924572857] 'agreement among raft nodes before linearized reading' (duration: 329.943036ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:52.723548Z","caller":"traceutil/trace.go:171","msg":"trace[230491804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"399.017674ms","start":"2026-05-11T05:46:52.324512Z","end":"2026-05-11T05:46:52.723529Z","steps":["trace[230491804] 'agreement among raft nodes before linearized reading' (duration: 398.826279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.723644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.324476Z","time spent":"399.147147ms","remote":"127.0.0.1:34078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-11T05:46:52.725377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.138339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:52.725448Z","caller":"traceutil/trace.go:171","msg":"trace[647344262] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"427.242002ms","start":"2026-05-11T05:46:52.298194Z","end":"2026-05-11T05:46:52.725437Z","steps":["trace[647344262] 'agreement among raft nodes before linearized reading' (duration: 425.813505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.725483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.298179Z","time spent":"427.290213ms","remote":"127.0.0.1:34076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-11T05:46:52.723872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.393343Z","time spent":"330.157911ms","remote":"127.0.0.1:34094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-11T05:46:52.725395Z","caller":"traceutil/trace.go:171","msg":"trace[777034842] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"314.863048ms","start":"2026-05-11T05:46:52.410243Z","end":"2026-05-11T05:46:52.725106Z","steps":["trace[777034842] 'process raft request' (duration: 311.09683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:52.732209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.410213Z","time spent":"321.93218ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T05:46:53.153354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.107986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:46:53.15343Z","caller":"traceutil/trace.go:171","msg":"trace[1631713178] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"263.394983ms","start":"2026-05-11T05:46:52.890023Z","end":"2026-05-11T05:46:53.153418Z","steps":["trace[1631713178] 'read index received' (duration: 92.118172ms)","trace[1631713178] 'applied index is now lower than readState.Index' (duration: 171.276141ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:46:53.15349Z","caller":"traceutil/trace.go:171","msg":"trace[34739733] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"347.329752ms","start":"2026-05-11T05:46:52.806152Z","end":"2026-05-11T05:46:53.153482Z","steps":["trace[34739733] 'process raft request' (duration: 176.036162ms)","trace[34739733] 'compare' (duration: 170.995283ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:46:53.153528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:46:52.806132Z","time spent":"347.376365ms","remote":"127.0.0.1:39522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T05:46:53.153648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.374675ms","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-05-11T05:46:53.153641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.563358ms","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":"warn","ts":"2026-05-11T05:46:53.153639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.444735ms","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-05-11T05:46:53.153708Z","caller":"traceutil/trace.go:171","msg":"trace[115870794] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"263.704542ms","start":"2026-05-11T05:46:52.889987Z","end":"2026-05-11T05:46:53.153691Z","steps":["trace[115870794] 'agreement among raft nodes before linearized reading' (duration: 263.524356ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.153721Z","caller":"traceutil/trace.go:171","msg":"trace[1042901711] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"263.579518ms","start":"2026-05-11T05:46:52.890124Z","end":"2026-05-11T05:46:53.153704Z","steps":["trace[1042901711] 'agreement among raft nodes before linearized reading' (duration: 263.401033ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.153666Z","caller":"traceutil/trace.go:171","msg":"trace[2093681408] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"187.403106ms","start":"2026-05-11T05:46:52.966257Z","end":"2026-05-11T05:46:53.15366Z","steps":["trace[2093681408] 'agreement among raft nodes before linearized reading' (duration: 187.353575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.154038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.094207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:53.154063Z","caller":"traceutil/trace.go:171","msg":"trace[1768952355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:623; }","duration":"140.128498ms","start":"2026-05-11T05:46:53.013928Z","end":"2026-05-11T05:46:53.154056Z","steps":["trace[1768952355] 'agreement among raft nodes before linearized reading' (duration: 140.094507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.154107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.846907ms","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":"warn","ts":"2026-05-11T05:46:53.154153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.432766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T05:46:53.154145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.42509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:53.154175Z","caller":"traceutil/trace.go:171","msg":"trace[342615433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:623; }","duration":"140.468657ms","start":"2026-05-11T05:46:53.013701Z","end":"2026-05-11T05:46:53.154169Z","steps":["trace[342615433] 'agreement among raft nodes before linearized reading' (duration: 140.434686ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.154184Z","caller":"traceutil/trace.go:171","msg":"trace[1082746335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"231.485561ms","start":"2026-05-11T05:46:52.922687Z","end":"2026-05-11T05:46:53.154172Z","steps":["trace[1082746335] 'agreement among raft nodes before linearized reading' (duration: 231.417129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.154224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.661009ms","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":"warn","ts":"2026-05-11T05:46:53.154251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.635702ms","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":"info","ts":"2026-05-11T05:46:53.154254Z","caller":"traceutil/trace.go:171","msg":"trace[1803482777] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"263.728711ms","start":"2026-05-11T05:46:52.890515Z","end":"2026-05-11T05:46:53.154244Z","steps":["trace[1803482777] 'agreement among raft nodes before linearized reading' (duration: 263.69205ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.15427Z","caller":"traceutil/trace.go:171","msg":"trace[85487905] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"187.665522ms","start":"2026-05-11T05:46:52.9666Z","end":"2026-05-11T05:46:53.154265Z","steps":["trace[85487905] 'agreement among raft nodes before linearized reading' (duration: 187.634841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.154339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.799633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:53.154369Z","caller":"traceutil/trace.go:171","msg":"trace[263349156] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"202.867615ms","start":"2026-05-11T05:46:52.951493Z","end":"2026-05-11T05:46:53.154361Z","steps":["trace[263349156] 'agreement among raft nodes before linearized reading' (duration: 202.822423ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.154147Z","caller":"traceutil/trace.go:171","msg":"trace[1889763051] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:623; }","duration":"187.898028ms","start":"2026-05-11T05:46:52.966239Z","end":"2026-05-11T05:46:53.154137Z","steps":["trace[1889763051] 'agreement among raft nodes before linearized reading' (duration: 187.830876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.15452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.356296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:53.154549Z","caller":"traceutil/trace.go:171","msg":"trace[473212542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"203.394828ms","start":"2026-05-11T05:46:52.951146Z","end":"2026-05-11T05:46:53.154541Z","steps":["trace[473212542] 'agreement among raft nodes before linearized reading' (duration: 203.349017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:53.154669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.526571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T05:46:53.154188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.737537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:46:53.154695Z","caller":"traceutil/trace.go:171","msg":"trace[1956098091] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"203.570802ms","start":"2026-05-11T05:46:52.951117Z","end":"2026-05-11T05:46:53.154687Z","steps":["trace[1956098091] 'agreement among raft nodes before linearized reading' (duration: 203.531271ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:53.154714Z","caller":"traceutil/trace.go:171","msg":"trace[642255521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"232.280851ms","start":"2026-05-11T05:46:52.922425Z","end":"2026-05-11T05:46:53.154706Z","steps":["trace[642255521] 'agreement among raft nodes before linearized reading' (duration: 231.742218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:46:54.28098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.971241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:46:54.281252Z","caller":"traceutil/trace.go:171","msg":"trace[2021517662] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"116.357346ms","start":"2026-05-11T05:46:54.164849Z","end":"2026-05-11T05:46:54.281206Z","steps":["trace[2021517662] 'compare' (duration: 107.762046ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:46:54.281403Z","caller":"traceutil/trace.go:171","msg":"trace[513106436] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"116.184121ms","start":"2026-05-11T05:46:54.165174Z","end":"2026-05-11T05:46:54.281358Z","steps":["trace[513106436] 'process raft request' (duration: 115.958145ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:47:09.236734Z","caller":"traceutil/trace.go:171","msg":"trace[1476258767] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"118.79206ms","start":"2026-05-11T05:47:09.117917Z","end":"2026-05-11T05:47:09.236709Z","steps":["trace[1476258767] 'read index received' (duration: 118.605195ms)","trace[1476258767] 'applied index is now lower than readState.Index' (duration: 185.975µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:47:09.236851Z","caller":"traceutil/trace.go:171","msg":"trace[278046953] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"250.675166ms","start":"2026-05-11T05:47:08.986165Z","end":"2026-05-11T05:47:09.23684Z","steps":["trace[278046953] 'process raft request' (duration: 250.409629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:47:09.237009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.075217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:47:09.237047Z","caller":"traceutil/trace.go:171","msg":"trace[1943882892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"119.16599ms","start":"2026-05-11T05:47:09.11787Z","end":"2026-05-11T05:47:09.237036Z","steps":["trace[1943882892] 'agreement among raft nodes before linearized reading' (duration: 119.090688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:47:45.012555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.438608ms","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-05-11T05:47:45.012617Z","caller":"traceutil/trace.go:171","msg":"trace[597992589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1003; }","duration":"223.541701ms","start":"2026-05-11T05:47:44.789063Z","end":"2026-05-11T05:47:45.012605Z","steps":["trace[597992589] 'range keys from in-memory index tree' (duration: 223.278104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:47:45.012725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.69775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-11T05:47:45.012786Z","caller":"traceutil/trace.go:171","msg":"trace[1205598607] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1003; }","duration":"174.805153ms","start":"2026-05-11T05:47:44.837966Z","end":"2026-05-11T05:47:45.012772Z","steps":["trace[1205598607] 'range keys from in-memory index tree' (duration: 174.551716ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:47:45.173492Z","caller":"traceutil/trace.go:171","msg":"trace[273820651] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"157.486115ms","start":"2026-05-11T05:47:45.015983Z","end":"2026-05-11T05:47:45.173469Z","steps":["trace[273820651] 'process raft request' (duration: 157.319051ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:47:45.307455Z","caller":"traceutil/trace.go:171","msg":"trace[1183968844] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1040; }","duration":"187.876893ms","start":"2026-05-11T05:47:45.119546Z","end":"2026-05-11T05:47:45.307423Z","steps":["trace[1183968844] 'read index received' (duration: 53.721571ms)","trace[1183968844] 'applied index is now lower than readState.Index' (duration: 134.153012ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:47:45.307511Z","caller":"traceutil/trace.go:171","msg":"trace[1330478501] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"290.583332ms","start":"2026-05-11T05:47:45.016902Z","end":"2026-05-11T05:47:45.307486Z","steps":["trace[1330478501] 'process raft request' (duration: 289.891144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:47:45.307623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.045518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:47:45.307662Z","caller":"traceutil/trace.go:171","msg":"trace[801862126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"188.13858ms","start":"2026-05-11T05:47:45.119511Z","end":"2026-05-11T05:47:45.307649Z","steps":["trace[801862126] 'agreement among raft nodes before linearized reading' (duration: 188.028297ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:06.661679Z","caller":"traceutil/trace.go:171","msg":"trace[859859710] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"130.226875ms","start":"2026-05-11T05:48:06.531403Z","end":"2026-05-11T05:48:06.66163Z","steps":["trace[859859710] 'process raft request' (duration: 129.583619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:06.924881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.159783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:48:06.924962Z","caller":"traceutil/trace.go:171","msg":"trace[2053460565] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"191.652906ms","start":"2026-05-11T05:48:06.733297Z","end":"2026-05-11T05:48:06.92495Z","steps":["trace[2053460565] 'read index received' (duration: 48.297729ms)","trace[2053460565] 'applied index is now lower than readState.Index' (duration: 143.354137ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:48:06.925118Z","caller":"traceutil/trace.go:171","msg":"trace[1425093858] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"259.576788ms","start":"2026-05-11T05:48:06.665533Z","end":"2026-05-11T05:48:06.925109Z","steps":["trace[1425093858] 'process raft request' (duration: 116.112847ms)","trace[1425093858] 'compare' (duration: 143.074131ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:48:06.92531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.019676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T05:48:06.925329Z","caller":"traceutil/trace.go:171","msg":"trace[843954003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1074; }","duration":"192.079837ms","start":"2026-05-11T05:48:06.733243Z","end":"2026-05-11T05:48:06.925323Z","steps":["trace[843954003] 'agreement among raft nodes before linearized reading' (duration: 191.996055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:06.92547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.859465ms","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-05-11T05:48:06.925497Z","caller":"traceutil/trace.go:171","msg":"trace[1223169555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1074; }","duration":"170.903517ms","start":"2026-05-11T05:48:06.754586Z","end":"2026-05-11T05:48:06.925489Z","steps":["trace[1223169555] 'agreement among raft nodes before linearized reading' (duration: 170.819925ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:07.18188Z","caller":"traceutil/trace.go:171","msg":"trace[1685017784] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"252.453824ms","start":"2026-05-11T05:48:06.9294Z","end":"2026-05-11T05:48:07.181854Z","steps":["trace[1685017784] 'process raft request' (duration: 194.080277ms)","trace[1685017784] 'compare' (duration: 58.145361ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:48:07.182163Z","caller":"traceutil/trace.go:171","msg":"trace[1666773723] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"252.187787ms","start":"2026-05-11T05:48:06.929934Z","end":"2026-05-11T05:48:07.182122Z","steps":["trace[1666773723] 'process raft request' (duration: 251.849649ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:07.182152Z","caller":"traceutil/trace.go:171","msg":"trace[106311483] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1116; }","duration":"118.618339ms","start":"2026-05-11T05:48:07.063479Z","end":"2026-05-11T05:48:07.182097Z","steps":["trace[106311483] 'read index received' (duration: 59.970005ms)","trace[106311483] 'applied index is now lower than readState.Index' (duration: 58.645293ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:48:07.182376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.894786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T05:48:07.18245Z","caller":"traceutil/trace.go:171","msg":"trace[1262948885] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1076; }","duration":"119.017829ms","start":"2026-05-11T05:48:07.063414Z","end":"2026-05-11T05:48:07.182432Z","steps":["trace[1262948885] 'agreement among raft nodes before linearized reading' (duration: 118.881785ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:23.173357Z","caller":"traceutil/trace.go:171","msg":"trace[1307889718] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"144.567438ms","start":"2026-05-11T05:48:23.028765Z","end":"2026-05-11T05:48:23.173333Z","steps":["trace[1307889718] 'process raft request' (duration: 144.319192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:23.41834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.290796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T05:48:23.41848Z","caller":"traceutil/trace.go:171","msg":"trace[2014970640] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1179; }","duration":"210.47125ms","start":"2026-05-11T05:48:23.207963Z","end":"2026-05-11T05:48:23.418434Z","steps":["trace[2014970640] 'count revisions from in-memory index tree' (duration: 210.170672ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:40.741136Z","caller":"traceutil/trace.go:171","msg":"trace[150767672] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"220.06532ms","start":"2026-05-11T05:48:40.521046Z","end":"2026-05-11T05:48:40.741111Z","steps":["trace[150767672] 'process raft request' (duration: 219.901876ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:40.853496Z","caller":"traceutil/trace.go:171","msg":"trace[1418507760] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"105.36929ms","start":"2026-05-11T05:48:40.74809Z","end":"2026-05-11T05:48:40.853459Z","steps":["trace[1418507760] 'process raft request' (duration: 94.219347ms)","trace[1418507760] 'compare' (duration: 10.791365ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:48:41.989208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.738369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:48:41.989695Z","caller":"traceutil/trace.go:171","msg":"trace[15674949] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"701.149291ms","start":"2026-05-11T05:48:41.288463Z","end":"2026-05-11T05:48:41.989612Z","steps":["trace[15674949] 'process raft request' (duration: 260.92165ms)","trace[15674949] 'compare' (duration: 439.618096ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:48:41.989978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:48:41.288441Z","time spent":"701.392056ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T05:48:42.015804Z","caller":"traceutil/trace.go:171","msg":"trace[407349112] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1315; }","duration":"521.4545ms","start":"2026-05-11T05:48:41.494328Z","end":"2026-05-11T05:48:42.015783Z","steps":["trace[407349112] 'read index received' (duration: 55.073548ms)","trace[407349112] 'applied index is now lower than readState.Index' (duration: 466.379542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:48:42.016006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.684685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T05:48:42.016044Z","caller":"traceutil/trace.go:171","msg":"trace[1355545266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1266; }","duration":"521.767427ms","start":"2026-05-11T05:48:41.494267Z","end":"2026-05-11T05:48:42.016035Z","steps":["trace[1355545266] 'agreement among raft nodes before linearized reading' (duration: 521.627084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:42.016083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:48:41.494244Z","time spent":"521.826809ms","remote":"127.0.0.1:39422","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-05-11T05:48:42.016245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.217387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-11T05:48:42.016289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.420202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-11T05:48:42.016356Z","caller":"traceutil/trace.go:171","msg":"trace[1179601167] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1266; }","duration":"152.532696ms","start":"2026-05-11T05:48:41.863803Z","end":"2026-05-11T05:48:42.016336Z","steps":["trace[1179601167] 'agreement among raft nodes before linearized reading' (duration: 152.30684ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:48:42.01636Z","caller":"traceutil/trace.go:171","msg":"trace[1772650287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1266; }","duration":"517.3704ms","start":"2026-05-11T05:48:41.498955Z","end":"2026-05-11T05:48:42.016326Z","steps":["trace[1772650287] 'agreement among raft nodes before linearized reading' (duration: 517.045773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:42.016412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:48:41.498943Z","time spent":"517.457833ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T05:48:42.016472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.190679ms","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-05-11T05:48:42.016538Z","caller":"traceutil/trace.go:171","msg":"trace[61432656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1266; }","duration":"511.303282ms","start":"2026-05-11T05:48:41.505224Z","end":"2026-05-11T05:48:42.016527Z","steps":["trace[61432656] 'agreement among raft nodes before linearized reading' (duration: 511.174839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:48:42.016568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:48:41.505199Z","time spent":"511.362513ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-11T05:48:42.654674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.17268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T05:48:42.654813Z","caller":"traceutil/trace.go:171","msg":"trace[907742749] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"256.121933ms","start":"2026-05-11T05:48:42.398655Z","end":"2026-05-11T05:48:42.654777Z","steps":["trace[907742749] 'process raft request' (duration: 58.731808ms)","trace[907742749] 'compare' (duration: 196.983315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T05:50:00.896052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.554079ms","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-05-11T05:50:00.896211Z","caller":"traceutil/trace.go:171","msg":"trace[2145979810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1652; }","duration":"388.749894ms","start":"2026-05-11T05:50:00.507441Z","end":"2026-05-11T05:50:00.896191Z","steps":["trace[2145979810] 'range keys from in-memory index tree' (duration: 388.383344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.896265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.507429Z","time spent":"388.825515ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-11T05:50:00.896437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.761504ms","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-05-11T05:50:00.896535Z","caller":"traceutil/trace.go:171","msg":"trace[408231125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1652; }","duration":"487.904167ms","start":"2026-05-11T05:50:00.408597Z","end":"2026-05-11T05:50:00.896501Z","steps":["trace[408231125] 'range keys from in-memory index tree' (duration: 487.593469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.896538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.207657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-11T05:50:00.896572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.408567Z","time spent":"487.99823ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T05:50:00.896595Z","caller":"traceutil/trace.go:171","msg":"trace[715709674] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1652; }","duration":"345.30399ms","start":"2026-05-11T05:50:00.55127Z","end":"2026-05-11T05:50:00.896574Z","steps":["trace[715709674] 'range keys from in-memory index tree' (duration: 345.071994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.896652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.551243Z","time spent":"345.398822ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-11T05:50:00.896715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.515588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:50:00.896766Z","caller":"traceutil/trace.go:171","msg":"trace[1024982252] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1652; }","duration":"138.61716ms","start":"2026-05-11T05:50:00.758138Z","end":"2026-05-11T05:50:00.896755Z","steps":["trace[1024982252] 'count revisions from in-memory index tree' (duration: 138.356854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.89686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.282393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-05-11T05:50:00.896888Z","caller":"traceutil/trace.go:171","msg":"trace[587135779] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1652; }","duration":"452.333964ms","start":"2026-05-11T05:50:00.444546Z","end":"2026-05-11T05:50:00.89688Z","steps":["trace[587135779] 'range keys from in-memory index tree' (duration: 452.197501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.896909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.444534Z","time spent":"452.367485ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-11T05:50:00.896243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.668077ms","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-05-11T05:50:00.897056Z","caller":"traceutil/trace.go:171","msg":"trace[1984182711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1652; }","duration":"388.557949ms","start":"2026-05-11T05:50:00.508489Z","end":"2026-05-11T05:50:00.897047Z","steps":["trace[1984182711] 'range keys from in-memory index tree' (duration: 387.463743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.897097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.508459Z","time spent":"388.629221ms","remote":"127.0.0.1:39422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T05:50:00.896465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.899746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T05:50:00.89724Z","caller":"traceutil/trace.go:171","msg":"trace[1104578852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1652; }","duration":"351.700326ms","start":"2026-05-11T05:50:00.545532Z","end":"2026-05-11T05:50:00.897232Z","steps":["trace[1104578852] 'range keys from in-memory index tree' (duration: 350.795854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:50:00.89728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T05:50:00.54552Z","time spent":"351.753207ms","remote":"127.0.0.1:39422","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-05-11T05:50:01.291691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.404869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T05:50:01.29182Z","caller":"traceutil/trace.go:171","msg":"trace[1104524391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1659; }","duration":"170.591045ms","start":"2026-05-11T05:50:01.121183Z","end":"2026-05-11T05:50:01.291774Z","steps":["trace[1104524391] 'range keys from in-memory index tree' (duration: 170.283567ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T05:52:24.739825Z","caller":"traceutil/trace.go:171","msg":"trace[1600681733] transaction","detail":"{read_only:false; response_revision:2344; number_of_response:1; }","duration":"138.676934ms","start":"2026-05-11T05:52:24.601121Z","end":"2026-05-11T05:52:24.739798Z","steps":["trace[1600681733] 'process raft request' (duration: 138.464579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T05:52:24.740105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.597521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-05-11T05:52:24.739771Z","caller":"traceutil/trace.go:171","msg":"trace[1907404848] linearizableReadLoop","detail":"{readStateIndex:2440; appliedIndex:2439; }","duration":"101.263002ms","start":"2026-05-11T05:52:24.63848Z","end":"2026-05-11T05:52:24.739743Z","steps":["trace[1907404848] 'read index received' (duration: 101.029196ms)","trace[1907404848] 'applied index is now lower than readState.Index' (duration: 232.806µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T05:52:24.740204Z","caller":"traceutil/trace.go:171","msg":"trace[2094779224] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2344; }","duration":"101.768825ms","start":"2026-05-11T05:52:24.638411Z","end":"2026-05-11T05:52:24.74018Z","steps":["trace[2094779224] 'agreement among raft nodes before linearized reading' (duration: 101.468237ms)"],"step_count":1}