{"level":"warn","ts":"2026-04-13T17:11:15.022879Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:11:15.023032Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.179:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.179:2380","--initial-cluster=instance=https://199.19.213.179:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.179:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.179: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-04-13T17:11:15.023148Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:11:15.023163Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-04-13T17:11:15.023186Z","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-04-13T17:11:15.024408Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"]} {"level":"info","ts":"2026-04-13T17:11:15.024667Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.179: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-04-13T17:11:15.031668Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.572622ms"} {"level":"info","ts":"2026-04-13T17:11:15.044043Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"69895f7c3b831156","cluster-id":"caac76e5ff14ceff"} {"level":"info","ts":"2026-04-13T17:11:15.044179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T17:11:15.04421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 0"} {"level":"info","ts":"2026-04-13T17:11:15.044238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 69895f7c3b831156 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T17:11:15.044252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became follower at term 1"} {"level":"info","ts":"2026-04-13T17:11:15.044395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"warn","ts":"2026-04-13T17:11:15.056734Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T17:11:15.059212Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T17:11:15.063793Z","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-04-13T17:11:15.067822Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"69895f7c3b831156","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T17:11:15.068044Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"69895f7c3b831156","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T17:11:15.068725Z","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-04-13T17:11:15.068817Z","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-04-13T17:11:15.068829Z","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-04-13T17:11:15.076201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 switched to configuration voters=(7604714432970821974)"} {"level":"info","ts":"2026-04-13T17:11:15.076338Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","added-peer-id":"69895f7c3b831156","added-peer-peer-urls":["https://199.19.213.179:2380"]} {"level":"info","ts":"2026-04-13T17:11:15.076864Z","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-04-13T17:11:15.077104Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"69895f7c3b831156","initial-advertise-peer-urls":["https://199.19.213.179:2380"],"listen-peer-urls":["https://199.19.213.179:2380"],"advertise-client-urls":["https://199.19.213.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T17:11:15.07714Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T17:11:15.077714Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-04-13T17:11:15.077753Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.179:2380"} {"level":"info","ts":"2026-04-13T17:11:15.145253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T17:11:15.145321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T17:11:15.145631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgPreVoteResp from 69895f7c3b831156 at term 1"} {"level":"info","ts":"2026-04-13T17:11:15.145789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became candidate at term 2"} {"level":"info","ts":"2026-04-13T17:11:15.145816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 received MsgVoteResp from 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-04-13T17:11:15.145923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"69895f7c3b831156 became leader at term 2"} {"level":"info","ts":"2026-04-13T17:11:15.145951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 69895f7c3b831156 elected leader 69895f7c3b831156 at term 2"} {"level":"info","ts":"2026-04-13T17:11:15.147154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"69895f7c3b831156","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.179:2379]}","request-path":"/0/members/69895f7c3b831156/attributes","cluster-id":"caac76e5ff14ceff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T17:11:15.147184Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:11:15.147445Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:11:15.147763Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:11:15.148082Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T17:11:15.148256Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T17:11:15.150405Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"caac76e5ff14ceff","local-member-id":"69895f7c3b831156","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:11:15.150512Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:11:15.150547Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:11:15.150863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.179:2379"} {"level":"info","ts":"2026-04-13T17:11:15.152945Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-13T17:11:20.592072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.628214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:11:20.592231Z","caller":"traceutil/trace.go:171","msg":"trace[248598741] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:219; }","duration":"557.759616ms","start":"2026-04-13T17:11:20.034454Z","end":"2026-04-13T17:11:20.592213Z","steps":["trace[248598741] 'read index received' (duration: 48.921µs)","trace[248598741] 'applied index is now lower than readState.Index' (duration: 557.709334ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:20.592266Z","caller":"traceutil/trace.go:171","msg":"trace[276433120] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"790.000323ms","start":"2026-04-13T17:11:19.802234Z","end":"2026-04-13T17:11:20.592235Z","steps":["trace[276433120] 'process raft request' (duration: 130.589862ms)","trace[276433120] 'compare' (duration: 658.386688ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:11:20.592406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.952521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-04-13T17:11:20.59244Z","caller":"traceutil/trace.go:171","msg":"trace[170152478] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:214; }","duration":"558.039263ms","start":"2026-04-13T17:11:20.03439Z","end":"2026-04-13T17:11:20.59243Z","steps":["trace[170152478] 'agreement among raft nodes before linearized reading' (duration: 557.881119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:20.592425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:19.80222Z","time spent":"790.123235ms","remote":"127.0.0.1:50994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:11:20.592515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:20.034368Z","time spent":"558.110674ms","remote":"127.0.0.1:50972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-13T17:11:21.097214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335592722,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:11:21.41385Z","caller":"traceutil/trace.go:171","msg":"trace[521087759] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"835.756095ms","start":"2026-04-13T17:11:20.578059Z","end":"2026-04-13T17:11:21.413815Z","steps":["trace[521087759] 'process raft request' (duration: 802.534571ms)","trace[521087759] 'compare' (duration: 33.080391ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:11:21.413996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:20.578029Z","time spent":"835.901398ms","remote":"127.0.0.1:50898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:11:21.601377Z","caller":"traceutil/trace.go:171","msg":"trace[996537728] linearizableReadLoop","detail":"{readStateIndex:222; appliedIndex:220; }","duration":"1.005047144s","start":"2026-04-13T17:11:20.596289Z","end":"2026-04-13T17:11:21.601336Z","steps":["trace[996537728] 'read index received' (duration: 784.325982ms)","trace[996537728] 'applied index is now lower than readState.Index' (duration: 220.719382ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:21.601497Z","caller":"traceutil/trace.go:171","msg":"trace[1554081677] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"998.709209ms","start":"2026-04-13T17:11:20.602708Z","end":"2026-04-13T17:11:21.601417Z","steps":["trace[1554081677] 'process raft request' (duration: 998.397022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:21.602222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:20.602672Z","time spent":"999.029066ms","remote":"127.0.0.1:50972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:11:21.602514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005417043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:21.602656Z","caller":"traceutil/trace.go:171","msg":"trace[570282899] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:216; }","duration":"1.006388635s","start":"2026-04-13T17:11:20.596229Z","end":"2026-04-13T17:11:21.602618Z","steps":["trace[570282899] 'agreement among raft nodes before linearized reading' (duration: 1.005391962s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:21.602721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:20.596214Z","time spent":"1.006490817s","remote":"127.0.0.1:50994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-04-13T17:11:21.608442Z","caller":"traceutil/trace.go:171","msg":"trace[2123404806] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"188.661034ms","start":"2026-04-13T17:11:21.41976Z","end":"2026-04-13T17:11:21.608421Z","steps":["trace[2123404806] 'process raft request' (duration: 188.48215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:21.608633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007981802s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:21.608713Z","caller":"traceutil/trace.go:171","msg":"trace[850653541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:217; }","duration":"1.008087244s","start":"2026-04-13T17:11:20.600609Z","end":"2026-04-13T17:11:21.608696Z","steps":["trace[850653541] 'agreement among raft nodes before linearized reading' (duration: 1.00794624s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:21.608763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:20.600602Z","time spent":"1.008151176s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:11:21.608997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.731137ms","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-04-13T17:11:21.609045Z","caller":"traceutil/trace.go:171","msg":"trace[474246192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:217; }","duration":"151.843849ms","start":"2026-04-13T17:11:21.457189Z","end":"2026-04-13T17:11:21.609033Z","steps":["trace[474246192] 'agreement among raft nodes before linearized reading' (duration: 151.187064ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:47.043437Z","caller":"traceutil/trace.go:171","msg":"trace[1654926558] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"113.964769ms","start":"2026-04-13T17:11:46.929444Z","end":"2026-04-13T17:11:47.043408Z","steps":["trace[1654926558] 'process raft request' (duration: 103.760684ms)","trace[1654926558] 'compare' (duration: 10.058272ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:47.04458Z","caller":"traceutil/trace.go:171","msg":"trace[207484490] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"104.625204ms","start":"2026-04-13T17:11:46.939939Z","end":"2026-04-13T17:11:47.044565Z","steps":["trace[207484490] 'process raft request' (duration: 104.168604ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:47.044848Z","caller":"traceutil/trace.go:171","msg":"trace[1890672353] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"108.063352ms","start":"2026-04-13T17:11:46.936764Z","end":"2026-04-13T17:11:47.044828Z","steps":["trace[1890672353] 'process raft request' (duration: 107.164932ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:48.658408Z","caller":"traceutil/trace.go:171","msg":"trace[309871248] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"285.148292ms","start":"2026-04-13T17:11:48.373228Z","end":"2026-04-13T17:11:48.658377Z","steps":["trace[309871248] 'read index received' (duration: 285.016239ms)","trace[309871248] 'applied index is now lower than readState.Index' (duration: 131.253µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:48.658511Z","caller":"traceutil/trace.go:171","msg":"trace[1471092566] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"317.920155ms","start":"2026-04-13T17:11:48.340544Z","end":"2026-04-13T17:11:48.658464Z","steps":["trace[1471092566] 'process raft request' (duration: 317.69643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:48.658587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.320466ms","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-04-13T17:11:48.658641Z","caller":"traceutil/trace.go:171","msg":"trace[1593070654] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:517; }","duration":"285.436589ms","start":"2026-04-13T17:11:48.37319Z","end":"2026-04-13T17:11:48.658627Z","steps":["trace[1593070654] 'agreement among raft nodes before linearized reading' (duration: 285.302006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:48.658737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:48.340518Z","time spent":"318.097148ms","remote":"127.0.0.1:51048","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-04-13T17:11:52.880928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.945227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:52.881015Z","caller":"traceutil/trace.go:171","msg":"trace[2028783669] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:605; }","duration":"453.072061ms","start":"2026-04-13T17:11:52.427923Z","end":"2026-04-13T17:11:52.880995Z","steps":["trace[2028783669] 'range keys from in-memory index tree' (duration: 452.890495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:52.881054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:52.427904Z","time spent":"453.139792ms","remote":"127.0.0.1:50994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-13T17:11:55.869922Z","caller":"traceutil/trace.go:171","msg":"trace[398541760] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"465.736706ms","start":"2026-04-13T17:11:55.40416Z","end":"2026-04-13T17:11:55.869896Z","steps":["trace[398541760] 'read index received' (duration: 464.958317ms)","trace[398541760] 'applied index is now lower than readState.Index' (duration: 776.329µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:55.86997Z","caller":"traceutil/trace.go:171","msg":"trace[323062331] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"523.556099ms","start":"2026-04-13T17:11:55.346387Z","end":"2026-04-13T17:11:55.869944Z","steps":["trace[323062331] 'process raft request' (duration: 522.889583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.870112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.921302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:55.870153Z","caller":"traceutil/trace.go:171","msg":"trace[1867195918] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"466.036215ms","start":"2026-04-13T17:11:55.404106Z","end":"2026-04-13T17:11:55.870143Z","steps":["trace[1867195918] 'agreement among raft nodes before linearized reading' (duration: 465.942051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.870202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.404073Z","time spent":"466.117677ms","remote":"127.0.0.1:42256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T17:11:55.870138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.34635Z","time spent":"523.683312ms","remote":"127.0.0.1:50924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:11:55.870473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.265069ms","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-04-13T17:11:55.870633Z","caller":"traceutil/trace.go:171","msg":"trace[117285650] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:622; }","duration":"347.485124ms","start":"2026-04-13T17:11:55.523111Z","end":"2026-04-13T17:11:55.870597Z","steps":["trace[117285650] 'agreement among raft nodes before linearized reading' (duration: 347.159116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.870725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.523108Z","time spent":"347.599627ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:55.870886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.397288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:55.870967Z","caller":"traceutil/trace.go:171","msg":"trace[193438582] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:622; }","duration":"308.498601ms","start":"2026-04-13T17:11:55.562431Z","end":"2026-04-13T17:11:55.87093Z","steps":["trace[193438582] 'agreement among raft nodes before linearized reading' (duration: 308.378398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.87102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.562419Z","time spent":"308.588183ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:55.871129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.508357ms","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-04-13T17:11:55.871143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.321452ms","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-04-13T17:11:55.871182Z","caller":"traceutil/trace.go:171","msg":"trace[1692014607] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:622; }","duration":"309.563568ms","start":"2026-04-13T17:11:55.561606Z","end":"2026-04-13T17:11:55.87117Z","steps":["trace[1692014607] 'agreement among raft nodes before linearized reading' (duration: 309.484376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.871217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.561558Z","time spent":"309.64963ms","remote":"127.0.0.1:42274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-13T17:11:55.871204Z","caller":"traceutil/trace.go:171","msg":"trace[415222727] 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":"176.410473ms","start":"2026-04-13T17:11:55.694772Z","end":"2026-04-13T17:11:55.871182Z","steps":["trace[415222727] 'agreement among raft nodes before linearized reading' (duration: 176.335781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.871464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.851525ms","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-04-13T17:11:55.871551Z","caller":"traceutil/trace.go:171","msg":"trace[165150435] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:622; }","duration":"309.955808ms","start":"2026-04-13T17:11:55.561574Z","end":"2026-04-13T17:11:55.87153Z","steps":["trace[165150435] 'agreement among raft nodes before linearized reading' (duration: 309.714462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.871575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.343309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:55.871591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.469259ms","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-04-13T17:11:55.871588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.561554Z","time spent":"310.022409ms","remote":"127.0.0.1:42274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:11:55.871625Z","caller":"traceutil/trace.go:171","msg":"trace[955951975] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"411.39793ms","start":"2026-04-13T17:11:55.460215Z","end":"2026-04-13T17:11:55.871613Z","steps":["trace[955951975] 'agreement among raft nodes before linearized reading' (duration: 411.322078ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:55.871631Z","caller":"traceutil/trace.go:171","msg":"trace[1685978756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:622; }","duration":"348.54947ms","start":"2026-04-13T17:11:55.523071Z","end":"2026-04-13T17:11:55.87162Z","steps":["trace[1685978756] 'agreement among raft nodes before linearized reading' (duration: 348.474058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.871662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.460185Z","time spent":"411.466802ms","remote":"127.0.0.1:42260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:55.87167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.52305Z","time spent":"348.611692ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T17:11:55.871866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.741159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:55.87189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.50821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:55.871908Z","caller":"traceutil/trace.go:171","msg":"trace[410399286] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"411.81267ms","start":"2026-04-13T17:11:55.460086Z","end":"2026-04-13T17:11:55.871899Z","steps":["trace[410399286] 'agreement among raft nodes before linearized reading' (duration: 411.752628ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:55.871924Z","caller":"traceutil/trace.go:171","msg":"trace[763562270] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"467.562052ms","start":"2026-04-13T17:11:55.40435Z","end":"2026-04-13T17:11:55.871912Z","steps":["trace[763562270] 'agreement among raft nodes before linearized reading' (duration: 467.504251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.87194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.460065Z","time spent":"411.867792ms","remote":"127.0.0.1:42260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T17:11:55.871957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.404339Z","time spent":"467.607853ms","remote":"127.0.0.1:42256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:55.871914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.231916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:55.872018Z","caller":"traceutil/trace.go:171","msg":"trace[971644226] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"411.359079ms","start":"2026-04-13T17:11:55.460646Z","end":"2026-04-13T17:11:55.872005Z","steps":["trace[971644226] 'agreement among raft nodes before linearized reading' (duration: 411.231035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.872092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.460634Z","time spent":"411.442531ms","remote":"127.0.0.1:42260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:55.872219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.031254ms","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":"warn","ts":"2026-04-13T17:11:55.872417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.581522ms","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-04-13T17:11:55.872463Z","caller":"traceutil/trace.go:171","msg":"trace[995532711] 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":"177.634723ms","start":"2026-04-13T17:11:55.694816Z","end":"2026-04-13T17:11:55.872451Z","steps":["trace[995532711] 'agreement among raft nodes before linearized reading' (duration: 175.377398ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:55.872911Z","caller":"traceutil/trace.go:171","msg":"trace[1216396371] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"468.716191ms","start":"2026-04-13T17:11:55.40418Z","end":"2026-04-13T17:11:55.872896Z","steps":["trace[1216396371] 'agreement among raft nodes before linearized reading' (duration: 466.019154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:55.87297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:55.404153Z","time spent":"468.793704ms","remote":"127.0.0.1:42256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:11:56.008725Z","caller":"traceutil/trace.go:171","msg":"trace[2110457166] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"118.041186ms","start":"2026-04-13T17:11:55.890658Z","end":"2026-04-13T17:11:56.0087Z","steps":["trace[2110457166] 'read index received' (duration: 6.03371ms)","trace[2110457166] 'applied index is now lower than readState.Index' (duration: 112.006926ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:56.009161Z","caller":"traceutil/trace.go:171","msg":"trace[423250121] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"113.562725ms","start":"2026-04-13T17:11:55.89559Z","end":"2026-04-13T17:11:56.009153Z","steps":["trace[423250121] 'process raft request' (duration: 113.056502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.009349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.655492ms","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-04-13T17:11:56.009417Z","caller":"traceutil/trace.go:171","msg":"trace[1550340434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"118.759175ms","start":"2026-04-13T17:11:55.890611Z","end":"2026-04-13T17:11:56.00937Z","steps":["trace[1550340434] 'agreement among raft nodes before linearized reading' (duration: 118.676973ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:56.0096Z","caller":"traceutil/trace.go:171","msg":"trace[510988270] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"128.490488ms","start":"2026-04-13T17:11:55.881081Z","end":"2026-04-13T17:11:56.009572Z","steps":["trace[510988270] 'process raft request' (duration: 56.961723ms)","trace[510988270] 'compare' (duration: 70.410247ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:56.009784Z","caller":"traceutil/trace.go:171","msg":"trace[1394380355] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"128.200499ms","start":"2026-04-13T17:11:55.881558Z","end":"2026-04-13T17:11:56.009759Z","steps":["trace[1394380355] 'process raft request' (duration: 127.041431ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:56.068883Z","caller":"traceutil/trace.go:171","msg":"trace[2100260100] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"135.83521ms","start":"2026-04-13T17:11:55.933016Z","end":"2026-04-13T17:11:56.068851Z","steps":["trace[2100260100] 'process raft request' (duration: 135.664646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.068997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.499608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.069095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.105342ms","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":"info","ts":"2026-04-13T17:11:56.069106Z","caller":"traceutil/trace.go:171","msg":"trace[1747974890] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"154.628051ms","start":"2026-04-13T17:11:55.914457Z","end":"2026-04-13T17:11:56.069085Z","steps":["trace[1747974890] 'agreement among raft nodes before linearized reading' (duration: 154.357474ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:56.069142Z","caller":"traceutil/trace.go:171","msg":"trace[1360359466] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"155.176014ms","start":"2026-04-13T17:11:55.913952Z","end":"2026-04-13T17:11:56.069128Z","steps":["trace[1360359466] 'agreement among raft nodes before linearized reading' (duration: 155.113673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.068932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.892387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.06938Z","caller":"traceutil/trace.go:171","msg":"trace[1071874549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"155.368239ms","start":"2026-04-13T17:11:55.913995Z","end":"2026-04-13T17:11:56.069363Z","steps":["trace[1071874549] 'agreement among raft nodes before linearized reading' (duration: 154.833475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.069011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.258381ms","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-04-13T17:11:56.069531Z","caller":"traceutil/trace.go:171","msg":"trace[1754756584] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:627; }","duration":"178.805764ms","start":"2026-04-13T17:11:55.890712Z","end":"2026-04-13T17:11:56.069518Z","steps":["trace[1754756584] 'agreement among raft nodes before linearized reading' (duration: 178.241369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.069642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.990365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T17:11:56.069686Z","caller":"traceutil/trace.go:171","msg":"trace[1237637934] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"142.101268ms","start":"2026-04-13T17:11:55.927573Z","end":"2026-04-13T17:11:56.069674Z","steps":["trace[1237637934] 'agreement among raft nodes before linearized reading' (duration: 141.858322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.581102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335593542,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:11:56.881669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.67724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:11:56.88175Z","caller":"traceutil/trace.go:171","msg":"trace[560068497] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"801.117029ms","start":"2026-04-13T17:11:56.080621Z","end":"2026-04-13T17:11:56.881738Z","steps":["trace[560068497] 'read index received' (duration: 602.257945ms)","trace[560068497] 'applied index is now lower than readState.Index' (duration: 198.858054ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:56.882047Z","caller":"traceutil/trace.go:171","msg":"trace[1066854812] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"804.107133ms","start":"2026-04-13T17:11:56.077893Z","end":"2026-04-13T17:11:56.882Z","steps":["trace[1066854812] 'process raft request' (duration: 605.020044ms)","trace[1066854812] 'compare' (duration: 198.556716ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:11:56.882097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.985066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.882134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.129288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.882174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.399022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.882174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.077869Z","time spent":"804.247377ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:11:56.882212Z","caller":"traceutil/trace.go:171","msg":"trace[1114059551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:628; }","duration":"766.457544ms","start":"2026-04-13T17:11:56.115739Z","end":"2026-04-13T17:11:56.882197Z","steps":["trace[1114059551] 'agreement among raft nodes before linearized reading' (duration: 766.396123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.251158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882196Z","caller":"traceutil/trace.go:171","msg":"trace[1117329627] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"801.092728ms","start":"2026-04-13T17:11:56.08106Z","end":"2026-04-13T17:11:56.882153Z","steps":["trace[1117329627] 'agreement among raft nodes before linearized reading' (duration: 800.951385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.115717Z","time spent":"766.514995ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-13T17:11:56.882247Z","caller":"traceutil/trace.go:171","msg":"trace[635035384] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"800.381591ms","start":"2026-04-13T17:11:56.081853Z","end":"2026-04-13T17:11:56.882235Z","steps":["trace[635035384] 'agreement among raft nodes before linearized reading' (duration: 800.260358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.88228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.081827Z","time spent":"800.447052ms","remote":"127.0.0.1:42344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:56.882276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.081053Z","time spent":"801.205321ms","remote":"127.0.0.1:42344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T17:11:56.882293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.493965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882356Z","caller":"traceutil/trace.go:171","msg":"trace[1800177684] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:628; }","duration":"766.600738ms","start":"2026-04-13T17:11:56.115739Z","end":"2026-04-13T17:11:56.88234Z","steps":["trace[1800177684] 'agreement among raft nodes before linearized reading' (duration: 766.401163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.399968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882448Z","caller":"traceutil/trace.go:171","msg":"trace[890231793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"737.441249ms","start":"2026-04-13T17:11:56.145Z","end":"2026-04-13T17:11:56.882441Z","steps":["trace[890231793] 'agreement among raft nodes before linearized reading' (duration: 737.410999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.144914Z","time spent":"737.548002ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:56.882472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.115721Z","time spent":"766.71999ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:56.882489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.512827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882526Z","caller":"traceutil/trace.go:171","msg":"trace[147038719] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"700.545838ms","start":"2026-04-13T17:11:56.181966Z","end":"2026-04-13T17:11:56.882512Z","steps":["trace[147038719] 'agreement among raft nodes before linearized reading' (duration: 700.484137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.550959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882572Z","caller":"traceutil/trace.go:171","msg":"trace[1697227750] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"718.63893ms","start":"2026-04-13T17:11:56.163927Z","end":"2026-04-13T17:11:56.882566Z","steps":["trace[1697227750] 'agreement among raft nodes before linearized reading' (duration: 718.600149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.901582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.88259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.778747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.882604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.16384Z","time spent":"718.742403ms","remote":"127.0.0.1:42380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T17:11:56.882589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.181924Z","time spent":"700.644851ms","remote":"127.0.0.1:42396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-13T17:11:56.882616Z","caller":"traceutil/trace.go:171","msg":"trace[578959751] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"699.968604ms","start":"2026-04-13T17:11:56.182632Z","end":"2026-04-13T17:11:56.882601Z","steps":["trace[578959751] 'agreement among raft nodes before linearized reading' (duration: 699.897653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.182621Z","time spent":"700.023065ms","remote":"127.0.0.1:42396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:56.882526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.859446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:11:56.882397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.301096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882707Z","caller":"traceutil/trace.go:171","msg":"trace[2079275078] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"737.665775ms","start":"2026-04-13T17:11:56.145036Z","end":"2026-04-13T17:11:56.882702Z","steps":["trace[2079275078] 'agreement among raft nodes before linearized reading' (duration: 737.341837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.88273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.144995Z","time spent":"737.727366ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-13T17:11:56.882609Z","caller":"traceutil/trace.go:171","msg":"trace[61238407] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:628; }","duration":"765.849518ms","start":"2026-04-13T17:11:56.116754Z","end":"2026-04-13T17:11:56.882603Z","steps":["trace[61238407] 'agreement among raft nodes before linearized reading' (duration: 765.808007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.699832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882212Z","caller":"traceutil/trace.go:171","msg":"trace[505052764] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"718.232531ms","start":"2026-04-13T17:11:56.163948Z","end":"2026-04-13T17:11:56.88218Z","steps":["trace[505052764] 'agreement among raft nodes before linearized reading' (duration: 718.120728ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:56.882785Z","caller":"traceutil/trace.go:171","msg":"trace[1144238500] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"700.737443ms","start":"2026-04-13T17:11:56.182044Z","end":"2026-04-13T17:11:56.882781Z","steps":["trace[1144238500] 'agreement among raft nodes before linearized reading' (duration: 700.709572ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:56.882689Z","caller":"traceutil/trace.go:171","msg":"trace[1027344831] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"717.065691ms","start":"2026-04-13T17:11:56.165617Z","end":"2026-04-13T17:11:56.882683Z","steps":["trace[1027344831] 'agreement among raft nodes before linearized reading' (duration: 716.863066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.182031Z","time spent":"700.767294ms","remote":"127.0.0.1:42396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:56.882815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.16557Z","time spent":"717.235235ms","remote":"127.0.0.1:42368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:56.882769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.116727Z","time spent":"766.027273ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-13T17:11:56.882823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.163931Z","time spent":"718.872406ms","remote":"127.0.0.1:42380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:56.882404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.295503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.882939Z","caller":"traceutil/trace.go:171","msg":"trace[574354524] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"801.842827ms","start":"2026-04-13T17:11:56.081088Z","end":"2026-04-13T17:11:56.882931Z","steps":["trace[574354524] 'agreement among raft nodes before linearized reading' (duration: 801.286594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.882965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.081085Z","time spent":"801.871248ms","remote":"127.0.0.1:42344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:11:56.882142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.475108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:11:56.883666Z","caller":"traceutil/trace.go:171","msg":"trace[1613489855] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:628; }","duration":"803.037647ms","start":"2026-04-13T17:11:56.080586Z","end":"2026-04-13T17:11:56.883624Z","steps":["trace[1613489855] 'agreement among raft nodes before linearized reading' (duration: 801.294794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:56.883751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:11:56.080573Z","time spent":"803.142209ms","remote":"127.0.0.1:51312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-13T17:11:58.181764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.441406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:11:58.181892Z","caller":"traceutil/trace.go:171","msg":"trace[553332077] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"274.626596ms","start":"2026-04-13T17:11:57.907247Z","end":"2026-04-13T17:11:58.181873Z","steps":["trace[553332077] 'read index received' (duration: 29.821µs)","trace[553332077] 'applied index is now lower than readState.Index' (duration: 274.595515ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:11:58.181961Z","caller":"traceutil/trace.go:171","msg":"trace[554838094] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"282.00404ms","start":"2026-04-13T17:11:57.899948Z","end":"2026-04-13T17:11:58.181952Z","steps":["trace[554838094] 'compare' (duration: 279.2141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:58.182321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.040086ms","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-04-13T17:11:58.182412Z","caller":"traceutil/trace.go:171","msg":"trace[557028000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"275.172239ms","start":"2026-04-13T17:11:57.907216Z","end":"2026-04-13T17:11:58.182388Z","steps":["trace[557028000] 'agreement among raft nodes before linearized reading' (duration: 274.788859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:58.198008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.952327ms","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-04-13T17:11:58.198114Z","caller":"traceutil/trace.go:171","msg":"trace[681778396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"183.111862ms","start":"2026-04-13T17:11:58.014977Z","end":"2026-04-13T17:11:58.198088Z","steps":["trace[681778396] 'agreement among raft nodes before linearized reading' (duration: 182.839694ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:11:58.198152Z","caller":"traceutil/trace.go:171","msg":"trace[1029573761] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"277.19332ms","start":"2026-04-13T17:11:57.920892Z","end":"2026-04-13T17:11:58.198085Z","steps":["trace[1029573761] 'process raft request' (duration: 276.780029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:11:58.198296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.741193ms","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-04-13T17:11:58.198434Z","caller":"traceutil/trace.go:171","msg":"trace[1521127390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"174.921687ms","start":"2026-04-13T17:11:58.023495Z","end":"2026-04-13T17:11:58.198416Z","steps":["trace[1521127390] 'agreement among raft nodes before linearized reading' (duration: 174.669131ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:12.768744Z","caller":"traceutil/trace.go:171","msg":"trace[1355963383] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"117.655692ms","start":"2026-04-13T17:12:12.651061Z","end":"2026-04-13T17:12:12.768717Z","steps":["trace[1355963383] 'process raft request' (duration: 117.406166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:14.825746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.440529ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T17:12:14.825914Z","caller":"traceutil/trace.go:171","msg":"trace[1922942968] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"543.265774ms","start":"2026-04-13T17:12:14.28261Z","end":"2026-04-13T17:12:14.825875Z","steps":["trace[1922942968] 'read index received' (duration: 34.558499ms)","trace[1922942968] 'applied index is now lower than readState.Index' (duration: 508.705565ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:12:14.8262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.583832ms","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-04-13T17:12:14.82624Z","caller":"traceutil/trace.go:171","msg":"trace[1937000790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"543.677264ms","start":"2026-04-13T17:12:14.28255Z","end":"2026-04-13T17:12:14.826227Z","steps":["trace[1937000790] 'agreement among raft nodes before linearized reading' (duration: 543.471879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:14.826288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:14.282525Z","time spent":"543.750625ms","remote":"127.0.0.1:51048","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-04-13T17:12:14.826281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.09964ms","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-04-13T17:12:14.826354Z","caller":"traceutil/trace.go:171","msg":"trace[1416479597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:795; }","duration":"543.242064ms","start":"2026-04-13T17:12:14.283093Z","end":"2026-04-13T17:12:14.826335Z","steps":["trace[1416479597] 'agreement among raft nodes before linearized reading' (duration: 542.985348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:14.826396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:14.283062Z","time spent":"543.327025ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:12:14.826413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.45788ms","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-04-13T17:12:14.826516Z","caller":"traceutil/trace.go:171","msg":"trace[266005013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:795; }","duration":"382.630824ms","start":"2026-04-13T17:12:14.443862Z","end":"2026-04-13T17:12:14.826492Z","steps":["trace[266005013] 'agreement among raft nodes before linearized reading' (duration: 382.308486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:14.826504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.306905ms","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-04-13T17:12:14.826574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:14.443835Z","time spent":"382.727126ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T17:12:14.826624Z","caller":"traceutil/trace.go:171","msg":"trace[228231188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"537.48172ms","start":"2026-04-13T17:12:14.289107Z","end":"2026-04-13T17:12:14.826589Z","steps":["trace[228231188] 'agreement among raft nodes before linearized reading' (duration: 537.132802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:14.826699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:14.28908Z","time spent":"537.603863ms","remote":"127.0.0.1:51048","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-04-13T17:12:50.290041Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.000333813s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T17:12:50.372386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082658436s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-13T17:12:50.37276Z","caller":"traceutil/trace.go:171","msg":"trace[1248954543] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1038; }","duration":"1.199464418s","start":"2026-04-13T17:12:49.173276Z","end":"2026-04-13T17:12:50.37274Z","steps":["trace[1248954543] 'read index received' (duration: 116.431422ms)","trace[1248954543] 'applied index is now lower than readState.Index' (duration: 1.083031906s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:12:50.372835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.065457Z","time spent":"1.307374387s","remote":"127.0.0.1:50846","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-13T17:12:50.37302Z","caller":"traceutil/trace.go:171","msg":"trace[206732084] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"1.303990823s","start":"2026-04-13T17:12:49.069Z","end":"2026-04-13T17:12:50.37299Z","steps":["trace[206732084] 'process raft request' (duration: 1.303710206s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:50.373027Z","caller":"traceutil/trace.go:171","msg":"trace[668521617] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"1.305144792s","start":"2026-04-13T17:12:49.067849Z","end":"2026-04-13T17:12:50.372994Z","steps":["trace[668521617] 'process raft request' (duration: 1.304816984s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:50.373177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.068988Z","time spent":"1.304107616s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:50.373204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.06782Z","time spent":"1.305286786s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:50.373222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19994733s","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-04-13T17:12:50.373262Z","caller":"traceutil/trace.go:171","msg":"trace[2135766735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"1.200029222s","start":"2026-04-13T17:12:49.173222Z","end":"2026-04-13T17:12:50.373251Z","steps":["trace[2135766735] 'agreement among raft nodes before linearized reading' (duration: 1.199826747s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:50.373286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.173199Z","time spent":"1.200081452s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T17:12:50.373363Z","caller":"traceutil/trace.go:171","msg":"trace[343824113] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"1.305502991s","start":"2026-04-13T17:12:49.067851Z","end":"2026-04-13T17:12:50.373354Z","steps":["trace[343824113] 'process raft request' (duration: 1.304692531s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:50.373408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.067826Z","time spent":"1.305555902s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:50.873484Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594335,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:12:51.249203Z","caller":"traceutil/trace.go:171","msg":"trace[1364736352] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"1.523617908s","start":"2026-04-13T17:12:49.72556Z","end":"2026-04-13T17:12:51.249178Z","steps":["trace[1364736352] 'process raft request' (duration: 1.523564137s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:51.249234Z","caller":"traceutil/trace.go:171","msg":"trace[1353796795] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"1.7600599s","start":"2026-04-13T17:12:49.489156Z","end":"2026-04-13T17:12:51.249216Z","steps":["trace[1353796795] 'process raft request' (duration: 1.759795073s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:51.249359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.48913Z","time spent":"1.760149611s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:51.249361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.725536Z","time spent":"1.52374151s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:12:51.308553Z","caller":"traceutil/trace.go:171","msg":"trace[1318560986] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1042; }","duration":"935.746689ms","start":"2026-04-13T17:12:50.372791Z","end":"2026-04-13T17:12:51.308538Z","steps":["trace[1318560986] 'read index received' (duration: 876.19799ms)","trace[1318560986] 'applied index is now lower than readState.Index' (duration: 59.547719ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:12:51.308637Z","caller":"traceutil/trace.go:171","msg":"trace[1989751809] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"930.195541ms","start":"2026-04-13T17:12:50.378398Z","end":"2026-04-13T17:12:51.308594Z","steps":["trace[1989751809] 'process raft request' (duration: 930.066877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:51.308707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.488526316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:12:51.308751Z","caller":"traceutil/trace.go:171","msg":"trace[1951950884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"1.488625078s","start":"2026-04-13T17:12:49.820116Z","end":"2026-04-13T17:12:51.308741Z","steps":["trace[1951950884] 'agreement among raft nodes before linearized reading' (duration: 1.488543526s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:51.30879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.820093Z","time spent":"1.48868734s","remote":"127.0.0.1:50818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T17:12:51.308556Z","caller":"traceutil/trace.go:171","msg":"trace[952462042] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"933.486043ms","start":"2026-04-13T17:12:50.375042Z","end":"2026-04-13T17:12:51.308528Z","steps":["trace[952462042] 'process raft request' (duration: 918.908101ms)","trace[952462042] 'compare' (duration: 14.387937ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:12:51.308838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:50.378379Z","time spent":"930.340645ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:51.308925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:50.375012Z","time spent":"933.827101ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:12:51.308931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016004335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:12:51.308991Z","caller":"traceutil/trace.go:171","msg":"trace[716143707] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1011; }","duration":"2.016113048s","start":"2026-04-13T17:12:49.292863Z","end":"2026-04-13T17:12:51.308976Z","steps":["trace[716143707] 'agreement among raft nodes before linearized reading' (duration: 2.015985095s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:51.309036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:49.292837Z","time spent":"2.01618615s","remote":"127.0.0.1:50940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:12:51.309068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.036771ms","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-04-13T17:12:51.309098Z","caller":"traceutil/trace.go:171","msg":"trace[1155973681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1011; }","duration":"240.110653ms","start":"2026-04-13T17:12:51.068979Z","end":"2026-04-13T17:12:51.30909Z","steps":["trace[1155973681] 'agreement among raft nodes before linearized reading' (duration: 239.98999ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:52.593001Z","caller":"traceutil/trace.go:171","msg":"trace[273018431] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"210.125099ms","start":"2026-04-13T17:12:52.382851Z","end":"2026-04-13T17:12:52.592976Z","steps":["trace[273018431] 'process raft request' (duration: 209.920974ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:52.593279Z","caller":"traceutil/trace.go:171","msg":"trace[970836726] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"210.304643ms","start":"2026-04-13T17:12:52.382958Z","end":"2026-04-13T17:12:52.593263Z","steps":["trace[970836726] 'process raft request' (duration: 209.975015ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:59.650788Z","caller":"traceutil/trace.go:171","msg":"trace[1285561153] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"162.68178ms","start":"2026-04-13T17:12:59.488074Z","end":"2026-04-13T17:12:59.650756Z","steps":["trace[1285561153] 'process raft request' (duration: 160.453235ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:01.481208Z","caller":"traceutil/trace.go:171","msg":"trace[927485503] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"104.025304ms","start":"2026-04-13T17:13:01.377158Z","end":"2026-04-13T17:13:01.481183Z","steps":["trace[927485503] 'process raft request' (duration: 103.855059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:03.923867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.620993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:03.923971Z","caller":"traceutil/trace.go:171","msg":"trace[576971435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1051; }","duration":"103.775577ms","start":"2026-04-13T17:13:03.820165Z","end":"2026-04-13T17:13:03.923941Z","steps":["trace[576971435] 'range keys from in-memory index tree' (duration: 103.494269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:05.345359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.955592ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T17:13:05.345601Z","caller":"traceutil/trace.go:171","msg":"trace[1888896452] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"685.706573ms","start":"2026-04-13T17:13:04.659875Z","end":"2026-04-13T17:13:05.345582Z","steps":["trace[1888896452] 'read index received' (duration: 366.444054ms)","trace[1888896452] 'applied index is now lower than readState.Index' (duration: 319.261129ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:05.345753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.870027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:13:05.345789Z","caller":"traceutil/trace.go:171","msg":"trace[1233215430] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1051; }","duration":"685.96781ms","start":"2026-04-13T17:13:04.659812Z","end":"2026-04-13T17:13:05.34578Z","steps":["trace[1233215430] 'agreement among raft nodes before linearized reading' (duration: 685.887718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:05.345826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:04.659785Z","time spent":"686.030741ms","remote":"127.0.0.1:50932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:13:05.345965Z","caller":"traceutil/trace.go:171","msg":"trace[467558722] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"134.688996ms","start":"2026-04-13T17:13:05.211237Z","end":"2026-04-13T17:13:05.345926Z","steps":["trace[467558722] 'process raft request' (duration: 134.246406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:05.416156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.399465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:05.416204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.221993ms","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-04-13T17:13:05.416223Z","caller":"traceutil/trace.go:171","msg":"trace[27494024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1052; }","duration":"594.516318ms","start":"2026-04-13T17:13:04.821689Z","end":"2026-04-13T17:13:05.416205Z","steps":["trace[27494024] 'agreement among raft nodes before linearized reading' (duration: 524.215512ms)","trace[27494024] 'range keys from in-memory index tree' (duration: 70.201564ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:05.416257Z","caller":"traceutil/trace.go:171","msg":"trace[582378123] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1052; }","duration":"555.325145ms","start":"2026-04-13T17:13:04.860915Z","end":"2026-04-13T17:13:05.41624Z","steps":["trace[582378123] 'agreement among raft nodes before linearized reading' (duration: 484.965017ms)","trace[582378123] 'range keys from in-memory index tree' (duration: 70.151473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:05.41627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:04.821663Z","time spent":"594.595679ms","remote":"127.0.0.1:50818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:13:05.416306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:04.860879Z","time spent":"555.416557ms","remote":"127.0.0.1:51048","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-04-13T17:13:05.416358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.58441ms","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-04-13T17:13:05.416475Z","caller":"traceutil/trace.go:171","msg":"trace[3145837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"570.812915ms","start":"2026-04-13T17:13:04.845638Z","end":"2026-04-13T17:13:05.416451Z","steps":["trace[3145837] 'agreement among raft nodes before linearized reading' (duration: 500.257043ms)","trace[3145837] 'range keys from in-memory index tree' (duration: 70.229234ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:05.416367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.331537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-13T17:13:05.416578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:04.845611Z","time spent":"570.957449ms","remote":"127.0.0.1:51048","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-04-13T17:13:05.416586Z","caller":"traceutil/trace.go:171","msg":"trace[1915731540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"723.613684ms","start":"2026-04-13T17:13:04.692955Z","end":"2026-04-13T17:13:05.416568Z","steps":["trace[1915731540] 'agreement among raft nodes before linearized reading' (duration: 652.916528ms)","trace[1915731540] 'range keys from in-memory index tree' (duration: 70.316187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:05.41663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:04.692927Z","time spent":"723.691116ms","remote":"127.0.0.1:51048","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-04-13T17:13:05.527436Z","caller":"traceutil/trace.go:171","msg":"trace[161785550] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"108.278269ms","start":"2026-04-13T17:13:05.419105Z","end":"2026-04-13T17:13:05.527383Z","steps":["trace[161785550] 'process raft request' (duration: 108.055344ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:05.654014Z","caller":"traceutil/trace.go:171","msg":"trace[936754936] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"233.662067ms","start":"2026-04-13T17:13:05.420326Z","end":"2026-04-13T17:13:05.653988Z","steps":["trace[936754936] 'process raft request' (duration: 233.614456ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:05.654061Z","caller":"traceutil/trace.go:171","msg":"trace[529187016] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"234.046976ms","start":"2026-04-13T17:13:05.419991Z","end":"2026-04-13T17:13:05.654038Z","steps":["trace[529187016] 'process raft request' (duration: 233.79592ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:05.710573Z","caller":"traceutil/trace.go:171","msg":"trace[1745863539] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"126.246559ms","start":"2026-04-13T17:13:05.584295Z","end":"2026-04-13T17:13:05.710542Z","steps":["trace[1745863539] 'process raft request' (duration: 125.600064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:06.063609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.98679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T17:13:06.063684Z","caller":"traceutil/trace.go:171","msg":"trace[700571453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1057; }","duration":"301.121613ms","start":"2026-04-13T17:13:05.762544Z","end":"2026-04-13T17:13:06.063665Z","steps":["trace[700571453] 'range keys from in-memory index tree' (duration: 300.775535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:06.06372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:05.762518Z","time spent":"301.193775ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T17:13:06.205387Z","caller":"traceutil/trace.go:171","msg":"trace[445824806] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"137.117097ms","start":"2026-04-13T17:13:06.068247Z","end":"2026-04-13T17:13:06.205364Z","steps":["trace[445824806] 'process raft request' (duration: 136.969023ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:10.356163Z","caller":"traceutil/trace.go:171","msg":"trace[117026587] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"120.841428ms","start":"2026-04-13T17:13:10.235299Z","end":"2026-04-13T17:13:10.35614Z","steps":["trace[117026587] 'process raft request' (duration: 120.725995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:12.075985Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594499,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:12.576924Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594499,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:13.077482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594499,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:13.132056Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.64374858s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T17:13:13.132549Z","caller":"traceutil/trace.go:171","msg":"trace[1349405503] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"1.644329896s","start":"2026-04-13T17:13:11.488193Z","end":"2026-04-13T17:13:13.132523Z","steps":["trace[1349405503] 'process raft request' (duration: 1.64407476s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.132722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.488164Z","time spent":"1.644470039s","remote":"127.0.0.1:51048","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-04-13T17:13:13.543594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.599194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:13.54369Z","caller":"traceutil/trace.go:171","msg":"trace[575770298] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1110; }","duration":"1.968019873s","start":"2026-04-13T17:13:11.575644Z","end":"2026-04-13T17:13:13.543664Z","steps":["trace[575770298] 'read index received' (duration: 1.55655187s)","trace[575770298] 'applied index is now lower than readState.Index' (duration: 411.466253ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:13.54372Z","caller":"traceutil/trace.go:171","msg":"trace[888231089] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"1.678864183s","start":"2026-04-13T17:13:11.864819Z","end":"2026-04-13T17:13:13.543683Z","steps":["trace[888231089] 'process raft request' (duration: 1.386104985s)","trace[888231089] 'compare' (duration: 292.302887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:13.543856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.968213438s","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-04-13T17:13:13.543891Z","caller":"traceutil/trace.go:171","msg":"trace[240672888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1073; }","duration":"1.96830041s","start":"2026-04-13T17:13:11.575581Z","end":"2026-04-13T17:13:13.543881Z","steps":["trace[240672888] 'agreement among raft nodes before linearized reading' (duration: 1.968159617s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.543886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.771446047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-13T17:13:13.543897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.864795Z","time spent":"1.679001327s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:13.543923Z","caller":"traceutil/trace.go:171","msg":"trace[364485065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1073; }","duration":"1.77152791s","start":"2026-04-13T17:13:11.772385Z","end":"2026-04-13T17:13:13.543913Z","steps":["trace[364485065] 'agreement among raft nodes before linearized reading' (duration: 1.771385355s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.543923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.575558Z","time spent":"1.968356812s","remote":"127.0.0.1:51048","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-04-13T17:13:13.543961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.520427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:13.543993Z","caller":"traceutil/trace.go:171","msg":"trace[1894942144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"273.579918ms","start":"2026-04-13T17:13:13.270401Z","end":"2026-04-13T17:13:13.543981Z","steps":["trace[1894942144] 'agreement among raft nodes before linearized reading' (duration: 273.538077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.544009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.240725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T17:13:13.543909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184471994s","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-04-13T17:13:13.544034Z","caller":"traceutil/trace.go:171","msg":"trace[1803434574] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1073; }","duration":"465.309596ms","start":"2026-04-13T17:13:13.078717Z","end":"2026-04-13T17:13:13.544026Z","steps":["trace[1803434574] 'agreement among raft nodes before linearized reading' (duration: 465.253585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.544013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.295696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:13.544056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.078693Z","time spent":"465.357888ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:13:13.544054Z","caller":"traceutil/trace.go:171","msg":"trace[1864370846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1073; }","duration":"1.184657819s","start":"2026-04-13T17:13:12.359382Z","end":"2026-04-13T17:13:13.54404Z","steps":["trace[1864370846] 'agreement among raft nodes before linearized reading' (duration: 1.184461073s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:13.544074Z","caller":"traceutil/trace.go:171","msg":"trace[1320601994] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1073; }","duration":"443.392988ms","start":"2026-04-13T17:13:13.100664Z","end":"2026-04-13T17:13:13.544057Z","steps":["trace[1320601994] 'agreement among raft nodes before linearized reading' (duration: 443.290576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.544093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:12.359362Z","time spent":"1.18472017s","remote":"127.0.0.1:51048","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-04-13T17:13:13.544125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.100652Z","time spent":"443.45996ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:13.544186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.680251038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-13T17:13:13.544155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.628705082s","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-04-13T17:13:13.544245Z","caller":"traceutil/trace.go:171","msg":"trace[1357650130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1073; }","duration":"1.68036073s","start":"2026-04-13T17:13:11.863868Z","end":"2026-04-13T17:13:13.544228Z","steps":["trace[1357650130] 'agreement among raft nodes before linearized reading' (duration: 1.680216197s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.544243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26291667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:13.544282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.863843Z","time spent":"1.680430552s","remote":"127.0.0.1:51048","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-04-13T17:13:13.544289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.724240299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:13.54429Z","caller":"traceutil/trace.go:171","msg":"trace[298939816] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1073; }","duration":"1.263007542s","start":"2026-04-13T17:13:12.281267Z","end":"2026-04-13T17:13:13.544275Z","steps":["trace[298939816] 'agreement among raft nodes before linearized reading' (duration: 1.262935811s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:13.544284Z","caller":"traceutil/trace.go:171","msg":"trace[651072778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1073; }","duration":"1.628896727s","start":"2026-04-13T17:13:11.915359Z","end":"2026-04-13T17:13:13.544256Z","steps":["trace[651072778] 'agreement among raft nodes before linearized reading' (duration: 1.628511897s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:13.544323Z","caller":"traceutil/trace.go:171","msg":"trace[283903048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"1.72431397s","start":"2026-04-13T17:13:11.82Z","end":"2026-04-13T17:13:13.544314Z","steps":["trace[283903048] 'agreement among raft nodes before linearized reading' (duration: 1.724265319s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:13.544333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:12.281245Z","time spent":"1.263076445s","remote":"127.0.0.1:42228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:13.544324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.772364Z","time spent":"1.771931069s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:13:13.544354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.819974Z","time spent":"1.724373791s","remote":"127.0.0.1:50818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:13:13.544367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:11.915338Z","time spent":"1.629011s","remote":"127.0.0.1:51048","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-04-13T17:13:14.148933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:14.649633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:15.150271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:15.341198Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.790370151s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T17:13:16.465898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124368709s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:16.466027Z","caller":"traceutil/trace.go:171","msg":"trace[1449392108] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"2.915262263s","start":"2026-04-13T17:13:13.550745Z","end":"2026-04-13T17:13:16.466007Z","steps":["trace[1449392108] 'process raft request' (duration: 1.790659658s)","trace[1449392108] 'compare' (duration: 1.123054986s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:16.466089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.550726Z","time spent":"2.915330814s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:16.570164Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.228823874s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T17:13:16.818387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999898097s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-13T17:13:16.818509Z","caller":"traceutil/trace.go:171","msg":"trace[460439775] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00003781s","start":"2026-04-13T17:13:14.818448Z","end":"2026-04-13T17:13:16.818486Z","steps":["trace[460439775] 'agreement among raft nodes before linearized reading' (duration: 1.999895527s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:16.818565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:14.818374Z","time spent":"2.000179614s","remote":"127.0.0.1:50818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:13:18.548321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.551443Z","time spent":"4.996869905s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-13T17:13:18.548388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.550855Z","time spent":"4.997524931s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/13 17:13:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" 2026/04/13 17:13:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T17:13:18.548618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.550935Z","time spent":"4.997680794s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/13 17:13:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T17:13:18.729439Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.158940843s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-13T17:13:18.819581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000383338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T17:13:18.819678Z","caller":"traceutil/trace.go:171","msg":"trace[109452463] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000485531s","start":"2026-04-13T17:13:16.819162Z","end":"2026-04-13T17:13:18.819647Z","steps":["trace[109452463] 'agreement among raft nodes before linearized reading' (duration: 2.000379358s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:18.819749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:16.819113Z","time spent":"2.000625804s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 17:13:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T17:13:18.828595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.258083986s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:18.829136Z","caller":"traceutil/trace.go:171","msg":"trace[1044031921] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"5.278122201s","start":"2026-04-13T17:13:13.550995Z","end":"2026-04-13T17:13:18.829117Z","steps":["trace[1044031921] 'process raft request' (duration: 5.278035569s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:18.829809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.550987Z","time spent":"5.278772846s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:19.153564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.329434ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T17:13:19.15384Z","caller":"traceutil/trace.go:171","msg":"trace[456860213] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1112; }","duration":"5.504888219s","start":"2026-04-13T17:13:13.648892Z","end":"2026-04-13T17:13:19.15378Z","steps":["trace[456860213] 'read index received' (duration: 1.692528659s)","trace[456860213] 'applied index is now lower than readState.Index' (duration: 3.81235567s)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:19.153979Z","caller":"traceutil/trace.go:171","msg":"trace[1718650519] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"3.538945476s","start":"2026-04-13T17:13:15.615025Z","end":"2026-04-13T17:13:19.15397Z","steps":["trace[1718650519] 'process raft request' (duration: 3.538793293s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:19.153937Z","caller":"traceutil/trace.go:171","msg":"trace[1273236942] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"330.068925ms","start":"2026-04-13T17:13:18.823833Z","end":"2026-04-13T17:13:19.153902Z","steps":["trace[1273236942] 'process raft request' (duration: 330.026474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:15.614996Z","time spent":"3.539025719s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:19.154147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.412844179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:19.154199Z","caller":"traceutil/trace.go:171","msg":"trace[247878810] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1081; }","duration":"5.412955892s","start":"2026-04-13T17:13:13.741229Z","end":"2026-04-13T17:13:19.154185Z","steps":["trace[247878810] 'agreement among raft nodes before linearized reading' (duration: 5.412839989s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.505263778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T17:13:19.154351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.180494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:13:19.154366Z","caller":"traceutil/trace.go:171","msg":"trace[1971023608] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1081; }","duration":"5.505503003s","start":"2026-04-13T17:13:13.648839Z","end":"2026-04-13T17:13:19.154342Z","steps":["trace[1971023608] 'agreement among raft nodes before linearized reading' (duration: 5.505141595s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:19.154443Z","caller":"traceutil/trace.go:171","msg":"trace[1299046227] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1081; }","duration":"718.307577ms","start":"2026-04-13T17:13:18.436104Z","end":"2026-04-13T17:13:19.154412Z","steps":["trace[1299046227] 'agreement among raft nodes before linearized reading' (duration: 718.194524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.648816Z","time spent":"5.505648277s","remote":"127.0.0.1:51188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.154533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:18.43608Z","time spent":"718.43487ms","remote":"127.0.0.1:42404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.154533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.172836431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T17:13:19.154515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.170839113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:19.154161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:18.823809Z","time spent":"330.25713ms","remote":"127.0.0.1:50898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:13:19.154662Z","caller":"traceutil/trace.go:171","msg":"trace[1148912665] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1081; }","duration":"4.172993355s","start":"2026-04-13T17:13:14.981621Z","end":"2026-04-13T17:13:19.154615Z","steps":["trace[1148912665] 'agreement among raft nodes before linearized reading' (duration: 4.17278598s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:19.154707Z","caller":"traceutil/trace.go:171","msg":"trace[1612133568] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1081; }","duration":"4.170993877s","start":"2026-04-13T17:13:14.983643Z","end":"2026-04-13T17:13:19.154637Z","steps":["trace[1612133568] 'agreement among raft nodes before linearized reading' (duration: 4.170701509s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:14.981598Z","time spent":"4.173142968s","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.154852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:14.983606Z","time spent":"4.171183701s","remote":"127.0.0.1:51006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.154874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.877639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.179\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T17:13:19.154987Z","caller":"traceutil/trace.go:171","msg":"trace[810851270] range","detail":"{range_begin:/registry/masterleases/199.19.213.179; range_end:; response_count:1; response_revision:1081; }","duration":"116.974121ms","start":"2026-04-13T17:13:19.03798Z","end":"2026-04-13T17:13:19.154954Z","steps":["trace[810851270] 'agreement among raft nodes before linearized reading' (duration: 116.667474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.155007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.434215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:19.154362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.362130681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:19.154988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.50463218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:19.15514Z","caller":"traceutil/trace.go:171","msg":"trace[135405835] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1081; }","duration":"2.362936141s","start":"2026-04-13T17:13:16.792179Z","end":"2026-04-13T17:13:19.155115Z","steps":["trace[135405835] 'agreement among raft nodes before linearized reading' (duration: 2.362156731s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:13.741212Z","time spent":"5.413026693s","remote":"127.0.0.1:42240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:13:19.155162Z","caller":"traceutil/trace.go:171","msg":"trace[501977794] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1081; }","duration":"2.505057661s","start":"2026-04-13T17:13:16.650088Z","end":"2026-04-13T17:13:19.155146Z","steps":["trace[501977794] 'agreement among raft nodes before linearized reading' (duration: 2.504438145s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.1552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:16.792153Z","time spent":"2.363028753s","remote":"127.0.0.1:35948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.155233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.416656149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:19.15525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:16.650062Z","time spent":"2.505159154s","remote":"127.0.0.1:51096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:13:19.15507Z","caller":"traceutil/trace.go:171","msg":"trace[1831546240] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1081; }","duration":"348.542489ms","start":"2026-04-13T17:13:18.806511Z","end":"2026-04-13T17:13:19.155053Z","steps":["trace[1831546240] 'agreement among raft nodes before linearized reading' (duration: 348.444105ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:19.153967Z","caller":"traceutil/trace.go:171","msg":"trace[248103097] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"3.603167863s","start":"2026-04-13T17:13:15.550774Z","end":"2026-04-13T17:13:19.153942Z","steps":["trace[248103097] 'process raft request' (duration: 3.602905276s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.155326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:18.806485Z","time spent":"348.829026ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.155415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:15.55074Z","time spent":"3.604617499s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:19.155281Z","caller":"traceutil/trace.go:171","msg":"trace[684516106] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1081; }","duration":"4.416760131s","start":"2026-04-13T17:13:14.738509Z","end":"2026-04-13T17:13:19.155269Z","steps":["trace[684516106] 'agreement among raft nodes before linearized reading' (duration: 4.416679799s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.154506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.777559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:19.155506Z","caller":"traceutil/trace.go:171","msg":"trace[1163654632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1081; }","duration":"326.877096ms","start":"2026-04-13T17:13:18.828619Z","end":"2026-04-13T17:13:19.155496Z","steps":["trace[1163654632] 'agreement among raft nodes before linearized reading' (duration: 325.723937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.155515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:14.73848Z","time spent":"4.417013657s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:13:19.155538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:18.828594Z","time spent":"326.935218ms","remote":"127.0.0.1:50818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:13:19.155581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.557993ms","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-04-13T17:13:19.155628Z","caller":"traceutil/trace.go:171","msg":"trace[2120261389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1081; }","duration":"685.647665ms","start":"2026-04-13T17:13:18.46997Z","end":"2026-04-13T17:13:19.155618Z","steps":["trace[2120261389] 'agreement among raft nodes before linearized reading' (duration: 685.496902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.155667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:18.469947Z","time spent":"685.712747ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:13:19.917934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.647048ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-13T17:13:19.91821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:19.157195Z","time spent":"761.007747ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-13T17:13:19.918267Z","caller":"traceutil/trace.go:171","msg":"trace[1228660894] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"760.376971ms","start":"2026-04-13T17:13:19.157825Z","end":"2026-04-13T17:13:19.918202Z","steps":["trace[1228660894] 'read index received' (duration: 249.455336ms)","trace[1228660894] 'applied index is now lower than readState.Index' (duration: 510.917305ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:19.918226Z","caller":"traceutil/trace.go:171","msg":"trace[522723222] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"758.323591ms","start":"2026-04-13T17:13:19.159882Z","end":"2026-04-13T17:13:19.918206Z","steps":["trace[522723222] 'process raft request' (duration: 758.183548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.91858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.696029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:19.91859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:19.159859Z","time spent":"758.627808ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:19.918749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.648594ms","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-04-13T17:13:19.918653Z","caller":"traceutil/trace.go:171","msg":"trace[2091522331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"760.843203ms","start":"2026-04-13T17:13:19.157791Z","end":"2026-04-13T17:13:19.918634Z","steps":["trace[2091522331] 'agreement among raft nodes before linearized reading' (duration: 760.643108ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:19.918837Z","caller":"traceutil/trace.go:171","msg":"trace[1925114382] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1082; }","duration":"542.809518ms","start":"2026-04-13T17:13:19.375984Z","end":"2026-04-13T17:13:19.918793Z","steps":["trace[1925114382] 'agreement among raft nodes before linearized reading' (duration: 542.664075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:19.918944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:19.157771Z","time spent":"761.039798ms","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T17:13:19.918918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:19.375962Z","time spent":"542.932592ms","remote":"127.0.0.1:42148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-13T17:13:21.000259Z","caller":"traceutil/trace.go:171","msg":"trace[1521719689] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"446.168476ms","start":"2026-04-13T17:13:20.554062Z","end":"2026-04-13T17:13:21.000231Z","steps":["trace[1521719689] 'process raft request' (duration: 445.994071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:21.000425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:20.554042Z","time spent":"446.302178ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:21.065313Z","caller":"traceutil/trace.go:171","msg":"trace[2123046945] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"510.842223ms","start":"2026-04-13T17:13:20.554443Z","end":"2026-04-13T17:13:21.065285Z","steps":["trace[2123046945] 'process raft request' (duration: 462.558148ms)","trace[2123046945] 'compare' (duration: 48.120101ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:21.065476Z","caller":"traceutil/trace.go:171","msg":"trace[1206156008] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1124; }","duration":"244.626186ms","start":"2026-04-13T17:13:20.82081Z","end":"2026-04-13T17:13:21.065436Z","steps":["trace[1206156008] 'read index received' (duration: 179.313053ms)","trace[1206156008] 'applied index is now lower than readState.Index' (duration: 65.310373ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:21.065524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:20.554423Z","time spent":"510.970416ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:21.065622Z","caller":"traceutil/trace.go:171","msg":"trace[2067798732] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"511.138831ms","start":"2026-04-13T17:13:20.554465Z","end":"2026-04-13T17:13:21.065604Z","steps":["trace[2067798732] 'process raft request' (duration: 510.778351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:21.065718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:20.554448Z","time spent":"511.225873ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:21.065799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.972566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:21.065892Z","caller":"traceutil/trace.go:171","msg":"trace[175414453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"245.13019ms","start":"2026-04-13T17:13:20.82075Z","end":"2026-04-13T17:13:21.065881Z","steps":["trace[175414453] 'agreement among raft nodes before linearized reading' (duration: 244.886144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:21.066023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.387326ms","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-04-13T17:13:21.066075Z","caller":"traceutil/trace.go:171","msg":"trace[195184972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"232.481028ms","start":"2026-04-13T17:13:20.833582Z","end":"2026-04-13T17:13:21.066063Z","steps":["trace[195184972] 'agreement among raft nodes before linearized reading' (duration: 232.262723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:21.06619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.138275ms","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-04-13T17:13:21.066295Z","caller":"traceutil/trace.go:171","msg":"trace[337151826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1086; }","duration":"222.315529ms","start":"2026-04-13T17:13:20.843952Z","end":"2026-04-13T17:13:21.066268Z","steps":["trace[337151826] 'agreement among raft nodes before linearized reading' (duration: 222.057983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:21.532025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.544575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:21.532108Z","caller":"traceutil/trace.go:171","msg":"trace[1612635726] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"286.180247ms","start":"2026-04-13T17:13:21.245911Z","end":"2026-04-13T17:13:21.532091Z","steps":["trace[1612635726] 'read index received' (duration: 65.508509ms)","trace[1612635726] 'applied index is now lower than readState.Index' (duration: 220.670318ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:21.532156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.243898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:21.532179Z","caller":"traceutil/trace.go:171","msg":"trace[684378713] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1088; }","duration":"286.30877ms","start":"2026-04-13T17:13:21.245865Z","end":"2026-04-13T17:13:21.532174Z","steps":["trace[684378713] 'agreement among raft nodes before linearized reading' (duration: 286.262889ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:21.532235Z","caller":"traceutil/trace.go:171","msg":"trace[1977709003] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"370.342734ms","start":"2026-04-13T17:13:21.161863Z","end":"2026-04-13T17:13:21.532206Z","steps":["trace[1977709003] 'process raft request' (duration: 149.544342ms)","trace[1977709003] 'compare' (duration: 220.399892ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:21.532456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:21.161826Z","time spent":"370.493897ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:23.198293Z","caller":"traceutil/trace.go:171","msg":"trace[852259965] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"129.084719ms","start":"2026-04-13T17:13:23.069183Z","end":"2026-04-13T17:13:23.198268Z","steps":["trace[852259965] 'read index received' (duration: 128.831183ms)","trace[852259965] 'applied index is now lower than readState.Index' (duration: 252.226µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:23.198456Z","caller":"traceutil/trace.go:171","msg":"trace[1043287350] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"191.469031ms","start":"2026-04-13T17:13:23.006951Z","end":"2026-04-13T17:13:23.19842Z","steps":["trace[1043287350] 'process raft request' (duration: 191.131493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:23.198762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.590811ms","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-04-13T17:13:23.198817Z","caller":"traceutil/trace.go:171","msg":"trace[1857901222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"129.714415ms","start":"2026-04-13T17:13:23.069088Z","end":"2026-04-13T17:13:23.198803Z","steps":["trace[1857901222] 'agreement among raft nodes before linearized reading' (duration: 129.531591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:23.198996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.415018ms","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-04-13T17:13:23.199079Z","caller":"traceutil/trace.go:171","msg":"trace[238750481] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1090; }","duration":"129.53348ms","start":"2026-04-13T17:13:23.069526Z","end":"2026-04-13T17:13:23.199059Z","steps":["trace[238750481] 'agreement among raft nodes before linearized reading' (duration: 129.322795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:23.199285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.618778ms","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-04-13T17:13:23.199329Z","caller":"traceutil/trace.go:171","msg":"trace[1003001758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"108.69365ms","start":"2026-04-13T17:13:23.090623Z","end":"2026-04-13T17:13:23.199316Z","steps":["trace[1003001758] 'agreement among raft nodes before linearized reading' (duration: 108.575867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:23.420687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.241351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:23.420938Z","caller":"traceutil/trace.go:171","msg":"trace[466255738] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"217.562592ms","start":"2026-04-13T17:13:23.203354Z","end":"2026-04-13T17:13:23.420917Z","steps":["trace[466255738] 'process raft request' (duration: 217.519091ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:23.421071Z","caller":"traceutil/trace.go:171","msg":"trace[458741552] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"217.701825ms","start":"2026-04-13T17:13:23.203353Z","end":"2026-04-13T17:13:23.421055Z","steps":["trace[458741552] 'process raft request' (duration: 217.458139ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:23.421104Z","caller":"traceutil/trace.go:171","msg":"trace[386611607] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"218.450444ms","start":"2026-04-13T17:13:23.202605Z","end":"2026-04-13T17:13:23.421055Z","steps":["trace[386611607] 'process raft request' (duration: 71.751463ms)","trace[386611607] 'compare' (duration: 146.049695ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:23.455418Z","caller":"traceutil/trace.go:171","msg":"trace[2039181903] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"175.990772ms","start":"2026-04-13T17:13:23.279396Z","end":"2026-04-13T17:13:23.455387Z","steps":["trace[2039181903] 'process raft request' (duration: 175.826918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:35.977726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594744,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:36.412772Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.165350215s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T17:13:36.413149Z","caller":"traceutil/trace.go:171","msg":"trace[2061120858] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"1.165766605s","start":"2026-04-13T17:13:35.247358Z","end":"2026-04-13T17:13:36.413125Z","steps":["trace[2061120858] 'process raft request' (duration: 1.165601991s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:36.413269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.247342Z","time spent":"1.165858827s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:36.847Z","caller":"traceutil/trace.go:171","msg":"trace[1753878739] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1227; }","duration":"1.369983119s","start":"2026-04-13T17:13:35.476986Z","end":"2026-04-13T17:13:36.846969Z","steps":["trace[1753878739] 'read index received' (duration: 936.025584ms)","trace[1753878739] 'applied index is now lower than readState.Index' (duration: 433.956285ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:36.847056Z","caller":"traceutil/trace.go:171","msg":"trace[1659541215] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"1.230189267s","start":"2026-04-13T17:13:35.616839Z","end":"2026-04-13T17:13:36.847028Z","steps":["trace[1659541215] 'process raft request' (duration: 1.215272601s)","trace[1659541215] 'compare' (duration: 14.730651ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:36.847191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.616815Z","time spent":"1.230297459s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:13:36.847263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.437581ms","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":"warn","ts":"2026-04-13T17:13:36.847254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370252826s","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-04-13T17:13:36.847299Z","caller":"traceutil/trace.go:171","msg":"trace[1131442950] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1183; }","duration":"178.507573ms","start":"2026-04-13T17:13:36.668782Z","end":"2026-04-13T17:13:36.84729Z","steps":["trace[1131442950] 'agreement among raft nodes before linearized reading' (duration: 178.436381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:36.847299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304700927s","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-04-13T17:13:36.84732Z","caller":"traceutil/trace.go:171","msg":"trace[589779543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1183; }","duration":"1.370359518s","start":"2026-04-13T17:13:35.476944Z","end":"2026-04-13T17:13:36.847304Z","steps":["trace[589779543] 'agreement among raft nodes before linearized reading' (duration: 1.370156994s)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:36.847335Z","caller":"traceutil/trace.go:171","msg":"trace[233969717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1183; }","duration":"1.304750708s","start":"2026-04-13T17:13:35.542571Z","end":"2026-04-13T17:13:36.847322Z","steps":["trace[233969717] 'agreement among raft nodes before linearized reading' (duration: 1.304599404s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:36.847366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.476925Z","time spent":"1.37043463s","remote":"127.0.0.1:51048","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-04-13T17:13:36.84737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.542502Z","time spent":"1.30485984s","remote":"127.0.0.1:51048","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-04-13T17:13:36.847483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.448494ms","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-04-13T17:13:36.847504Z","caller":"traceutil/trace.go:171","msg":"trace[1888023499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1183; }","duration":"859.491244ms","start":"2026-04-13T17:13:35.988007Z","end":"2026-04-13T17:13:36.847498Z","steps":["trace[1888023499] 'agreement among raft nodes before linearized reading' (duration: 859.434383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:36.84751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229154991s","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-04-13T17:13:36.847532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.987994Z","time spent":"859.534045ms","remote":"127.0.0.1:51048","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-04-13T17:13:36.84754Z","caller":"traceutil/trace.go:171","msg":"trace[522017662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1183; }","duration":"1.229215883s","start":"2026-04-13T17:13:35.618316Z","end":"2026-04-13T17:13:36.847532Z","steps":["trace[522017662] 'agreement among raft nodes before linearized reading' (duration: 1.229139701s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:36.847564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:35.618302Z","time spent":"1.229255734s","remote":"127.0.0.1:51048","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-04-13T17:13:50.978225Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335594863,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:13:51.085181Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.105340211s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T17:13:51.085591Z","caller":"traceutil/trace.go:171","msg":"trace[196973447] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"1.105818683s","start":"2026-04-13T17:13:49.979747Z","end":"2026-04-13T17:13:51.085566Z","steps":["trace[196973447] 'process raft request' (duration: 1.105630308s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.085737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:49.979727Z","time spent":"1.105921386s","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:51.098525Z","caller":"traceutil/trace.go:171","msg":"trace[1348004547] linearizableReadLoop","detail":"{readStateIndex:1278; appliedIndex:1276; }","duration":"621.06686ms","start":"2026-04-13T17:13:50.477426Z","end":"2026-04-13T17:13:51.098493Z","steps":["trace[1348004547] 'read index received' (duration: 607.962518ms)","trace[1348004547] 'applied index is now lower than readState.Index' (duration: 13.102682ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:51.098724Z","caller":"traceutil/trace.go:171","msg":"trace[471556262] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"191.042971ms","start":"2026-04-13T17:13:50.907634Z","end":"2026-04-13T17:13:51.098677Z","steps":["trace[471556262] 'process raft request' (duration: 190.653772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.098803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.459341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:51.098857Z","caller":"traceutil/trace.go:171","msg":"trace[1245203958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1229; }","duration":"279.553824ms","start":"2026-04-13T17:13:50.819281Z","end":"2026-04-13T17:13:51.098835Z","steps":["trace[1245203958] 'agreement among raft nodes before linearized reading' (duration: 279.423701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.099012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.573082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T17:13:51.099137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.932529ms","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-04-13T17:13:51.099173Z","caller":"traceutil/trace.go:171","msg":"trace[1689006021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1229; }","duration":"167.009702ms","start":"2026-04-13T17:13:50.932155Z","end":"2026-04-13T17:13:51.099165Z","steps":["trace[1689006021] 'agreement among raft nodes before linearized reading' (duration: 166.914959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.099275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.66013ms","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-04-13T17:13:51.099298Z","caller":"traceutil/trace.go:171","msg":"trace[1364143195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1229; }","duration":"172.734422ms","start":"2026-04-13T17:13:50.926558Z","end":"2026-04-13T17:13:51.099293Z","steps":["trace[1364143195] 'agreement among raft nodes before linearized reading' (duration: 172.674851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.099133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.350147ms","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-04-13T17:13:51.099293Z","caller":"traceutil/trace.go:171","msg":"trace[235187303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1229; }","duration":"621.678774ms","start":"2026-04-13T17:13:50.477384Z","end":"2026-04-13T17:13:51.099063Z","steps":["trace[235187303] 'agreement among raft nodes before linearized reading' (duration: 621.270565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:51.099462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:50.477367Z","time spent":"622.074935ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T17:13:51.099642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.469491ms","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-04-13T17:13:51.099694Z","caller":"traceutil/trace.go:171","msg":"trace[261923514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1229; }","duration":"114.571473ms","start":"2026-04-13T17:13:50.985109Z","end":"2026-04-13T17:13:51.099681Z","steps":["trace[261923514] 'agreement among raft nodes before linearized reading' (duration: 114.346678ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:51.100426Z","caller":"traceutil/trace.go:171","msg":"trace[1299302514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1229; }","duration":"114.755328ms","start":"2026-04-13T17:13:50.984666Z","end":"2026-04-13T17:13:51.099421Z","steps":["trace[1299302514] 'agreement among raft nodes before linearized reading' (duration: 114.115182ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:53.288616Z","caller":"traceutil/trace.go:171","msg":"trace[833642791] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1283; }","duration":"152.885465ms","start":"2026-04-13T17:13:53.135694Z","end":"2026-04-13T17:13:53.288579Z","steps":["trace[833642791] 'read index received' (duration: 152.497446ms)","trace[833642791] 'applied index is now lower than readState.Index' (duration: 386.509µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:53.289288Z","caller":"traceutil/trace.go:171","msg":"trace[1068245054] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"183.151807ms","start":"2026-04-13T17:13:53.106109Z","end":"2026-04-13T17:13:53.289261Z","steps":["trace[1068245054] 'process raft request' (duration: 182.194844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:53.289779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.062883ms","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-04-13T17:13:53.289854Z","caller":"traceutil/trace.go:171","msg":"trace[913441449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1235; }","duration":"154.194927ms","start":"2026-04-13T17:13:53.135642Z","end":"2026-04-13T17:13:53.289837Z","steps":["trace[913441449] 'agreement among raft nodes before linearized reading' (duration: 153.960441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:53.290679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.167957ms","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-04-13T17:13:53.290744Z","caller":"traceutil/trace.go:171","msg":"trace[1899537785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1235; }","duration":"128.288951ms","start":"2026-04-13T17:13:53.16244Z","end":"2026-04-13T17:13:53.290729Z","steps":["trace[1899537785] 'agreement among raft nodes before linearized reading' (duration: 128.125567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:53.291809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.436404ms","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-04-13T17:13:53.291872Z","caller":"traceutil/trace.go:171","msg":"trace[735616409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1235; }","duration":"128.515966ms","start":"2026-04-13T17:13:53.16334Z","end":"2026-04-13T17:13:53.291856Z","steps":["trace[735616409] 'agreement among raft nodes before linearized reading' (duration: 128.353692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:53.293077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.967482ms","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-04-13T17:13:53.293154Z","caller":"traceutil/trace.go:171","msg":"trace[717832120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1235; }","duration":"130.065924ms","start":"2026-04-13T17:13:53.163069Z","end":"2026-04-13T17:13:53.293135Z","steps":["trace[717832120] 'agreement among raft nodes before linearized reading' (duration: 129.871739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:53.293549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.149007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T17:13:53.293598Z","caller":"traceutil/trace.go:171","msg":"trace[2079550996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1235; }","duration":"130.230128ms","start":"2026-04-13T17:13:53.163353Z","end":"2026-04-13T17:13:53.293583Z","steps":["trace[2079550996] 'agreement among raft nodes before linearized reading' (duration: 130.116635ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:53.439433Z","caller":"traceutil/trace.go:171","msg":"trace[2134539824] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"140.9254ms","start":"2026-04-13T17:13:53.298439Z","end":"2026-04-13T17:13:53.439399Z","steps":["trace[2134539824] 'process raft request' (duration: 140.837108ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:53.439445Z","caller":"traceutil/trace.go:171","msg":"trace[531585191] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"141.025612ms","start":"2026-04-13T17:13:53.298368Z","end":"2026-04-13T17:13:53.439393Z","steps":["trace[531585191] 'process raft request' (duration: 118.826727ms)","trace[531585191] 'compare' (duration: 22.030661ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:53.439563Z","caller":"traceutil/trace.go:171","msg":"trace[154214139] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"140.988951ms","start":"2026-04-13T17:13:53.29854Z","end":"2026-04-13T17:13:53.439529Z","steps":["trace[154214139] 'process raft request' (duration: 140.794287ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:53.44131Z","caller":"traceutil/trace.go:171","msg":"trace[1372326150] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"141.825983ms","start":"2026-04-13T17:13:53.299455Z","end":"2026-04-13T17:13:53.441281Z","steps":["trace[1372326150] 'process raft request' (duration: 141.736501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.695881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.529877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:55.695987Z","caller":"traceutil/trace.go:171","msg":"trace[1756558557] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"305.806288ms","start":"2026-04-13T17:13:55.390162Z","end":"2026-04-13T17:13:55.695968Z","steps":["trace[1756558557] 'process raft request' (duration: 172.118997ms)","trace[1756558557] 'compare' (duration: 133.433845ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:55.696033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:13:55.390145Z","time spent":"305.87111ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:13:55.696112Z","caller":"traceutil/trace.go:171","msg":"trace[833279941] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"252.949371ms","start":"2026-04-13T17:13:55.443157Z","end":"2026-04-13T17:13:55.696107Z","steps":["trace[833279941] 'read index received' (duration: 119.035684ms)","trace[833279941] 'applied index is now lower than readState.Index' (duration: 133.913057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:13:55.696213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.056443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-13T17:13:55.696231Z","caller":"traceutil/trace.go:171","msg":"trace[48296597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1247; }","duration":"253.108396ms","start":"2026-04-13T17:13:55.443118Z","end":"2026-04-13T17:13:55.696227Z","steps":["trace[48296597] 'agreement among raft nodes before linearized reading' (duration: 253.034163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.696272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.047484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-13T17:13:55.696308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.314871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-13T17:13:55.69632Z","caller":"traceutil/trace.go:171","msg":"trace[1199454779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1247; }","duration":"251.346442ms","start":"2026-04-13T17:13:55.44497Z","end":"2026-04-13T17:13:55.696316Z","steps":["trace[1199454779] 'agreement among raft nodes before linearized reading' (duration: 251.309691ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:55.696331Z","caller":"traceutil/trace.go:171","msg":"trace[1555585026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1247; }","duration":"253.139287ms","start":"2026-04-13T17:13:55.44317Z","end":"2026-04-13T17:13:55.696309Z","steps":["trace[1555585026] 'agreement among raft nodes before linearized reading' (duration: 253.006162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.696378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.737016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-13T17:13:55.696468Z","caller":"traceutil/trace.go:171","msg":"trace[886793118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"252.838859ms","start":"2026-04-13T17:13:55.443621Z","end":"2026-04-13T17:13:55.69646Z","steps":["trace[886793118] 'agreement among raft nodes before linearized reading' (duration: 252.730497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.69645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.506431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:13:55.696555Z","caller":"traceutil/trace.go:171","msg":"trace[283484089] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1247; }","duration":"138.682325ms","start":"2026-04-13T17:13:55.557853Z","end":"2026-04-13T17:13:55.696536Z","steps":["trace[283484089] 'agreement among raft nodes before linearized reading' (duration: 138.48046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.945897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.963142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:13:55.94634Z","caller":"traceutil/trace.go:171","msg":"trace[2090281772] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"240.298571ms","start":"2026-04-13T17:13:55.706018Z","end":"2026-04-13T17:13:55.946316Z","steps":["trace[2090281772] 'process raft request' (duration: 109.853988ms)","trace[2090281772] 'compare' (duration: 129.866749ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:55.946219Z","caller":"traceutil/trace.go:171","msg":"trace[1886582163] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"240.173937ms","start":"2026-04-13T17:13:55.706019Z","end":"2026-04-13T17:13:55.946193Z","steps":["trace[1886582163] 'process raft request' (duration: 239.953522ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:55.950399Z","caller":"traceutil/trace.go:171","msg":"trace[1144215476] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1297; }","duration":"238.796484ms","start":"2026-04-13T17:13:55.711591Z","end":"2026-04-13T17:13:55.950388Z","steps":["trace[1144215476] 'read index received' (duration: 104.293841ms)","trace[1144215476] 'applied index is now lower than readState.Index' (duration: 134.502033ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:13:55.950451Z","caller":"traceutil/trace.go:171","msg":"trace[791853183] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"244.235417ms","start":"2026-04-13T17:13:55.706201Z","end":"2026-04-13T17:13:55.950436Z","steps":["trace[791853183] 'process raft request' (duration: 244.137755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:55.95044Z","caller":"traceutil/trace.go:171","msg":"trace[528161519] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"244.305199ms","start":"2026-04-13T17:13:55.70611Z","end":"2026-04-13T17:13:55.950415Z","steps":["trace[528161519] 'process raft request' (duration: 244.183436ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:55.950477Z","caller":"traceutil/trace.go:171","msg":"trace[291024635] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"208.5328ms","start":"2026-04-13T17:13:55.741937Z","end":"2026-04-13T17:13:55.95047Z","steps":["trace[291024635] 'process raft request' (duration: 208.422597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:13:55.95062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.797821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:13:55.950636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.04335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:13:55.950673Z","caller":"traceutil/trace.go:171","msg":"trace[152191369] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1252; }","duration":"141.894253ms","start":"2026-04-13T17:13:55.808763Z","end":"2026-04-13T17:13:55.950657Z","steps":["trace[152191369] 'agreement among raft nodes before linearized reading' (duration: 141.807841ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:55.950672Z","caller":"traceutil/trace.go:171","msg":"trace[2131249129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1252; }","duration":"239.119022ms","start":"2026-04-13T17:13:55.711544Z","end":"2026-04-13T17:13:55.950663Z","steps":["trace[2131249129] 'agreement among raft nodes before linearized reading' (duration: 239.06049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:09.542328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1249359153335595093,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:14:09.62203Z","caller":"traceutil/trace.go:171","msg":"trace[1859558208] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"880.543109ms","start":"2026-04-13T17:14:08.741457Z","end":"2026-04-13T17:14:09.622Z","steps":["trace[1859558208] 'process raft request' (duration: 880.301172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:09.622213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:14:08.741414Z","time spent":"880.702982ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:14:09.627276Z","caller":"traceutil/trace.go:171","msg":"trace[1463053202] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1403; }","duration":"585.724293ms","start":"2026-04-13T17:14:09.041528Z","end":"2026-04-13T17:14:09.627252Z","steps":["trace[1463053202] 'read index received' (duration: 580.238357ms)","trace[1463053202] 'applied index is now lower than readState.Index' (duration: 5.484696ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:14:09.627401Z","caller":"traceutil/trace.go:171","msg":"trace[190000163] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"186.827168ms","start":"2026-04-13T17:14:09.440555Z","end":"2026-04-13T17:14:09.627382Z","steps":["trace[190000163] 'process raft request' (duration: 186.575412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:09.627706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.143254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.179\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T17:14:09.627801Z","caller":"traceutil/trace.go:171","msg":"trace[305658826] range","detail":"{range_begin:/registry/masterleases/199.19.213.179; range_end:; response_count:1; response_revision:1353; }","duration":"586.283698ms","start":"2026-04-13T17:14:09.041497Z","end":"2026-04-13T17:14:09.627781Z","steps":["trace[305658826] 'agreement among raft nodes before linearized reading' (duration: 586.082043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:09.627851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:14:09.041481Z","time spent":"586.36225ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.179\" "} {"level":"warn","ts":"2026-04-13T17:14:09.628221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.336704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:470"} {"level":"info","ts":"2026-04-13T17:14:09.628257Z","caller":"traceutil/trace.go:171","msg":"trace[960380690] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1353; }","duration":"434.408646ms","start":"2026-04-13T17:14:09.193841Z","end":"2026-04-13T17:14:09.62825Z","steps":["trace[960380690] 'agreement among raft nodes before linearized reading' (duration: 433.623726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:09.62828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:14:09.193822Z","time spent":"434.453257ms","remote":"127.0.0.1:51048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":493,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-13T17:14:14.233616Z","caller":"traceutil/trace.go:171","msg":"trace[1899305527] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"100.607509ms","start":"2026-04-13T17:14:14.132977Z","end":"2026-04-13T17:14:14.233584Z","steps":["trace[1899305527] 'process raft request' (duration: 37.426379ms)","trace[1899305527] 'compare' (duration: 62.983825ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:14:23.993776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.279037ms","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-04-13T17:14:23.993895Z","caller":"traceutil/trace.go:171","msg":"trace[1145274172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1418; }","duration":"145.448681ms","start":"2026-04-13T17:14:23.84843Z","end":"2026-04-13T17:14:23.993879Z","steps":["trace[1145274172] 'range keys from in-memory index tree' (duration: 145.074483ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:14:38.260634Z","caller":"traceutil/trace.go:171","msg":"trace[268054116] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"171.270264ms","start":"2026-04-13T17:14:38.089333Z","end":"2026-04-13T17:14:38.260603Z","steps":["trace[268054116] 'read index received' (duration: 170.907174ms)","trace[268054116] 'applied index is now lower than readState.Index' (duration: 361.56µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:14:38.260737Z","caller":"traceutil/trace.go:171","msg":"trace[304324413] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"184.44678ms","start":"2026-04-13T17:14:38.076248Z","end":"2026-04-13T17:14:38.260695Z","steps":["trace[304324413] 'process raft request' (duration: 184.110671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:38.260911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.54997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-13T17:14:38.260992Z","caller":"traceutil/trace.go:171","msg":"trace[1983970540] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1485; }","duration":"171.690464ms","start":"2026-04-13T17:14:38.08928Z","end":"2026-04-13T17:14:38.26097Z","steps":["trace[1983970540] 'agreement among raft nodes before linearized reading' (duration: 171.440778ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:14:56.531281Z","caller":"traceutil/trace.go:171","msg":"trace[506149238] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"110.643769ms","start":"2026-04-13T17:14:56.420582Z","end":"2026-04-13T17:14:56.531225Z","steps":["trace[506149238] 'process raft request' (duration: 110.184577ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:16:37.284608Z","caller":"traceutil/trace.go:171","msg":"trace[1749451689] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"142.213583ms","start":"2026-04-13T17:16:37.142365Z","end":"2026-04-13T17:16:37.284579Z","steps":["trace[1749451689] 'process raft request' (duration: 141.764962ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:16:37.284933Z","caller":"traceutil/trace.go:171","msg":"trace[1398435050] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"141.078894ms","start":"2026-04-13T17:16:37.143814Z","end":"2026-04-13T17:16:37.284893Z","steps":["trace[1398435050] 'process raft request' (duration: 140.725585ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:16:37.285104Z","caller":"traceutil/trace.go:171","msg":"trace[312517673] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"141.256168ms","start":"2026-04-13T17:16:37.143834Z","end":"2026-04-13T17:16:37.28509Z","steps":["trace[312517673] 'process raft request' (duration: 141.127655ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:16:38.466152Z","caller":"traceutil/trace.go:171","msg":"trace[223332022] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"125.823305ms","start":"2026-04-13T17:16:38.340292Z","end":"2026-04-13T17:16:38.466116Z","steps":["trace[223332022] 'process raft request' (duration: 125.604359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:17:09.59091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.71246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-13T17:17:09.591012Z","caller":"traceutil/trace.go:171","msg":"trace[1344889504] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2178; }","duration":"110.886574ms","start":"2026-04-13T17:17:09.480105Z","end":"2026-04-13T17:17:09.590992Z","steps":["trace[1344889504] 'range keys from in-memory index tree' (duration: 110.464693ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:17:32.915143Z","caller":"traceutil/trace.go:171","msg":"trace[175275731] transaction","detail":"{read_only:false; response_revision:2310; number_of_response:1; }","duration":"110.815211ms","start":"2026-04-13T17:17:32.804296Z","end":"2026-04-13T17:17:32.915111Z","steps":["trace[175275731] 'process raft request' (duration: 110.667687ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:17:40.116155Z","caller":"traceutil/trace.go:171","msg":"trace[1476340787] transaction","detail":"{read_only:false; response_revision:2351; number_of_response:1; }","duration":"186.632923ms","start":"2026-04-13T17:17:39.929489Z","end":"2026-04-13T17:17:40.116122Z","steps":["trace[1476340787] 'process raft request' (duration: 105.756915ms)","trace[1476340787] 'compare' (duration: 80.446798ms)"],"step_count":2}