{"level":"warn","ts":"2026-04-24T07:36:00.664407Z","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-24T07:36:00.664517Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-24T07:36:00.664744Z","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-24T07:36:00.664766Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-24T07:36:00.664793Z","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-24T07:36:00.665725Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-04-24T07:36:00.665849Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-24T07:36:00.717379Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"51.215417ms"} {"level":"info","ts":"2026-04-24T07:36:00.868079Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-04-24T07:36:00.868271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-04-24T07:36:00.868308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-04-24T07:36:00.868324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-24T07:36:00.868366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-04-24T07:36:00.868441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-04-24T07:36:00.990173Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-24T07:36:01.003269Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-24T07:36:01.010073Z","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-24T07:36:01.050635Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-24T07:36:01.050754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-24T07:36:01.051024Z","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-24T07:36:01.051149Z","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-24T07:36:01.051164Z","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-24T07:36:01.055507Z","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-24T07:36:01.055643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-04-24T07:36:01.055638Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-24T07:36:01.055667Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-24T07:36:01.055746Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-24T07:36:01.05578Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-24T07:36:01.055831Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-24T07:36:01.071657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-04-24T07:36:01.071713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-24T07:36:01.071746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-04-24T07:36:01.071783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-04-24T07:36:01.071795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-24T07:36:01.071811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-04-24T07:36:01.071824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-24T07:36:01.102188Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T07:36:01.108853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-24T07:36:01.108856Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-04-24T07:36:01.109109Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-24T07:36:01.109432Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-24T07:36:01.109539Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-24T07:36:01.112478Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-24T07:36:01.114229Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T07:36:01.114322Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T07:36:01.114358Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-24T07:36:01.125937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"warn","ts":"2026-04-24T07:36:03.15491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.60591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-24T07:36:03.155055Z","caller":"traceutil/trace.go:171","msg":"trace[2140406149] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"151.759293ms","start":"2026-04-24T07:36:03.003284Z","end":"2026-04-24T07:36:03.155044Z","steps":["trace[2140406149] 'process raft request' (duration: 151.725541ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.155115Z","caller":"traceutil/trace.go:171","msg":"trace[19685792] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"151.780794ms","start":"2026-04-24T07:36:03.003287Z","end":"2026-04-24T07:36:03.155067Z","steps":["trace[19685792] 'read index received' (duration: 49.597473ms)","trace[19685792] 'applied index is now lower than readState.Index' (duration: 102.180851ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:03.155296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.96422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:03.155325Z","caller":"traceutil/trace.go:171","msg":"trace[2147159299] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:4; }","duration":"152.047473ms","start":"2026-04-24T07:36:03.003266Z","end":"2026-04-24T07:36:03.155313Z","steps":["trace[2147159299] 'agreement among raft nodes before linearized reading' (duration: 151.921609ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.155309Z","caller":"traceutil/trace.go:171","msg":"trace[1729845318] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"152.019342ms","start":"2026-04-24T07:36:03.003035Z","end":"2026-04-24T07:36:03.155055Z","steps":["trace[1729845318] 'process raft request' (duration: 49.866543ms)","trace[1729845318] 'compare' (duration: 101.455634ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:03.20905Z","caller":"traceutil/trace.go:171","msg":"trace[2035246877] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"140.080675ms","start":"2026-04-24T07:36:03.068957Z","end":"2026-04-24T07:36:03.209037Z","steps":["trace[2035246877] 'process raft request' (duration: 139.963601ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.20906Z","caller":"traceutil/trace.go:171","msg":"trace[961753379] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"140.23518ms","start":"2026-04-24T07:36:03.068781Z","end":"2026-04-24T07:36:03.209016Z","steps":["trace[961753379] 'process raft request' (duration: 140.117176ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.20916Z","caller":"traceutil/trace.go:171","msg":"trace[1069378063] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"142.098565ms","start":"2026-04-24T07:36:03.067014Z","end":"2026-04-24T07:36:03.209112Z","steps":["trace[1069378063] 'process raft request' (duration: 141.811806ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.209279Z","caller":"traceutil/trace.go:171","msg":"trace[1838858408] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"140.041573ms","start":"2026-04-24T07:36:03.069063Z","end":"2026-04-24T07:36:03.209105Z","steps":["trace[1838858408] 'process raft request' (duration: 139.911169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.209354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.084936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-mr4pg\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-04-24T07:36:03.209403Z","caller":"traceutil/trace.go:171","msg":"trace[806065239] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-mr4pg; range_end:; response_count:1; response_revision:11; }","duration":"205.171519ms","start":"2026-04-24T07:36:03.004212Z","end":"2026-04-24T07:36:03.209383Z","steps":["trace[806065239] 'agreement among raft nodes before linearized reading' (duration: 205.095426ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.209469Z","caller":"traceutil/trace.go:171","msg":"trace[811094362] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"140.498379ms","start":"2026-04-24T07:36:03.068959Z","end":"2026-04-24T07:36:03.209457Z","steps":["trace[811094362] 'process raft request' (duration: 139.982212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.209453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.334934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-24T07:36:03.20954Z","caller":"traceutil/trace.go:171","msg":"trace[738071563] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"205.447829ms","start":"2026-04-24T07:36:03.00407Z","end":"2026-04-24T07:36:03.209518Z","steps":["trace[738071563] 'agreement among raft nodes before linearized reading' (duration: 205.262582ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.209573Z","caller":"traceutil/trace.go:171","msg":"trace[735450755] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"140.570062ms","start":"2026-04-24T07:36:03.068978Z","end":"2026-04-24T07:36:03.209548Z","steps":["trace[735450755] 'process raft request' (duration: 139.979961ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.209489Z","caller":"traceutil/trace.go:171","msg":"trace[718073088] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"134.960826ms","start":"2026-04-24T07:36:03.074511Z","end":"2026-04-24T07:36:03.209472Z","steps":["trace[718073088] 'process raft request' (duration: 134.485899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.209708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.083671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-24T07:36:03.209755Z","caller":"traceutil/trace.go:171","msg":"trace[1044080027] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"123.135133ms","start":"2026-04-24T07:36:03.086603Z","end":"2026-04-24T07:36:03.209738Z","steps":["trace[1044080027] 'agreement among raft nodes before linearized reading' (duration: 123.04247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.209925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.701264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-24T07:36:03.209977Z","caller":"traceutil/trace.go:171","msg":"trace[1871240717] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"178.777207ms","start":"2026-04-24T07:36:03.031192Z","end":"2026-04-24T07:36:03.209969Z","steps":["trace[1871240717] 'agreement among raft nodes before linearized reading' (duration: 178.094074ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.625344Z","caller":"traceutil/trace.go:171","msg":"trace[1543927629] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"416.304117ms","start":"2026-04-24T07:36:03.209018Z","end":"2026-04-24T07:36:03.625322Z","steps":["trace[1543927629] 'read index received' (duration: 405.889874ms)","trace[1543927629] 'applied index is now lower than readState.Index' (duration: 10.413243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:03.625651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.87338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:03.62573Z","caller":"traceutil/trace.go:171","msg":"trace[520099522] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:12; }","duration":"466.001835ms","start":"2026-04-24T07:36:03.15971Z","end":"2026-04-24T07:36:03.625712Z","steps":["trace[520099522] 'agreement among raft nodes before linearized reading' (duration: 465.712874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.625816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.159694Z","time spent":"466.109519ms","remote":"127.0.0.1:52034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-04-24T07:36:03.626008Z","caller":"traceutil/trace.go:171","msg":"trace[616524271] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"469.155634ms","start":"2026-04-24T07:36:03.156213Z","end":"2026-04-24T07:36:03.625369Z","steps":["trace[616524271] 'process raft request' (duration: 458.682709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.626495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.156191Z","time spent":"469.961573ms","remote":"127.0.0.1:52012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:03.693729Z","caller":"traceutil/trace.go:171","msg":"trace[1699695658] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"480.838022ms","start":"2026-04-24T07:36:03.212857Z","end":"2026-04-24T07:36:03.693695Z","steps":["trace[1699695658] 'process raft request' (duration: 480.711948ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.693879Z","caller":"traceutil/trace.go:171","msg":"trace[398421652] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"480.316434ms","start":"2026-04-24T07:36:03.213554Z","end":"2026-04-24T07:36:03.69387Z","steps":["trace[398421652] 'process raft request' (duration: 480.047065ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.693941Z","caller":"traceutil/trace.go:171","msg":"trace[633983378] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"476.663175ms","start":"2026-04-24T07:36:03.217233Z","end":"2026-04-24T07:36:03.693896Z","steps":["trace[633983378] 'process raft request' (duration: 476.437597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.693983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.21354Z","time spent":"480.377456ms","remote":"127.0.0.1:52442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:03.694069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217222Z","time spent":"476.77712ms","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.694087Z","caller":"traceutil/trace.go:171","msg":"trace[147347063] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"476.771579ms","start":"2026-04-24T07:36:03.217291Z","end":"2026-04-24T07:36:03.694063Z","steps":["trace[147347063] 'process raft request' (duration: 476.409276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.694209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217286Z","time spent":"476.858583ms","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.694522Z","caller":"traceutil/trace.go:171","msg":"trace[608517294] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"477.204854ms","start":"2026-04-24T07:36:03.217306Z","end":"2026-04-24T07:36:03.694511Z","steps":["trace[608517294] 'process raft request' (duration: 476.422257ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.69379Z","caller":"traceutil/trace.go:171","msg":"trace[950018569] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"481.194144ms","start":"2026-04-24T07:36:03.212567Z","end":"2026-04-24T07:36:03.693761Z","steps":["trace[950018569] 'process raft request' (duration: 480.880863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.694592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217294Z","time spent":"477.263476ms","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.694678Z","caller":"traceutil/trace.go:171","msg":"trace[1844306930] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"477.329769ms","start":"2026-04-24T07:36:03.217335Z","end":"2026-04-24T07:36:03.694665Z","steps":["trace[1844306930] 'process raft request' (duration: 476.431387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.694741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217313Z","time spent":"477.405071ms","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.693848Z","caller":"traceutil/trace.go:171","msg":"trace[2087042412] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"479.731092ms","start":"2026-04-24T07:36:03.21411Z","end":"2026-04-24T07:36:03.693841Z","steps":["trace[2087042412] 'process raft request' (duration: 479.527895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.69484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.214091Z","time spent":"480.721887ms","remote":"127.0.0.1:52386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:03.694532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.212846Z","time spent":"481.484094ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:03.694973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.212522Z","time spent":"482.099415ms","remote":"127.0.0.1:52040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.695613Z","caller":"traceutil/trace.go:171","msg":"trace[1100571786] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"474.21229ms","start":"2026-04-24T07:36:03.221391Z","end":"2026-04-24T07:36:03.695603Z","steps":["trace[1100571786] 'process raft request' (duration: 473.828317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.695736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.221373Z","time spent":"474.279982ms","remote":"127.0.0.1:52120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:03.696072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.924352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-24T07:36:03.695359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.645709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:03.69612Z","caller":"traceutil/trace.go:171","msg":"trace[662929323] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:22; }","duration":"107.998414ms","start":"2026-04-24T07:36:03.588109Z","end":"2026-04-24T07:36:03.696107Z","steps":["trace[662929323] 'agreement among raft nodes before linearized reading' (duration: 107.887161ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.696156Z","caller":"traceutil/trace.go:171","msg":"trace[1255865825] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:22; }","duration":"479.029308ms","start":"2026-04-24T07:36:03.217108Z","end":"2026-04-24T07:36:03.696138Z","steps":["trace[1255865825] 'agreement among raft nodes before linearized reading' (duration: 478.177448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.696199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.933979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-24T07:36:03.696224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217087Z","time spent":"479.116052ms","remote":"127.0.0.1:52040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-04-24T07:36:03.696226Z","caller":"traceutil/trace.go:171","msg":"trace[325619470] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:22; }","duration":"426.98542ms","start":"2026-04-24T07:36:03.269231Z","end":"2026-04-24T07:36:03.696216Z","steps":["trace[325619470] 'agreement among raft nodes before linearized reading' (duration: 426.947589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.696253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.269213Z","time spent":"427.033232ms","remote":"127.0.0.1:52050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-04-24T07:36:03.695472Z","caller":"traceutil/trace.go:171","msg":"trace[771616270] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"477.824416ms","start":"2026-04-24T07:36:03.217636Z","end":"2026-04-24T07:36:03.69546Z","steps":["trace[771616270] 'process raft request' (duration: 476.835432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.696348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:03.217629Z","time spent":"478.679416ms","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:03.883772Z","caller":"traceutil/trace.go:171","msg":"trace[817738091] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"255.59352ms","start":"2026-04-24T07:36:03.628006Z","end":"2026-04-24T07:36:03.883599Z","steps":["trace[817738091] 'process raft request' (duration: 178.203246ms)","trace[817738091] 'compare' (duration: 77.262989ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:03.90141Z","caller":"traceutil/trace.go:171","msg":"trace[173506657] linearizableReadLoop","detail":"{readStateIndex:33; appliedIndex:25; }","duration":"148.216029ms","start":"2026-04-24T07:36:03.753176Z","end":"2026-04-24T07:36:03.901392Z","steps":["trace[173506657] 'read index received' (duration: 53.043384ms)","trace[173506657] 'applied index is now lower than readState.Index' (duration: 95.171915ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:03.901533Z","caller":"traceutil/trace.go:171","msg":"trace[748822353] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"200.578288ms","start":"2026-04-24T07:36:03.700928Z","end":"2026-04-24T07:36:03.901506Z","steps":["trace[748822353] 'process raft request' (duration: 200.413062ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.901634Z","caller":"traceutil/trace.go:171","msg":"trace[788799184] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"201.903014ms","start":"2026-04-24T07:36:03.69972Z","end":"2026-04-24T07:36:03.901623Z","steps":["trace[788799184] 'process raft request' (duration: 201.587193ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.901678Z","caller":"traceutil/trace.go:171","msg":"trace[425668674] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"200.086039ms","start":"2026-04-24T07:36:03.701583Z","end":"2026-04-24T07:36:03.901669Z","steps":["trace[425668674] 'process raft request' (duration: 199.777289ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.901707Z","caller":"traceutil/trace.go:171","msg":"trace[1315281223] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"201.997897ms","start":"2026-04-24T07:36:03.69968Z","end":"2026-04-24T07:36:03.901678Z","steps":["trace[1315281223] 'process raft request' (duration: 201.595343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:03.901886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.702495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:03.901877Z","caller":"traceutil/trace.go:171","msg":"trace[2034899301] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"201.240361ms","start":"2026-04-24T07:36:03.700603Z","end":"2026-04-24T07:36:03.901843Z","steps":["trace[2034899301] 'process raft request' (duration: 200.718662ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.90192Z","caller":"traceutil/trace.go:171","msg":"trace[1516753304] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:30; }","duration":"148.792869ms","start":"2026-04-24T07:36:03.75312Z","end":"2026-04-24T07:36:03.901913Z","steps":["trace[1516753304] 'agreement among raft nodes before linearized reading' (duration: 148.669685ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.901604Z","caller":"traceutil/trace.go:171","msg":"trace[371855944] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"202.670551ms","start":"2026-04-24T07:36:03.69877Z","end":"2026-04-24T07:36:03.901441Z","steps":["trace[371855944] 'process raft request' (duration: 202.346009ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:03.90187Z","caller":"traceutil/trace.go:171","msg":"trace[771407736] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"202.281336ms","start":"2026-04-24T07:36:03.699559Z","end":"2026-04-24T07:36:03.901841Z","steps":["trace[771407736] 'process raft request' (duration: 201.692696ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.093626Z","caller":"traceutil/trace.go:171","msg":"trace[2112352848] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"121.508403ms","start":"2026-04-24T07:36:03.972103Z","end":"2026-04-24T07:36:04.09361Z","steps":["trace[2112352848] 'read index received' (duration: 778.177µs)","trace[2112352848] 'applied index is now lower than readState.Index' (duration: 120.727856ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:04.093627Z","caller":"traceutil/trace.go:171","msg":"trace[525268875] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"123.006785ms","start":"2026-04-24T07:36:03.970594Z","end":"2026-04-24T07:36:04.0936Z","steps":["trace[525268875] 'process raft request' (duration: 52.87899ms)","trace[525268875] 'compare' (duration: 69.942448ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:04.093819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.69892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:04.093911Z","caller":"traceutil/trace.go:171","msg":"trace[1146060280] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:43; }","duration":"121.803923ms","start":"2026-04-24T07:36:03.972099Z","end":"2026-04-24T07:36:04.093903Z","steps":["trace[1146060280] 'agreement among raft nodes before linearized reading' (duration: 121.631728ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.094005Z","caller":"traceutil/trace.go:171","msg":"trace[1995092686] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"117.493453ms","start":"2026-04-24T07:36:03.976502Z","end":"2026-04-24T07:36:04.093996Z","steps":["trace[1995092686] 'process raft request' (duration: 117.064358ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.31775Z","caller":"traceutil/trace.go:171","msg":"trace[1937782594] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"152.12519ms","start":"2026-04-24T07:36:04.165607Z","end":"2026-04-24T07:36:04.317733Z","steps":["trace[1937782594] 'process raft request' (duration: 142.466355ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.318224Z","caller":"traceutil/trace.go:171","msg":"trace[1749347284] linearizableReadLoop","detail":"{readStateIndex:56; appliedIndex:54; }","duration":"151.671703ms","start":"2026-04-24T07:36:04.166539Z","end":"2026-04-24T07:36:04.318211Z","steps":["trace[1749347284] 'read index received' (duration: 141.577644ms)","trace[1749347284] 'applied index is now lower than readState.Index' (duration: 10.093489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:04.318333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.775797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:04.318341Z","caller":"traceutil/trace.go:171","msg":"trace[678511554] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"151.848031ms","start":"2026-04-24T07:36:04.166198Z","end":"2026-04-24T07:36:04.318046Z","steps":["trace[678511554] 'process raft request' (duration: 151.505719ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.318423Z","caller":"traceutil/trace.go:171","msg":"trace[214693114] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"151.804858ms","start":"2026-04-24T07:36:04.166611Z","end":"2026-04-24T07:36:04.318416Z","steps":["trace[214693114] 'process raft request' (duration: 151.393944ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.318363Z","caller":"traceutil/trace.go:171","msg":"trace[197711467] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:53; }","duration":"151.831309ms","start":"2026-04-24T07:36:04.166524Z","end":"2026-04-24T07:36:04.318356Z","steps":["trace[197711467] 'agreement among raft nodes before linearized reading' (duration: 151.739986ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.480891Z","caller":"traceutil/trace.go:171","msg":"trace[856928152] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"109.975032ms","start":"2026-04-24T07:36:04.370871Z","end":"2026-04-24T07:36:04.480846Z","steps":["trace[856928152] 'process raft request' (duration: 99.669285ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.480938Z","caller":"traceutil/trace.go:171","msg":"trace[793323717] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"109.584309ms","start":"2026-04-24T07:36:04.371329Z","end":"2026-04-24T07:36:04.480913Z","steps":["trace[793323717] 'process raft request' (duration: 109.416153ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.481721Z","caller":"traceutil/trace.go:171","msg":"trace[1460789183] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"110.331464ms","start":"2026-04-24T07:36:04.371366Z","end":"2026-04-24T07:36:04.481697Z","steps":["trace[1460789183] 'process raft request' (duration: 109.433623ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:04.482245Z","caller":"traceutil/trace.go:171","msg":"trace[1845409304] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"110.476909ms","start":"2026-04-24T07:36:04.371508Z","end":"2026-04-24T07:36:04.481985Z","steps":["trace[1845409304] 'process raft request' (duration: 109.3368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:05.059935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.258595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-24T07:36:05.060094Z","caller":"traceutil/trace.go:171","msg":"trace[1613417242] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"427.694474ms","start":"2026-04-24T07:36:04.632368Z","end":"2026-04-24T07:36:05.060063Z","steps":["trace[1613417242] 'process raft request' (duration: 167.221922ms)","trace[1613417242] 'compare' (duration: 260.118759ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:05.060197Z","caller":"traceutil/trace.go:171","msg":"trace[925374212] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"425.313492ms","start":"2026-04-24T07:36:04.634862Z","end":"2026-04-24T07:36:05.060175Z","steps":["trace[925374212] 'process raft request' (duration: 425.278881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:05.060234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:04.632354Z","time spent":"427.824518ms","remote":"127.0.0.1:52440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:05.060293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:04.634852Z","time spent":"425.403395ms","remote":"127.0.0.1:52344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":600,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:05.060222Z","caller":"traceutil/trace.go:171","msg":"trace[1229908588] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"426.442542ms","start":"2026-04-24T07:36:04.633752Z","end":"2026-04-24T07:36:05.060195Z","steps":["trace[1229908588] 'process raft request' (duration: 426.313648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:05.060403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:04.633734Z","time spent":"426.623227ms","remote":"127.0.0.1:52440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:05.060433Z","caller":"traceutil/trace.go:171","msg":"trace[834845115] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"428.008785ms","start":"2026-04-24T07:36:04.632395Z","end":"2026-04-24T07:36:05.060404Z","steps":["trace[834845115] 'read index received' (duration: 33.631µs)","trace[834845115] 'applied index is now lower than readState.Index' (duration: 427.973594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:05.060535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.136259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a93ac77ab27e15\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-04-24T07:36:05.060577Z","caller":"traceutil/trace.go:171","msg":"trace[726067232] range","detail":"{range_begin:/registry/events/default/instance.18a93ac77ab27e15; range_end:; response_count:1; response_revision:74; }","duration":"428.201291ms","start":"2026-04-24T07:36:04.632357Z","end":"2026-04-24T07:36:05.060558Z","steps":["trace[726067232] 'agreement among raft nodes before linearized reading' (duration: 428.130329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:05.060612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:04.63234Z","time spent":"428.265874ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":677,"request content":"key:\"/registry/events/default/instance.18a93ac77ab27e15\" "} {"level":"warn","ts":"2026-04-24T07:36:05.606084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219121274823534561,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-24T07:36:07.105666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999930832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-24T07:36:07.105749Z","caller":"traceutil/trace.go:171","msg":"trace[310645605] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000062507s","start":"2026-04-24T07:36:05.105669Z","end":"2026-04-24T07:36:07.105731Z","steps":["trace[310645605] 'agreement among raft nodes before linearized reading' (duration: 1.999961014s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:07.105808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:05.105648Z","time spent":"2.000149319s","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/24 07:36:07 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-24T07:36:07.325324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518056122s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-24T07:36:07.325449Z","caller":"traceutil/trace.go:171","msg":"trace[1715936490] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"2.262036534s","start":"2026-04-24T07:36:05.063395Z","end":"2026-04-24T07:36:07.325432Z","steps":["trace[1715936490] 'process raft request' (duration: 743.778635ms)","trace[1715936490] 'compare' (duration: 1.517948039s)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:07.325507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:05.06338Z","time spent":"2.262098156s","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:07.868795Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.061583753s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-24T07:36:08.321187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99995662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-24T07:36:08.321262Z","caller":"traceutil/trace.go:171","msg":"trace[1998947130] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000082554s","start":"2026-04-24T07:36:06.321162Z","end":"2026-04-24T07:36:08.321245Z","steps":["trace[1998947130] 'agreement among raft nodes before linearized reading' (duration: 1.999989161s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.321303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:06.321142Z","time spent":"2.000152676s","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/24 07:36:08 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-24T07:36:08.685478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.389102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-24T07:36:08.685677Z","caller":"traceutil/trace.go:171","msg":"trace[1485833679] linearizableReadLoop","detail":"{readStateIndex:82; appliedIndex:78; }","duration":"3.579952709s","start":"2026-04-24T07:36:05.105708Z","end":"2026-04-24T07:36:08.685661Z","steps":["trace[1485833679] 'read index received' (duration: 701.477807ms)","trace[1485833679] 'applied index is now lower than readState.Index' (duration: 2.878474002s)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:08.68582Z","caller":"traceutil/trace.go:171","msg":"trace[1621413154] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"3.622260647s","start":"2026-04-24T07:36:05.063547Z","end":"2026-04-24T07:36:08.685808Z","steps":["trace[1621413154] 'process raft request' (duration: 2.805451481s)","trace[1621413154] 'compare' (duration: 816.285938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:08.685877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:05.063528Z","time spent":"3.622323128s","remote":"127.0.0.1:52442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":622,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:08.686316Z","caller":"traceutil/trace.go:171","msg":"trace[1200037992] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"3.618099004s","start":"2026-04-24T07:36:05.068201Z","end":"2026-04-24T07:36:08.6863Z","steps":["trace[1200037992] 'process raft request' (duration: 3.61736212s)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:08.686341Z","caller":"traceutil/trace.go:171","msg":"trace[128270274] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"3.618034721s","start":"2026-04-24T07:36:05.068288Z","end":"2026-04-24T07:36:08.686322Z","steps":["trace[128270274] 'process raft request' (duration: 3.617329118s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.686453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:05.068283Z","time spent":"3.618111794s","remote":"127.0.0.1:52440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1088,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:08.687062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:05.06819Z","time spent":"3.618163925s","remote":"127.0.0.1:52344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:08.697086Z","caller":"traceutil/trace.go:171","msg":"trace[720383285] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"2.152755414s","start":"2026-04-24T07:36:06.544314Z","end":"2026-04-24T07:36:08.697069Z","steps":["trace[720383285] 'process raft request' (duration: 2.152601609s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.697369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:06.544291Z","time spent":"2.153025892s","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:08.697196Z","caller":"traceutil/trace.go:171","msg":"trace[1987344016] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"1.23819559s","start":"2026-04-24T07:36:07.45898Z","end":"2026-04-24T07:36:08.697175Z","steps":["trace[1987344016] 'process raft request' (duration: 1.238023774s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.697579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:07.458959Z","time spent":"1.238537911s","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:08.697747Z","caller":"traceutil/trace.go:171","msg":"trace[1529896727] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"1.159864785s","start":"2026-04-24T07:36:07.537872Z","end":"2026-04-24T07:36:08.697737Z","steps":["trace[1529896727] 'process raft request' (duration: 1.159158332s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.697846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:07.537846Z","time spent":"1.159971669s","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:08.698275Z","caller":"traceutil/trace.go:171","msg":"trace[2007545943] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"971.839164ms","start":"2026-04-24T07:36:07.726424Z","end":"2026-04-24T07:36:08.698263Z","steps":["trace[2007545943] 'process raft request' (duration: 971.269956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.698387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:07.726393Z","time spent":"971.964289ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:08.698406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369463448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a93ac77ab2abf2\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-24T07:36:08.698946Z","caller":"traceutil/trace.go:171","msg":"trace[2019236358] range","detail":"{range_begin:/registry/events/default/instance.18a93ac77ab2abf2; range_end:; response_count:1; response_revision:82; }","duration":"1.370032356s","start":"2026-04-24T07:36:07.328892Z","end":"2026-04-24T07:36:08.698924Z","steps":["trace[2019236358] 'agreement among raft nodes before linearized reading' (duration: 1.369426906s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.698982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:07.328871Z","time spent":"1.370101779s","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":673,"request content":"key:\"/registry/events/default/instance.18a93ac77ab2abf2\" "} {"level":"warn","ts":"2026-04-24T07:36:08.698458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.592439638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-24T07:36:08.699112Z","caller":"traceutil/trace.go:171","msg":"trace[624782247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:82; }","duration":"1.593125722s","start":"2026-04-24T07:36:07.105973Z","end":"2026-04-24T07:36:08.699099Z","steps":["trace[624782247] 'agreement among raft nodes before linearized reading' (duration: 1.592468759s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:08.699195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:07.105954Z","time spent":"1.593229365s","remote":"127.0.0.1:51976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-24T07:36:09.697491Z","caller":"traceutil/trace.go:171","msg":"trace[1346791101] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"160.980554ms","start":"2026-04-24T07:36:09.536481Z","end":"2026-04-24T07:36:09.697462Z","steps":["trace[1346791101] 'process raft request' (duration: 160.926312ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:09.697522Z","caller":"traceutil/trace.go:171","msg":"trace[1746874316] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"162.027278ms","start":"2026-04-24T07:36:09.535469Z","end":"2026-04-24T07:36:09.697496Z","steps":["trace[1746874316] 'process raft request' (duration: 136.266112ms)","trace[1746874316] 'compare' (duration: 25.513348ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:10.253044Z","caller":"traceutil/trace.go:171","msg":"trace[899690057] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"108.769363ms","start":"2026-04-24T07:36:10.144248Z","end":"2026-04-24T07:36:10.253017Z","steps":["trace[899690057] 'process raft request' (duration: 70.385317ms)","trace[899690057] 'compare' (duration: 38.264012ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:10.678215Z","caller":"traceutil/trace.go:171","msg":"trace[1105896690] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"188.086291ms","start":"2026-04-24T07:36:10.490098Z","end":"2026-04-24T07:36:10.678184Z","steps":["trace[1105896690] 'process raft request' (duration: 108.852747ms)","trace[1105896690] 'compare' (duration: 78.888133ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:13.044933Z","caller":"traceutil/trace.go:171","msg":"trace[657798367] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"105.123034ms","start":"2026-04-24T07:36:12.939787Z","end":"2026-04-24T07:36:13.04491Z","steps":["trace[657798367] 'compare' (duration: 86.19763ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:13.049397Z","caller":"traceutil/trace.go:171","msg":"trace[285947908] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"108.804108ms","start":"2026-04-24T07:36:12.940577Z","end":"2026-04-24T07:36:13.049381Z","steps":["trace[285947908] 'process raft request' (duration: 108.597992ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:16.621326Z","caller":"traceutil/trace.go:171","msg":"trace[1248723571] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"115.75614ms","start":"2026-04-24T07:36:16.505549Z","end":"2026-04-24T07:36:16.621305Z","steps":["trace[1248723571] 'read index received' (duration: 90.975453ms)","trace[1248723571] 'applied index is now lower than readState.Index' (duration: 24.779667ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:16.621426Z","caller":"traceutil/trace.go:171","msg":"trace[477948609] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"147.676398ms","start":"2026-04-24T07:36:16.473714Z","end":"2026-04-24T07:36:16.62139Z","steps":["trace[477948609] 'process raft request' (duration: 122.873099ms)","trace[477948609] 'compare' (duration: 24.612302ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:16.621476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.927377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-24T07:36:16.621519Z","caller":"traceutil/trace.go:171","msg":"trace[127754131] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:348; }","duration":"116.008839ms","start":"2026-04-24T07:36:16.505499Z","end":"2026-04-24T07:36:16.621508Z","steps":["trace[127754131] 'agreement among raft nodes before linearized reading' (duration: 115.926927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:16.621551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.035187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-24T07:36:16.621613Z","caller":"traceutil/trace.go:171","msg":"trace[431317465] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:348; }","duration":"111.13292ms","start":"2026-04-24T07:36:16.510465Z","end":"2026-04-24T07:36:16.621598Z","steps":["trace[431317465] 'agreement among raft nodes before linearized reading' (duration: 111.035667ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:24.143372Z","caller":"traceutil/trace.go:171","msg":"trace[1285934367] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"194.573108ms","start":"2026-04-24T07:36:23.948768Z","end":"2026-04-24T07:36:24.143341Z","steps":["trace[1285934367] 'process raft request' (duration: 194.34553ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:32.676518Z","caller":"traceutil/trace.go:171","msg":"trace[1857636471] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"145.396848ms","start":"2026-04-24T07:36:32.531088Z","end":"2026-04-24T07:36:32.676485Z","steps":["trace[1857636471] 'process raft request' (duration: 95.402622ms)","trace[1857636471] 'compare' (duration: 49.879403ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:32.677103Z","caller":"traceutil/trace.go:171","msg":"trace[1581901655] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"127.812406ms","start":"2026-04-24T07:36:32.549263Z","end":"2026-04-24T07:36:32.677075Z","steps":["trace[1581901655] 'process raft request' (duration: 127.546249ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.534944Z","caller":"traceutil/trace.go:171","msg":"trace[1172533699] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"342.435958ms","start":"2026-04-24T07:36:34.192463Z","end":"2026-04-24T07:36:34.534899Z","steps":["trace[1172533699] 'process raft request' (duration: 342.168241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.535182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.192442Z","time spent":"342.630464ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.546441Z","caller":"traceutil/trace.go:171","msg":"trace[2108960274] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"341.778292ms","start":"2026-04-24T07:36:34.204635Z","end":"2026-04-24T07:36:34.546414Z","steps":["trace[2108960274] 'process raft request' (duration: 341.71198ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.546459Z","caller":"traceutil/trace.go:171","msg":"trace[1883055526] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"348.30882ms","start":"2026-04-24T07:36:34.19811Z","end":"2026-04-24T07:36:34.546419Z","steps":["trace[1883055526] 'process raft request' (duration: 348.143866ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.546565Z","caller":"traceutil/trace.go:171","msg":"trace[630025873] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"345.785945ms","start":"2026-04-24T07:36:34.20076Z","end":"2026-04-24T07:36:34.546546Z","steps":["trace[630025873] 'process raft request' (duration: 345.549519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.546613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.198092Z","time spent":"348.439274ms","remote":"127.0.0.1:52234","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-24T07:36:34.546659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.200751Z","time spent":"345.863227ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.546747Z","caller":"traceutil/trace.go:171","msg":"trace[306527139] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"353.73458ms","start":"2026-04-24T07:36:34.192971Z","end":"2026-04-24T07:36:34.546706Z","steps":["trace[306527139] 'process raft request' (duration: 353.245688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.546941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.204607Z","time spent":"341.910906ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:34.54697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.192961Z","time spent":"353.917966ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.547134Z","caller":"traceutil/trace.go:171","msg":"trace[2035208617] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"353.667759ms","start":"2026-04-24T07:36:34.192663Z","end":"2026-04-24T07:36:34.54633Z","steps":["trace[2035208617] 'process raft request' (duration: 353.444923ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.547235Z","caller":"traceutil/trace.go:171","msg":"trace[316483402] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"340.456507ms","start":"2026-04-24T07:36:34.206768Z","end":"2026-04-24T07:36:34.547224Z","steps":["trace[316483402] 'process raft request' (duration: 340.20396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.547242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.192646Z","time spent":"354.548002ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.547277Z","caller":"traceutil/trace.go:171","msg":"trace[136584193] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:513; }","duration":"342.969402ms","start":"2026-04-24T07:36:34.204296Z","end":"2026-04-24T07:36:34.547266Z","steps":["trace[136584193] 'read index received' (duration: 330.377106ms)","trace[136584193] 'applied index is now lower than readState.Index' (duration: 12.591526ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:34.547291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.206752Z","time spent":"340.513599ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.547329Z","caller":"traceutil/trace.go:171","msg":"trace[1686789870] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"341.495394ms","start":"2026-04-24T07:36:34.20582Z","end":"2026-04-24T07:36:34.547315Z","steps":["trace[1686789870] 'process raft request' (duration: 340.56022ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.547366Z","caller":"traceutil/trace.go:171","msg":"trace[163112760] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"329.580996ms","start":"2026-04-24T07:36:34.217778Z","end":"2026-04-24T07:36:34.547359Z","steps":["trace[163112760] 'process raft request' (duration: 329.251558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.547367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.2058Z","time spent":"341.552555ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:34.547409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.217762Z","time spent":"329.626837ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.547469Z","caller":"traceutil/trace.go:171","msg":"trace[1147096010] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"196.550065ms","start":"2026-04-24T07:36:34.350909Z","end":"2026-04-24T07:36:34.547459Z","steps":["trace[1147096010] 'process raft request' (duration: 196.248597ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.547453Z","caller":"traceutil/trace.go:171","msg":"trace[256829050] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"341.419402ms","start":"2026-04-24T07:36:34.205959Z","end":"2026-04-24T07:36:34.547378Z","steps":["trace[256829050] 'process raft request' (duration: 340.94772ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.547571Z","caller":"traceutil/trace.go:171","msg":"trace[1548049531] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"175.49816ms","start":"2026-04-24T07:36:34.372065Z","end":"2026-04-24T07:36:34.547564Z","steps":["trace[1548049531] 'process raft request' (duration: 175.155621ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:34.547677Z","caller":"traceutil/trace.go:171","msg":"trace[494092630] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"328.745925ms","start":"2026-04-24T07:36:34.218922Z","end":"2026-04-24T07:36:34.547668Z","steps":["trace[494092630] 'process raft request' (duration: 328.144929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.547671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.360874ms","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-24T07:36:34.547729Z","caller":"traceutil/trace.go:171","msg":"trace[969014096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"343.443495ms","start":"2026-04-24T07:36:34.204272Z","end":"2026-04-24T07:36:34.547715Z","steps":["trace[969014096] 'agreement among raft nodes before linearized reading' (duration: 343.342293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.547703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.205952Z","time spent":"341.622238ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:34.547767Z","caller":"traceutil/trace.go:171","msg":"trace[1407646649] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"319.096025ms","start":"2026-04-24T07:36:34.228663Z","end":"2026-04-24T07:36:34.54776Z","steps":["trace[1407646649] 'process raft request' (duration: 318.442658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:34.547783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.204262Z","time spent":"343.508757ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-24T07:36:34.547811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.228648Z","time spent":"319.147796ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:34.547732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.218871Z","time spent":"328.840848ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:35.607097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.197571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:36:35.607644Z","caller":"traceutil/trace.go:171","msg":"trace[1738650519] transaction","detail":"{read_only:false; number_of_response:1; response_revision:510; }","duration":"1.06171373s","start":"2026-04-24T07:36:34.54591Z","end":"2026-04-24T07:36:35.607624Z","steps":["trace[1738650519] 'process raft request' (duration: 1.061660979s)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.60775Z","caller":"traceutil/trace.go:171","msg":"trace[1718430085] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.065700303s","start":"2026-04-24T07:36:34.542023Z","end":"2026-04-24T07:36:35.607724Z","steps":["trace[1718430085] 'process raft request' (duration: 309.775433ms)","trace[1718430085] 'compare' (duration: 754.947395ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:35.607792Z","caller":"traceutil/trace.go:171","msg":"trace[1463729451] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.06401988s","start":"2026-04-24T07:36:34.543748Z","end":"2026-04-24T07:36:35.607768Z","steps":["trace[1463729451] 'process raft request' (duration: 1.063679671s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.607895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.541992Z","time spent":"1.065828986s","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:35.607902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.543736Z","time spent":"1.064103502s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:35.608115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.545889Z","time spent":"1.061909095s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:35.707144Z","caller":"traceutil/trace.go:171","msg":"trace[2133995616] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.151361227s","start":"2026-04-24T07:36:34.555744Z","end":"2026-04-24T07:36:35.707105Z","steps":["trace[2133995616] 'process raft request' (duration: 1.150897915s)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.707342Z","caller":"traceutil/trace.go:171","msg":"trace[1367564721] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.146707638s","start":"2026-04-24T07:36:34.560621Z","end":"2026-04-24T07:36:35.707329Z","steps":["trace[1367564721] 'process raft request' (duration: 1.146373748s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.707436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.560604Z","time spent":"1.14680325s","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:35.707475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.555728Z","time spent":"1.15149957s","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:35.738767Z","caller":"traceutil/trace.go:171","msg":"trace[2831880] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.176755006s","start":"2026-04-24T07:36:34.561963Z","end":"2026-04-24T07:36:35.738718Z","steps":["trace[2831880] 'process raft request' (duration: 1.145332731s)","trace[2831880] 'compare' (duration: 31.084977ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:35.738797Z","caller":"traceutil/trace.go:171","msg":"trace[2119986511] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.176757006s","start":"2026-04-24T07:36:34.562005Z","end":"2026-04-24T07:36:35.738762Z","steps":["trace[2119986511] 'process raft request' (duration: 1.176559681s)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.738911Z","caller":"traceutil/trace.go:171","msg":"trace[1173002211] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.176611693s","start":"2026-04-24T07:36:34.56225Z","end":"2026-04-24T07:36:35.738861Z","steps":["trace[1173002211] 'process raft request' (duration: 1.176389277s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.738967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.561957Z","time spent":"1.176929832s","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:35.73897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.562Z","time spent":"1.176881159s","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:35.739055Z","caller":"traceutil/trace.go:171","msg":"trace[695571228] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.172519767s","start":"2026-04-24T07:36:34.566509Z","end":"2026-04-24T07:36:35.739029Z","steps":["trace[695571228] 'process raft request' (duration: 1.172210069s)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.739064Z","caller":"traceutil/trace.go:171","msg":"trace[190881888] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.172090107s","start":"2026-04-24T07:36:34.566924Z","end":"2026-04-24T07:36:35.739014Z","steps":["trace[190881888] 'process raft request' (duration: 1.17183646s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.739139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.562245Z","time spent":"1.176757497s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:35.739183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.566479Z","time spent":"1.172641041s","remote":"127.0.0.1:52514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:36:35.739389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.566917Z","time spent":"1.172320613s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:35.739768Z","caller":"traceutil/trace.go:171","msg":"trace[161894067] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.172772254s","start":"2026-04-24T07:36:34.566974Z","end":"2026-04-24T07:36:35.739746Z","steps":["trace[161894067] 'process raft request' (duration: 1.171849501s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.739896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.56697Z","time spent":"1.172856856s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:35.744162Z","caller":"traceutil/trace.go:171","msg":"trace[1497076919] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"130.168489ms","start":"2026-04-24T07:36:35.613964Z","end":"2026-04-24T07:36:35.744133Z","steps":["trace[1497076919] 'process raft request' (duration: 126.597997ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.745492Z","caller":"traceutil/trace.go:171","msg":"trace[1883095670] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.140423038s","start":"2026-04-24T07:36:34.60044Z","end":"2026-04-24T07:36:35.740863Z","steps":["trace[1883095670] 'process raft request' (duration: 1.139954835s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.745684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.600399Z","time spent":"1.14524309s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:35.745521Z","caller":"traceutil/trace.go:171","msg":"trace[1234751799] transaction","detail":"{read_only:false; number_of_response:1; response_revision:521; }","duration":"129.219014ms","start":"2026-04-24T07:36:35.616285Z","end":"2026-04-24T07:36:35.745504Z","steps":["trace[1234751799] 'process raft request' (duration: 124.336579ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.746244Z","caller":"traceutil/trace.go:171","msg":"trace[1039196446] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:527; }","duration":"1.158579524s","start":"2026-04-24T07:36:34.587634Z","end":"2026-04-24T07:36:35.746214Z","steps":["trace[1039196446] 'read index received' (duration: 264.303536ms)","trace[1039196446] 'applied index is now lower than readState.Index' (duration: 894.274438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:35.746487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158851142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:35.74652Z","caller":"traceutil/trace.go:171","msg":"trace[1703226604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"1.158920894s","start":"2026-04-24T07:36:34.58759Z","end":"2026-04-24T07:36:35.74651Z","steps":["trace[1703226604] 'agreement among raft nodes before linearized reading' (duration: 1.158844931s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.748068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.587569Z","time spent":"1.160485333s","remote":"127.0.0.1:51976","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-24T07:36:35.748258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.939434ms","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-24T07:36:35.748299Z","caller":"traceutil/trace.go:171","msg":"trace[197718385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:522; }","duration":"861.000505ms","start":"2026-04-24T07:36:34.887289Z","end":"2026-04-24T07:36:35.748289Z","steps":["trace[197718385] 'agreement among raft nodes before linearized reading' (duration: 860.928454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.748325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.887274Z","time spent":"861.045597ms","remote":"127.0.0.1:52234","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-24T07:36:35.740835Z","caller":"traceutil/trace.go:171","msg":"trace[129492724] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"118.297433ms","start":"2026-04-24T07:36:35.622519Z","end":"2026-04-24T07:36:35.740817Z","steps":["trace[129492724] 'process raft request' (duration: 118.16135ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:35.749144Z","caller":"traceutil/trace.go:171","msg":"trace[511721777] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.170884004s","start":"2026-04-24T07:36:34.569968Z","end":"2026-04-24T07:36:35.740852Z","steps":["trace[511721777] 'process raft request' (duration: 1.16955859s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:35.74926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:34.569943Z","time spent":"1.179235038s","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:39.342611Z","caller":"traceutil/trace.go:171","msg":"trace[1381446481] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"115.628805ms","start":"2026-04-24T07:36:39.22696Z","end":"2026-04-24T07:36:39.342589Z","steps":["trace[1381446481] 'process raft request' (duration: 112.454537ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:41.989536Z","caller":"traceutil/trace.go:171","msg":"trace[1649061677] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"123.1129ms","start":"2026-04-24T07:36:41.866372Z","end":"2026-04-24T07:36:41.989485Z","steps":["trace[1649061677] 'process raft request' (duration: 34.309106ms)","trace[1649061677] 'compare' (duration: 88.428945ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:42.376691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.660359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:36:42.376818Z","caller":"traceutil/trace.go:171","msg":"trace[1991146061] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"373.791252ms","start":"2026-04-24T07:36:42.003002Z","end":"2026-04-24T07:36:42.376794Z","steps":["trace[1991146061] 'process raft request' (duration: 203.941339ms)","trace[1991146061] 'compare' (duration: 169.493525ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:42.376897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:42.002985Z","time spent":"373.872794ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:36:42.875933Z","caller":"traceutil/trace.go:171","msg":"trace[842268969] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"301.567897ms","start":"2026-04-24T07:36:42.574296Z","end":"2026-04-24T07:36:42.875864Z","steps":["trace[842268969] 'read index received' (duration: 284.778941ms)","trace[842268969] 'applied index is now lower than readState.Index' (duration: 16.787926ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:42.876058Z","caller":"traceutil/trace.go:171","msg":"trace[1245248988] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"425.40839ms","start":"2026-04-24T07:36:42.450599Z","end":"2026-04-24T07:36:42.876007Z","steps":["trace[1245248988] 'process raft request' (duration: 408.619644ms)","trace[1245248988] 'compare' (duration: 16.253522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:42.876139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.831364ms","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-24T07:36:42.87618Z","caller":"traceutil/trace.go:171","msg":"trace[510539028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"301.888975ms","start":"2026-04-24T07:36:42.574278Z","end":"2026-04-24T07:36:42.876167Z","steps":["trace[510539028] 'agreement among raft nodes before linearized reading' (duration: 301.729621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:42.876224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:42.574212Z","time spent":"302.001258ms","remote":"127.0.0.1:52234","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-24T07:36:42.876262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:42.450563Z","time spent":"425.592505ms","remote":"127.0.0.1:52038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:45.135685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00021674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-24T07:36:45.135797Z","caller":"traceutil/trace.go:171","msg":"trace[1478973020] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000371893s","start":"2026-04-24T07:36:43.135397Z","end":"2026-04-24T07:36:45.135769Z","steps":["trace[1478973020] 'agreement among raft nodes before linearized reading' (duration: 2.00023989s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.135871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.135375Z","time spent":"2.000483786s","remote":"127.0.0.1:51982","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-24T07:36:45.587022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000243275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-24T07:36:45.587088Z","caller":"traceutil/trace.go:171","msg":"trace[1494589603] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000357158s","start":"2026-04-24T07:36:43.586716Z","end":"2026-04-24T07:36:45.587073Z","steps":["trace[1494589603] 'agreement among raft nodes before linearized reading' (duration: 2.000271476s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.58734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.586697Z","time spent":"2.000634934s","remote":"127.0.0.1:51976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/24 07:36:45 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-24T07:36:45.92478Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.464407948s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-24T07:36:45.974655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.855618ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:45.974718Z","caller":"traceutil/trace.go:171","msg":"trace[323807367] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"209.930049ms","start":"2026-04-24T07:36:45.764773Z","end":"2026-04-24T07:36:45.974703Z","steps":["trace[323807367] 'range keys from in-memory index tree' (duration: 209.840857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.974804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.994978279s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:36:45.975012Z","caller":"traceutil/trace.go:171","msg":"trace[6969362] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"3.036352679s","start":"2026-04-24T07:36:42.938623Z","end":"2026-04-24T07:36:45.974976Z","steps":["trace[6969362] 'process raft request' (duration: 41.132244ms)","trace[6969362] 'compare' (duration: 2.994438435s)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:45.975134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:42.938598Z","time spent":"3.036476062s","remote":"127.0.0.1:52208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:45.97538Z","caller":"traceutil/trace.go:171","msg":"trace[22895415] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"2.839912937s","start":"2026-04-24T07:36:43.135437Z","end":"2026-04-24T07:36:45.97535Z","steps":["trace[22895415] 'read index received' (duration: 35.98µs)","trace[22895415] 'applied index is now lower than readState.Index' (duration: 2.839873667s)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:45.975707Z","caller":"traceutil/trace.go:171","msg":"trace[31582936] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.51538854s","start":"2026-04-24T07:36:43.460242Z","end":"2026-04-24T07:36:45.975631Z","steps":["trace[31582936] 'process raft request' (duration: 2.514654753s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.976079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.460216Z","time spent":"2.5158072s","remote":"127.0.0.1:52234","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-24T07:36:45.983848Z","caller":"traceutil/trace.go:171","msg":"trace[1792850642] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"2.241494513s","start":"2026-04-24T07:36:43.74233Z","end":"2026-04-24T07:36:45.983824Z","steps":["trace[1792850642] 'process raft request' (duration: 2.241141205s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.742301Z","time spent":"2.241647786s","remote":"127.0.0.1:52120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:36:45.984161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.990311973s","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-24T07:36:45.984184Z","caller":"traceutil/trace.go:171","msg":"trace[2006837775] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"844.587992ms","start":"2026-04-24T07:36:45.139561Z","end":"2026-04-24T07:36:45.984149Z","steps":["trace[2006837775] 'process raft request' (duration: 844.031979ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:45.984236Z","caller":"traceutil/trace.go:171","msg":"trace[1724255820] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"1.990427975s","start":"2026-04-24T07:36:43.993789Z","end":"2026-04-24T07:36:45.984217Z","steps":["trace[1724255820] 'agreement among raft nodes before linearized reading' (duration: 1.99019706s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.993771Z","time spent":"1.990499777s","remote":"127.0.0.1:52234","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-24T07:36:45.984289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:45.139539Z","time spent":"844.686415ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:36:45.984476Z","caller":"traceutil/trace.go:171","msg":"trace[374799052] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.172627254s","start":"2026-04-24T07:36:44.811841Z","end":"2026-04-24T07:36:45.984468Z","steps":["trace[374799052] 'process raft request' (duration: 1.171722783s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150414639s","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-24T07:36:45.984528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:44.811813Z","time spent":"1.172687656s","remote":"127.0.0.1:52234","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-24T07:36:45.984549Z","caller":"traceutil/trace.go:171","msg":"trace[602332654] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"2.15045392s","start":"2026-04-24T07:36:43.834083Z","end":"2026-04-24T07:36:45.984537Z","steps":["trace[602332654] 'agreement among raft nodes before linearized reading' (duration: 2.150319937s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.98458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.834018Z","time spent":"2.150553593s","remote":"127.0.0.1:52234","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-24T07:36:45.984584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088525834s","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-24T07:36:45.984607Z","caller":"traceutil/trace.go:171","msg":"trace[1503833196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"1.088589686s","start":"2026-04-24T07:36:44.89601Z","end":"2026-04-24T07:36:45.9846Z","steps":["trace[1503833196] 'agreement among raft nodes before linearized reading' (duration: 1.088524014s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:44.895992Z","time spent":"1.088628757s","remote":"127.0.0.1:52234","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-24T07:36:45.984517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.700702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:45.984769Z","caller":"traceutil/trace.go:171","msg":"trace[1110640006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"390.952018ms","start":"2026-04-24T07:36:45.593809Z","end":"2026-04-24T07:36:45.984761Z","steps":["trace[1110640006] 'agreement among raft nodes before linearized reading' (duration: 390.685691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:45.593758Z","time spent":"391.032719ms","remote":"127.0.0.1:51982","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-24T07:36:45.984847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.23222492s","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-24T07:36:45.984868Z","caller":"traceutil/trace.go:171","msg":"trace[326470762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"2.232284042s","start":"2026-04-24T07:36:43.752577Z","end":"2026-04-24T07:36:45.984861Z","steps":["trace[326470762] 'agreement among raft nodes before linearized reading' (duration: 2.23221021s)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:45.984888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:36:43.752518Z","time spent":"2.232364763s","remote":"127.0.0.1:52234","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-24T07:36:46.175113Z","caller":"traceutil/trace.go:171","msg":"trace[59582671] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"161.351203ms","start":"2026-04-24T07:36:46.013734Z","end":"2026-04-24T07:36:46.175085Z","steps":["trace[59582671] 'process raft request' (duration: 154.907533ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:46.181132Z","caller":"traceutil/trace.go:171","msg":"trace[1758685967] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"166.488883ms","start":"2026-04-24T07:36:46.014598Z","end":"2026-04-24T07:36:46.181087Z","steps":["trace[1758685967] 'process raft request' (duration: 166.35535ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:46.184132Z","caller":"traceutil/trace.go:171","msg":"trace[1278381678] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:648; }","duration":"142.006311ms","start":"2026-04-24T07:36:46.042107Z","end":"2026-04-24T07:36:46.184113Z","steps":["trace[1278381678] 'read index received' (duration: 126.54592ms)","trace[1278381678] 'applied index is now lower than readState.Index' (duration: 15.459291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:36:46.184254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.110583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:46.184493Z","caller":"traceutil/trace.go:171","msg":"trace[275678619] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"142.36908ms","start":"2026-04-24T07:36:46.04208Z","end":"2026-04-24T07:36:46.184449Z","steps":["trace[275678619] 'agreement among raft nodes before linearized reading' (duration: 142.102832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:46.184731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.572185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:46.185148Z","caller":"traceutil/trace.go:171","msg":"trace[117194634] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"142.983954ms","start":"2026-04-24T07:36:46.042133Z","end":"2026-04-24T07:36:46.185117Z","steps":["trace[117194634] 'agreement among raft nodes before linearized reading' (duration: 142.557444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:46.18479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.265818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:46.18539Z","caller":"traceutil/trace.go:171","msg":"trace[1230831490] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"142.881562ms","start":"2026-04-24T07:36:46.042487Z","end":"2026-04-24T07:36:46.185369Z","steps":["trace[1230831490] 'agreement among raft nodes before linearized reading' (duration: 142.246277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.440192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.576783ms","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":"warn","ts":"2026-04-24T07:36:47.440225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.66003ms","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-24T07:36:47.440504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.815625ms","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":"warn","ts":"2026-04-24T07:36:47.440519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.470478ms","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-24T07:36:47.440534Z","caller":"traceutil/trace.go:171","msg":"trace[1018934108] 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":"236.870196ms","start":"2026-04-24T07:36:47.203652Z","end":"2026-04-24T07:36:47.440522Z","steps":["trace[1018934108] 'range keys from in-memory index tree' (duration: 236.732174ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:47.440531Z","caller":"traceutil/trace.go:171","msg":"trace[536484598] 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":"274.050339ms","start":"2026-04-24T07:36:47.166456Z","end":"2026-04-24T07:36:47.440506Z","steps":["trace[536484598] 'range keys from in-memory index tree' (duration: 273.594978ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:47.440552Z","caller":"traceutil/trace.go:171","msg":"trace[171090613] 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":"274.55449ms","start":"2026-04-24T07:36:47.165986Z","end":"2026-04-24T07:36:47.440541Z","steps":["trace[171090613] 'range keys from in-memory index tree' (duration: 274.343955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.440637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.58555ms","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-24T07:36:47.440726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.957469ms","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-24T07:36:47.440762Z","caller":"traceutil/trace.go:171","msg":"trace[109811482] 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":"253.035181ms","start":"2026-04-24T07:36:47.187718Z","end":"2026-04-24T07:36:47.440754Z","steps":["trace[109811482] 'range keys from in-memory index tree' (duration: 252.900937ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:47.440814Z","caller":"traceutil/trace.go:171","msg":"trace[1731643759] 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":"236.696132ms","start":"2026-04-24T07:36:47.203999Z","end":"2026-04-24T07:36:47.440696Z","steps":["trace[1731643759] 'count revisions from in-memory index tree' (duration: 236.525167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.440254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.623914ms","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-24T07:36:47.441208Z","caller":"traceutil/trace.go:171","msg":"trace[2090919726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"288.566025ms","start":"2026-04-24T07:36:47.152616Z","end":"2026-04-24T07:36:47.441182Z","steps":["trace[2090919726] 'count revisions from in-memory index tree' (duration: 287.603493ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:47.440473Z","caller":"traceutil/trace.go:171","msg":"trace[1979688782] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"287.696165ms","start":"2026-04-24T07:36:47.152554Z","end":"2026-04-24T07:36:47.44025Z","steps":["trace[1979688782] 'range keys from in-memory index tree' (duration: 287.48476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.440194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.278973ms","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-24T07:36:47.441573Z","caller":"traceutil/trace.go:171","msg":"trace[1701836551] 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":"275.613434ms","start":"2026-04-24T07:36:47.165876Z","end":"2026-04-24T07:36:47.441489Z","steps":["trace[1701836551] 'count revisions from in-memory index tree' (duration: 274.230302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.4409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.852406ms","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-24T07:36:47.442177Z","caller":"traceutil/trace.go:171","msg":"trace[938783056] 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":"254.152026ms","start":"2026-04-24T07:36:47.188007Z","end":"2026-04-24T07:36:47.442159Z","steps":["trace[938783056] 'count revisions from in-memory index tree' (duration: 252.791315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:47.440924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.63829ms","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":"info","ts":"2026-04-24T07:36:47.44252Z","caller":"traceutil/trace.go:171","msg":"trace[1229302883] 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":"238.231848ms","start":"2026-04-24T07:36:47.204269Z","end":"2026-04-24T07:36:47.442501Z","steps":["trace[1229302883] 'range keys from in-memory index tree' (duration: 236.540908ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:48.342259Z","caller":"traceutil/trace.go:171","msg":"trace[1014795714] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"111.23932ms","start":"2026-04-24T07:36:48.230992Z","end":"2026-04-24T07:36:48.342231Z","steps":["trace[1014795714] 'process raft request' (duration: 111.003805ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:48.640752Z","caller":"traceutil/trace.go:171","msg":"trace[1317462648] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"142.370527ms","start":"2026-04-24T07:36:48.498359Z","end":"2026-04-24T07:36:48.640729Z","steps":["trace[1317462648] 'process raft request' (duration: 140.651598ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:48.807036Z","caller":"traceutil/trace.go:171","msg":"trace[1924075743] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"161.099019ms","start":"2026-04-24T07:36:48.645904Z","end":"2026-04-24T07:36:48.807003Z","steps":["trace[1924075743] 'process raft request' (duration: 113.047213ms)","trace[1924075743] 'compare' (duration: 47.895732ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:36:52.12626Z","caller":"traceutil/trace.go:171","msg":"trace[780860520] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"107.229943ms","start":"2026-04-24T07:36:52.018995Z","end":"2026-04-24T07:36:52.126225Z","steps":["trace[780860520] 'process raft request' (duration: 106.65131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:55.238244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.016621ms","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":"info","ts":"2026-04-24T07:36:55.238314Z","caller":"traceutil/trace.go:171","msg":"trace[671583804] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:727; }","duration":"122.126103ms","start":"2026-04-24T07:36:55.116175Z","end":"2026-04-24T07:36:55.238301Z","steps":["trace[671583804] 'count revisions from in-memory index tree' (duration: 121.97686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:36:55.238246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.309827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-24T07:36:55.238188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.112943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:36:55.238372Z","caller":"traceutil/trace.go:171","msg":"trace[2124870218] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:727; }","duration":"122.479091ms","start":"2026-04-24T07:36:55.115876Z","end":"2026-04-24T07:36:55.238355Z","steps":["trace[2124870218] 'range keys from in-memory index tree' (duration: 122.218675ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:36:55.238428Z","caller":"traceutil/trace.go:171","msg":"trace[240324176] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:727; }","duration":"122.385859ms","start":"2026-04-24T07:36:55.116013Z","end":"2026-04-24T07:36:55.238399Z","steps":["trace[240324176] 'range keys from in-memory index tree' (duration: 122.041662ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:00.318927Z","caller":"traceutil/trace.go:171","msg":"trace[1352463612] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"132.023916ms","start":"2026-04-24T07:37:00.186879Z","end":"2026-04-24T07:37:00.318903Z","steps":["trace[1352463612] 'process raft request' (duration: 131.851683ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:00.319107Z","caller":"traceutil/trace.go:171","msg":"trace[1027719446] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:788; }","duration":"129.388811ms","start":"2026-04-24T07:37:00.189691Z","end":"2026-04-24T07:37:00.31908Z","steps":["trace[1027719446] 'read index received' (duration: 84.15943ms)","trace[1027719446] 'applied index is now lower than readState.Index' (duration: 45.227581ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:00.319132Z","caller":"traceutil/trace.go:171","msg":"trace[1886418846] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"130.849552ms","start":"2026-04-24T07:37:00.188272Z","end":"2026-04-24T07:37:00.319122Z","steps":["trace[1886418846] 'process raft request' (duration: 130.590916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:00.319275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.570974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-24T07:37:00.319318Z","caller":"traceutil/trace.go:171","msg":"trace[226950189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"129.680137ms","start":"2026-04-24T07:37:00.189627Z","end":"2026-04-24T07:37:00.319307Z","steps":["trace[226950189] 'agreement among raft nodes before linearized reading' (duration: 129.542104ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:01.127678Z","caller":"traceutil/trace.go:171","msg":"trace[738712553] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"101.602332ms","start":"2026-04-24T07:37:01.026016Z","end":"2026-04-24T07:37:01.127618Z","steps":["trace[738712553] 'process raft request' (duration: 71.124676ms)","trace[738712553] 'compare' (duration: 30.265622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:02.434867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.756371ms","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-24T07:37:02.43493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.370446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gnd2j\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-24T07:37:02.434971Z","caller":"traceutil/trace.go:171","msg":"trace[1728240297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:770; }","duration":"432.903965ms","start":"2026-04-24T07:37:02.002045Z","end":"2026-04-24T07:37:02.434949Z","steps":["trace[1728240297] 'range keys from in-memory index tree' (duration: 432.587918ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:02.435023Z","caller":"traceutil/trace.go:171","msg":"trace[578294531] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gnd2j; range_end:; response_count:1; response_revision:770; }","duration":"381.50704ms","start":"2026-04-24T07:37:02.053488Z","end":"2026-04-24T07:37:02.434995Z","steps":["trace[578294531] 'range keys from in-memory index tree' (duration: 381.155263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:02.435087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.05347Z","time spent":"381.598001ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gnd2j\" "} {"level":"warn","ts":"2026-04-24T07:37:02.43538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.378694ms","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-24T07:37:02.435456Z","caller":"traceutil/trace.go:171","msg":"trace[1874482100] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:770; }","duration":"157.482886ms","start":"2026-04-24T07:37:02.277956Z","end":"2026-04-24T07:37:02.435439Z","steps":["trace[1874482100] 'range keys from in-memory index tree' (duration: 157.265332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:02.435027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.002027Z","time spent":"432.984266ms","remote":"127.0.0.1:52234","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-24T07:37:02.435841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.963622ms","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-24T07:37:02.435899Z","caller":"traceutil/trace.go:171","msg":"trace[2091650841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:770; }","duration":"113.028784ms","start":"2026-04-24T07:37:02.322855Z","end":"2026-04-24T07:37:02.435884Z","steps":["trace[2091650841] 'range keys from in-memory index tree' (duration: 112.873711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:02.43601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.895116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-24T07:37:02.436034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.204637ms","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-24T07:37:02.436091Z","caller":"traceutil/trace.go:171","msg":"trace[486144998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:770; }","duration":"107.009938ms","start":"2026-04-24T07:37:02.329061Z","end":"2026-04-24T07:37:02.436071Z","steps":["trace[486144998] 'range keys from in-memory index tree' (duration: 106.721253ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:02.436235Z","caller":"traceutil/trace.go:171","msg":"trace[1009032632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:770; }","duration":"113.29044ms","start":"2026-04-24T07:37:02.322788Z","end":"2026-04-24T07:37:02.436079Z","steps":["trace[1009032632] 'range keys from in-memory index tree' (duration: 113.000403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.092526Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219121274823535989,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-24T07:37:03.095803Z","caller":"traceutil/trace.go:171","msg":"trace[762456772] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"655.817523ms","start":"2026-04-24T07:37:02.439968Z","end":"2026-04-24T07:37:03.095786Z","steps":["trace[762456772] 'process raft request' (duration: 655.698811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.095936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.439863Z","time spent":"655.996727ms","remote":"127.0.0.1:52234","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-24T07:37:03.110493Z","caller":"traceutil/trace.go:171","msg":"trace[108432113] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"669.28433ms","start":"2026-04-24T07:37:02.441181Z","end":"2026-04-24T07:37:03.110466Z","steps":["trace[108432113] 'process raft request' (duration: 668.938142ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:03.110508Z","caller":"traceutil/trace.go:171","msg":"trace[2035063229] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"669.25815ms","start":"2026-04-24T07:37:02.441223Z","end":"2026-04-24T07:37:03.110481Z","steps":["trace[2035063229] 'process raft request' (duration: 669.110097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.110669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.441207Z","time spent":"669.370362ms","remote":"127.0.0.1:52234","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-24T07:37:03.110689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.441152Z","time spent":"669.423943ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:37:03.110672Z","caller":"traceutil/trace.go:171","msg":"trace[924491427] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"669.324421ms","start":"2026-04-24T07:37:02.441307Z","end":"2026-04-24T07:37:03.110631Z","steps":["trace[924491427] 'process raft request' (duration: 669.080836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.11086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.441294Z","time spent":"669.478495ms","remote":"127.0.0.1:52234","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-24T07:37:03.111036Z","caller":"traceutil/trace.go:171","msg":"trace[1759041442] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:802; }","duration":"523.901577ms","start":"2026-04-24T07:37:02.587117Z","end":"2026-04-24T07:37:03.111019Z","steps":["trace[1759041442] 'read index received' (duration: 508.56462ms)","trace[1759041442] 'applied index is now lower than readState.Index' (duration: 15.335677ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:03.111066Z","caller":"traceutil/trace.go:171","msg":"trace[2076442662] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"669.446833ms","start":"2026-04-24T07:37:02.4416Z","end":"2026-04-24T07:37:03.111047Z","steps":["trace[2076442662] 'process raft request' (duration: 668.831491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.111219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.441593Z","time spent":"669.584196ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:37:03.111333Z","caller":"traceutil/trace.go:171","msg":"trace[1457079300] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"667.592685ms","start":"2026-04-24T07:37:02.443727Z","end":"2026-04-24T07:37:03.11132Z","steps":["trace[1457079300] 'process raft request' (duration: 667.235297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.111137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.019649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:37:03.111402Z","caller":"traceutil/trace.go:171","msg":"trace[382209656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"524.318435ms","start":"2026-04-24T07:37:02.587068Z","end":"2026-04-24T07:37:03.111387Z","steps":["trace[382209656] 'agreement among raft nodes before linearized reading' (duration: 524.016019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:03.111423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.443722Z","time spent":"667.653566ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:37:03.111472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:02.587047Z","time spent":"524.403756ms","remote":"127.0.0.1:51982","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-24T07:37:05.305941Z","caller":"traceutil/trace.go:171","msg":"trace[910459798] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"200.832646ms","start":"2026-04-24T07:37:05.105095Z","end":"2026-04-24T07:37:05.305927Z","steps":["trace[910459798] 'process raft request' (duration: 200.617402ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.306124Z","caller":"traceutil/trace.go:171","msg":"trace[1407127423] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"190.669601ms","start":"2026-04-24T07:37:05.115204Z","end":"2026-04-24T07:37:05.305874Z","steps":["trace[1407127423] 'read index received' (duration: 190.543449ms)","trace[1407127423] 'applied index is now lower than readState.Index' (duration: 125.092µs)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:05.306386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.157441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-24T07:37:05.30649Z","caller":"traceutil/trace.go:171","msg":"trace[2007310684] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:784; }","duration":"191.305553ms","start":"2026-04-24T07:37:05.115166Z","end":"2026-04-24T07:37:05.306472Z","steps":["trace[2007310684] 'agreement among raft nodes before linearized reading' (duration: 190.866944ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.543271Z","caller":"traceutil/trace.go:171","msg":"trace[320833328] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"237.099664ms","start":"2026-04-24T07:37:05.306152Z","end":"2026-04-24T07:37:05.543252Z","steps":["trace[320833328] 'read index received' (duration: 237.029973ms)","trace[320833328] 'applied index is now lower than readState.Index' (duration: 69.101µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:05.543342Z","caller":"traceutil/trace.go:171","msg":"trace[389449330] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"378.443894ms","start":"2026-04-24T07:37:05.164883Z","end":"2026-04-24T07:37:05.543327Z","steps":["trace[389449330] 'process raft request' (duration: 378.2398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.543453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.698984ms","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-24T07:37:05.54349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:05.164839Z","time spent":"378.548186ms","remote":"127.0.0.1:52208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:37:05.543524Z","caller":"traceutil/trace.go:171","msg":"trace[1320562881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:785; }","duration":"427.791256ms","start":"2026-04-24T07:37:05.115721Z","end":"2026-04-24T07:37:05.543513Z","steps":["trace[1320562881] 'agreement among raft nodes before linearized reading' (duration: 427.614112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.543546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.171334ms","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-24T07:37:05.54369Z","caller":"traceutil/trace.go:171","msg":"trace[250474231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:785; }","duration":"428.275215ms","start":"2026-04-24T07:37:05.115315Z","end":"2026-04-24T07:37:05.54359Z","steps":["trace[250474231] 'agreement among raft nodes before linearized reading' (duration: 428.080931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.543753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:05.115287Z","time spent":"428.451069ms","remote":"127.0.0.1:52234","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-24T07:37:05.543561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:05.115713Z","time spent":"427.839737ms","remote":"127.0.0.1:52234","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-24T07:37:05.54345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.740095ms","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-24T07:37:05.543873Z","caller":"traceutil/trace.go:171","msg":"trace[563531014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"428.179154ms","start":"2026-04-24T07:37:05.115684Z","end":"2026-04-24T07:37:05.543863Z","steps":["trace[563531014] 'agreement among raft nodes before linearized reading' (duration: 427.665903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.543934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:05.115675Z","time spent":"428.225854ms","remote":"127.0.0.1:52234","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-24T07:37:05.60383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.633009ms","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":"info","ts":"2026-04-24T07:37:05.60376Z","caller":"traceutil/trace.go:171","msg":"trace[2025390702] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"293.184894ms","start":"2026-04-24T07:37:05.31055Z","end":"2026-04-24T07:37:05.603734Z","steps":["trace[2025390702] 'process raft request' (duration: 293.0085ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.603881Z","caller":"traceutil/trace.go:171","msg":"trace[511472518] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:786; }","duration":"217.742282ms","start":"2026-04-24T07:37:05.386132Z","end":"2026-04-24T07:37:05.603875Z","steps":["trace[511472518] 'agreement among raft nodes before linearized reading' (duration: 217.603309ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.724947Z","caller":"traceutil/trace.go:171","msg":"trace[766781336] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"176.528754ms","start":"2026-04-24T07:37:05.548388Z","end":"2026-04-24T07:37:05.724917Z","steps":["trace[766781336] 'process raft request' (duration: 176.35329ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.725276Z","caller":"traceutil/trace.go:171","msg":"trace[446563845] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:818; }","duration":"121.546007ms","start":"2026-04-24T07:37:05.603707Z","end":"2026-04-24T07:37:05.725253Z","steps":["trace[446563845] 'read index received' (duration: 120.979806ms)","trace[446563845] 'applied index is now lower than readState.Index' (duration: 565.251µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:05.725308Z","caller":"traceutil/trace.go:171","msg":"trace[1003702889] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"176.32934ms","start":"2026-04-24T07:37:05.548963Z","end":"2026-04-24T07:37:05.725292Z","steps":["trace[1003702889] 'process raft request' (duration: 176.175427ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:05.725383Z","caller":"traceutil/trace.go:171","msg":"trace[2136237791] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"176.441313ms","start":"2026-04-24T07:37:05.54892Z","end":"2026-04-24T07:37:05.725361Z","steps":["trace[2136237791] 'process raft request' (duration: 175.951023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.725483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.075616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gnd2j\" ","response":"range_response_count:1 size:2874"} {"level":"info","ts":"2026-04-24T07:37:05.725519Z","caller":"traceutil/trace.go:171","msg":"trace[52035089] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gnd2j; range_end:; response_count:1; response_revision:789; }","duration":"145.154808ms","start":"2026-04-24T07:37:05.58035Z","end":"2026-04-24T07:37:05.725505Z","steps":["trace[52035089] 'agreement among raft nodes before linearized reading' (duration: 145.001604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:05.725507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.930171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:37:05.725575Z","caller":"traceutil/trace.go:171","msg":"trace[1513176395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:789; }","duration":"140.065363ms","start":"2026-04-24T07:37:05.585487Z","end":"2026-04-24T07:37:05.725553Z","steps":["trace[1513176395] 'agreement among raft nodes before linearized reading' (duration: 139.932201ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:06.245168Z","caller":"traceutil/trace.go:171","msg":"trace[374268893] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"166.281464ms","start":"2026-04-24T07:37:06.078867Z","end":"2026-04-24T07:37:06.245149Z","steps":["trace[374268893] 'process raft request' (duration: 166.127ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:06.458226Z","caller":"traceutil/trace.go:171","msg":"trace[140551306] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"101.337994ms","start":"2026-04-24T07:37:06.35687Z","end":"2026-04-24T07:37:06.458208Z","steps":["trace[140551306] 'process raft request' (duration: 101.226692ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:06.852767Z","caller":"traceutil/trace.go:171","msg":"trace[743603783] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"199.770168ms","start":"2026-04-24T07:37:06.652964Z","end":"2026-04-24T07:37:06.852734Z","steps":["trace[743603783] 'process raft request' (duration: 199.507273ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:11.769522Z","caller":"traceutil/trace.go:171","msg":"trace[1711918571] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"140.982011ms","start":"2026-04-24T07:37:11.628514Z","end":"2026-04-24T07:37:11.769496Z","steps":["trace[1711918571] 'process raft request' (duration: 140.800517ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:19.630834Z","caller":"traceutil/trace.go:171","msg":"trace[1635556283] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"192.593974ms","start":"2026-04-24T07:37:19.438217Z","end":"2026-04-24T07:37:19.630811Z","steps":["trace[1635556283] 'process raft request' (duration: 155.013116ms)","trace[1635556283] 'compare' (duration: 37.452196ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:32.414136Z","caller":"traceutil/trace.go:171","msg":"trace[1443452161] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"263.180887ms","start":"2026-04-24T07:37:32.150932Z","end":"2026-04-24T07:37:32.414113Z","steps":["trace[1443452161] 'process raft request' (duration: 263.047585ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:34.646429Z","caller":"traceutil/trace.go:171","msg":"trace[875530594] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"227.601672ms","start":"2026-04-24T07:37:34.418808Z","end":"2026-04-24T07:37:34.64641Z","steps":["trace[875530594] 'process raft request' (duration: 227.305538ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:36.964606Z","caller":"traceutil/trace.go:171","msg":"trace[89577930] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"116.791792ms","start":"2026-04-24T07:37:36.847795Z","end":"2026-04-24T07:37:36.964587Z","steps":["trace[89577930] 'process raft request' (duration: 116.6745ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:38.18894Z","caller":"traceutil/trace.go:171","msg":"trace[1725823406] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"341.821719ms","start":"2026-04-24T07:37:37.847093Z","end":"2026-04-24T07:37:38.188915Z","steps":["trace[1725823406] 'process raft request' (duration: 329.723116ms)","trace[1725823406] 'compare' (duration: 11.651525ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:38.189086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:37.847075Z","time spent":"341.948612ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":703,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:37:38.189161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.916778ms","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-24T07:37:38.18923Z","caller":"traceutil/trace.go:171","msg":"trace[1362112805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"293.026659ms","start":"2026-04-24T07:37:37.896188Z","end":"2026-04-24T07:37:38.189215Z","steps":["trace[1362112805] 'agreement among raft nodes before linearized reading' (duration: 292.811985ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:38.188934Z","caller":"traceutil/trace.go:171","msg":"trace[2063001622] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"292.677193ms","start":"2026-04-24T07:37:37.896229Z","end":"2026-04-24T07:37:38.188906Z","steps":["trace[2063001622] 'read index received' (duration: 280.54129ms)","trace[2063001622] 'applied index is now lower than readState.Index' (duration: 12.134333ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:38.189583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.141893ms","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-24T07:37:38.189645Z","caller":"traceutil/trace.go:171","msg":"trace[1027044634] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"286.221864ms","start":"2026-04-24T07:37:37.903408Z","end":"2026-04-24T07:37:38.18963Z","steps":["trace[1027044634] 'agreement among raft nodes before linearized reading' (duration: 286.075811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:38.189836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.741408ms","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-24T07:37:38.189897Z","caller":"traceutil/trace.go:171","msg":"trace[1238464526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"222.86296ms","start":"2026-04-24T07:37:37.96702Z","end":"2026-04-24T07:37:38.189883Z","steps":["trace[1238464526] 'agreement among raft nodes before linearized reading' (duration: 222.722238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:38.189917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.88934ms","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-24T07:37:38.189962Z","caller":"traceutil/trace.go:171","msg":"trace[883510357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"222.969672ms","start":"2026-04-24T07:37:37.966979Z","end":"2026-04-24T07:37:38.189948Z","steps":["trace[883510357] 'agreement among raft nodes before linearized reading' (duration: 222.85297ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:39.13006Z","caller":"traceutil/trace.go:171","msg":"trace[971285773] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"428.773659ms","start":"2026-04-24T07:37:38.701269Z","end":"2026-04-24T07:37:39.130042Z","steps":["trace[971285773] 'process raft request' (duration: 428.721468ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:39.130061Z","caller":"traceutil/trace.go:171","msg":"trace[1894277302] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1076; }","duration":"353.764224ms","start":"2026-04-24T07:37:38.776279Z","end":"2026-04-24T07:37:39.130043Z","steps":["trace[1894277302] 'read index received' (duration: 298.240361ms)","trace[1894277302] 'applied index is now lower than readState.Index' (duration: 55.523073ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:39.130084Z","caller":"traceutil/trace.go:171","msg":"trace[757202028] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"429.202526ms","start":"2026-04-24T07:37:38.700849Z","end":"2026-04-24T07:37:39.130051Z","steps":["trace[757202028] 'process raft request' (duration: 373.703324ms)","trace[757202028] 'compare' (duration: 55.293679ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:39.130144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:38.70125Z","time spent":"428.85427ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":743,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-24T07:37:39.130209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.914867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-24T07:37:39.130213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:38.700829Z","time spent":"429.323558ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-24T07:37:39.13025Z","caller":"traceutil/trace.go:171","msg":"trace[2111394049] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1037; }","duration":"353.997689ms","start":"2026-04-24T07:37:38.776242Z","end":"2026-04-24T07:37:39.130239Z","steps":["trace[2111394049] 'agreement among raft nodes before linearized reading' (duration: 353.910287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:39.130298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:38.776224Z","time spent":"354.06559ms","remote":"127.0.0.1:52090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-24T07:37:39.130323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.539077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:37:39.13034Z","caller":"traceutil/trace.go:171","msg":"trace[2556527] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1037; }","duration":"339.573948ms","start":"2026-04-24T07:37:38.790762Z","end":"2026-04-24T07:37:39.130336Z","steps":["trace[2556527] 'agreement among raft nodes before linearized reading' (duration: 339.543697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:39.130392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:38.79075Z","time spent":"339.606289ms","remote":"127.0.0.1:52296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-04-24T07:37:39.642479Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219121274823536529,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-24T07:37:39.828117Z","caller":"traceutil/trace.go:171","msg":"trace[1183949109] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1078; }","duration":"686.257457ms","start":"2026-04-24T07:37:39.141831Z","end":"2026-04-24T07:37:39.828089Z","steps":["trace[1183949109] 'read index received' (duration: 661.620147ms)","trace[1183949109] 'applied index is now lower than readState.Index' (duration: 24.63556ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:39.828134Z","caller":"traceutil/trace.go:171","msg":"trace[526370069] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"687.772674ms","start":"2026-04-24T07:37:39.140323Z","end":"2026-04-24T07:37:39.828096Z","steps":["trace[526370069] 'process raft request' (duration: 663.260205ms)","trace[526370069] 'compare' (duration: 23.860297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:39.828327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.470761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-275f980c-f468-4488-85e1-536c22bb08dc\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-04-24T07:37:39.828369Z","caller":"traceutil/trace.go:171","msg":"trace[1777689940] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-275f980c-f468-4488-85e1-536c22bb08dc; range_end:; response_count:1; response_revision:1038; }","duration":"686.556353ms","start":"2026-04-24T07:37:39.141798Z","end":"2026-04-24T07:37:39.828354Z","steps":["trace[1777689940] 'agreement among raft nodes before linearized reading' (duration: 686.452801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:39.828402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:39.141784Z","time spent":"686.610193ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3601,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-275f980c-f468-4488-85e1-536c22bb08dc\" "} {"level":"warn","ts":"2026-04-24T07:37:39.828497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.129061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"warn","ts":"2026-04-24T07:37:39.828292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:39.140306Z","time spent":"687.900245ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:37:39.82861Z","caller":"traceutil/trace.go:171","msg":"trace[484323469] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1038; }","duration":"586.291895ms","start":"2026-04-24T07:37:39.242293Z","end":"2026-04-24T07:37:39.828585Z","steps":["trace[484323469] 'agreement among raft nodes before linearized reading' (duration: 586.01162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:39.828668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:39.242276Z","time spent":"586.380696ms","remote":"127.0.0.1:52160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-04-24T07:37:39.828818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.983613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:37:39.828866Z","caller":"traceutil/trace.go:171","msg":"trace[88706135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1038; }","duration":"240.067975ms","start":"2026-04-24T07:37:39.588787Z","end":"2026-04-24T07:37:39.828855Z","steps":["trace[88706135] 'agreement among raft nodes before linearized reading' (duration: 239.990164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:40.462038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.696876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:37:40.462217Z","caller":"traceutil/trace.go:171","msg":"trace[464213702] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"188.048593ms","start":"2026-04-24T07:37:40.27415Z","end":"2026-04-24T07:37:40.462198Z","steps":["trace[464213702] 'process raft request' (duration: 187.992003ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:40.462315Z","caller":"traceutil/trace.go:171","msg":"trace[1441556040] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"202.680885ms","start":"2026-04-24T07:37:40.259603Z","end":"2026-04-24T07:37:40.462284Z","steps":["trace[1441556040] 'process raft request' (duration: 60.658523ms)","trace[1441556040] 'compare' (duration: 141.556144ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:40.51938Z","caller":"traceutil/trace.go:171","msg":"trace[332319178] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"115.905539ms","start":"2026-04-24T07:37:40.40345Z","end":"2026-04-24T07:37:40.519356Z","steps":["trace[332319178] 'process raft request' (duration: 115.766386ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:42.350139Z","caller":"traceutil/trace.go:171","msg":"trace[1412768269] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"147.366247ms","start":"2026-04-24T07:37:42.202751Z","end":"2026-04-24T07:37:42.350117Z","steps":["trace[1412768269] 'process raft request' (duration: 147.179124ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:42.486741Z","caller":"traceutil/trace.go:171","msg":"trace[1550890884] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"131.980815ms","start":"2026-04-24T07:37:42.354728Z","end":"2026-04-24T07:37:42.486709Z","steps":["trace[1550890884] 'process raft request' (duration: 93.92164ms)","trace[1550890884] 'compare' (duration: 37.963343ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:42.549907Z","caller":"traceutil/trace.go:171","msg":"trace[747544528] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"195.071548ms","start":"2026-04-24T07:37:42.354806Z","end":"2026-04-24T07:37:42.549878Z","steps":["trace[747544528] 'process raft request' (duration: 194.885065ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:44.392515Z","caller":"traceutil/trace.go:171","msg":"trace[1769150745] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"177.974252ms","start":"2026-04-24T07:37:44.21452Z","end":"2026-04-24T07:37:44.392494Z","steps":["trace[1769150745] 'process raft request' (duration: 177.85774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:44.599612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.699576ms","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-24T07:37:44.59971Z","caller":"traceutil/trace.go:171","msg":"trace[1253084019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1060; }","duration":"108.831338ms","start":"2026-04-24T07:37:44.490864Z","end":"2026-04-24T07:37:44.599695Z","steps":["trace[1253084019] 'range keys from in-memory index tree' (duration: 108.547383ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:44.755484Z","caller":"traceutil/trace.go:171","msg":"trace[1000234545] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"151.206496ms","start":"2026-04-24T07:37:44.604248Z","end":"2026-04-24T07:37:44.755454Z","steps":["trace[1000234545] 'process raft request' (duration: 96.732681ms)","trace[1000234545] 'compare' (duration: 54.242741ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:44.755516Z","caller":"traceutil/trace.go:171","msg":"trace[2072423774] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"150.965722ms","start":"2026-04-24T07:37:44.604531Z","end":"2026-04-24T07:37:44.755496Z","steps":["trace[2072423774] 'process raft request' (duration: 150.81572ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:44.755661Z","caller":"traceutil/trace.go:171","msg":"trace[1750288766] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1102; }","duration":"107.05186ms","start":"2026-04-24T07:37:44.648371Z","end":"2026-04-24T07:37:44.755422Z","steps":["trace[1750288766] 'read index received' (duration: 7.699995ms)","trace[1750288766] 'applied index is now lower than readState.Index' (duration: 99.350445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:37:44.75578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.386355ms","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-24T07:37:44.755848Z","caller":"traceutil/trace.go:171","msg":"trace[1546708910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1063; }","duration":"107.493746ms","start":"2026-04-24T07:37:44.648338Z","end":"2026-04-24T07:37:44.755831Z","steps":["trace[1546708910] 'agreement among raft nodes before linearized reading' (duration: 107.307944ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:37:48.609794Z","caller":"traceutil/trace.go:171","msg":"trace[1852952275] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"185.301816ms","start":"2026-04-24T07:37:48.424466Z","end":"2026-04-24T07:37:48.609768Z","steps":["trace[1852952275] 'read index received' (duration: 185.171574ms)","trace[1852952275] 'applied index is now lower than readState.Index' (duration: 129.152µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:37:48.609956Z","caller":"traceutil/trace.go:171","msg":"trace[1196883646] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"602.626464ms","start":"2026-04-24T07:37:48.007318Z","end":"2026-04-24T07:37:48.609945Z","steps":["trace[1196883646] 'process raft request' (duration: 602.263658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:48.610234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:37:48.007296Z","time spent":"602.694975ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:37:48.610286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.797564ms","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-24T07:37:48.610544Z","caller":"traceutil/trace.go:171","msg":"trace[800800613] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1088; }","duration":"186.10591ms","start":"2026-04-24T07:37:48.424412Z","end":"2026-04-24T07:37:48.610518Z","steps":["trace[800800613] 'agreement among raft nodes before linearized reading' (duration: 185.800405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:49.160347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.355704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:37:49.16049Z","caller":"traceutil/trace.go:171","msg":"trace[1910349468] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1095; }","duration":"112.545847ms","start":"2026-04-24T07:37:49.047882Z","end":"2026-04-24T07:37:49.160427Z","steps":["trace[1910349468] 'count revisions from in-memory index tree' (duration: 112.252762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:37:57.669983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.714632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-24T07:37:57.670646Z","caller":"traceutil/trace.go:171","msg":"trace[2097495069] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1126; }","duration":"115.451823ms","start":"2026-04-24T07:37:57.555169Z","end":"2026-04-24T07:37:57.670621Z","steps":["trace[2097495069] 'count revisions from in-memory index tree' (duration: 114.60636ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:01.001686Z","caller":"traceutil/trace.go:171","msg":"trace[1223187900] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"236.934417ms","start":"2026-04-24T07:38:00.764729Z","end":"2026-04-24T07:38:01.001664Z","steps":["trace[1223187900] 'read index received' (duration: 236.763435ms)","trace[1223187900] 'applied index is now lower than readState.Index' (duration: 169.712µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:01.001785Z","caller":"traceutil/trace.go:171","msg":"trace[708075825] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"974.30535ms","start":"2026-04-24T07:38:00.027442Z","end":"2026-04-24T07:38:01.001748Z","steps":["trace[708075825] 'process raft request' (duration: 974.059776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.001907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.14218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:01.001961Z","caller":"traceutil/trace.go:171","msg":"trace[2027303218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1136; }","duration":"237.261023ms","start":"2026-04-24T07:38:00.764687Z","end":"2026-04-24T07:38:01.001948Z","steps":["trace[2027303218] 'agreement among raft nodes before linearized reading' (duration: 237.146761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.001973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.027423Z","time spent":"974.447961ms","remote":"127.0.0.1:52234","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-24T07:38:01.306655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.539416ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:38:01.306802Z","caller":"traceutil/trace.go:171","msg":"trace[98369894] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"304.982452ms","start":"2026-04-24T07:38:01.0018Z","end":"2026-04-24T07:38:01.306782Z","steps":["trace[98369894] 'read index received' (duration: 117.232033ms)","trace[98369894] 'applied index is now lower than readState.Index' (duration: 187.748629ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:38:01.306987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.405292ms","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-24T07:38:01.307035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.059446ms","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-24T07:38:01.307064Z","caller":"traceutil/trace.go:171","msg":"trace[1685196439] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1137; }","duration":"377.501553ms","start":"2026-04-24T07:38:00.929544Z","end":"2026-04-24T07:38:01.307046Z","steps":["trace[1685196439] 'agreement among raft nodes before linearized reading' (duration: 377.32162ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:01.307078Z","caller":"traceutil/trace.go:171","msg":"trace[779714599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1137; }","duration":"381.137107ms","start":"2026-04-24T07:38:00.925928Z","end":"2026-04-24T07:38:01.307065Z","steps":["trace[779714599] 'agreement among raft nodes before linearized reading' (duration: 380.960364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.307107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.929536Z","time spent":"377.561994ms","remote":"127.0.0.1:52234","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-24T07:38:01.307135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.925907Z","time spent":"381.216509ms","remote":"127.0.0.1:52234","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-24T07:38:01.306988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.934164ms","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-24T07:38:01.30727Z","caller":"traceutil/trace.go:171","msg":"trace[2098147418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1137; }","duration":"381.350901ms","start":"2026-04-24T07:38:00.925909Z","end":"2026-04-24T07:38:01.30726Z","steps":["trace[2098147418] 'agreement among raft nodes before linearized reading' (duration: 380.893684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.307302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.925889Z","time spent":"381.403961ms","remote":"127.0.0.1:52234","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-24T07:38:01.307305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.521974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:01.307359Z","caller":"traceutil/trace.go:171","msg":"trace[179134420] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1137; }","duration":"530.611286ms","start":"2026-04-24T07:38:00.776732Z","end":"2026-04-24T07:38:01.307343Z","steps":["trace[179134420] 'agreement among raft nodes before linearized reading' (duration: 530.313962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.307414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.776713Z","time spent":"530.687837ms","remote":"127.0.0.1:52088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-04-24T07:38:01.307402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.890627ms","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-24T07:38:01.307449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.147038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-24T07:38:01.307472Z","caller":"traceutil/trace.go:171","msg":"trace[862353007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1137; }","duration":"451.005588ms","start":"2026-04-24T07:38:00.856449Z","end":"2026-04-24T07:38:01.307455Z","steps":["trace[862353007] 'agreement among raft nodes before linearized reading' (duration: 450.780394ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:01.307498Z","caller":"traceutil/trace.go:171","msg":"trace[1335174615] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:1137; }","duration":"294.222549ms","start":"2026-04-24T07:38:01.013264Z","end":"2026-04-24T07:38:01.307486Z","steps":["trace[1335174615] 'agreement among raft nodes before linearized reading' (duration: 294.102087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.307532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.856432Z","time spent":"451.074679ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-24T07:38:01.307827Z","caller":"traceutil/trace.go:171","msg":"trace[268038801] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"385.055937ms","start":"2026-04-24T07:38:00.922745Z","end":"2026-04-24T07:38:01.3078Z","steps":["trace[268038801] 'process raft request' (duration: 196.295653ms)","trace[268038801] 'compare' (duration: 187.442574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:38:01.308331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:00.922723Z","time spent":"385.528434ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:38:01.826364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.139556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:38:01.826642Z","caller":"traceutil/trace.go:171","msg":"trace[473068284] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1184; }","duration":"283.491036ms","start":"2026-04-24T07:38:01.543134Z","end":"2026-04-24T07:38:01.826625Z","steps":["trace[473068284] 'read index received' (duration: 237.477771ms)","trace[473068284] 'applied index is now lower than readState.Index' (duration: 46.012305ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:01.82674Z","caller":"traceutil/trace.go:171","msg":"trace[717272938] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"512.979706ms","start":"2026-04-24T07:38:01.313746Z","end":"2026-04-24T07:38:01.826726Z","steps":["trace[717272938] 'process raft request' (duration: 111.398845ms)","trace[717272938] 'compare' (duration: 401.031613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:38:01.826809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:01.313721Z","time spent":"513.053399ms","remote":"127.0.0.1:52234","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-24T07:38:01.826925Z","caller":"traceutil/trace.go:171","msg":"trace[1436659137] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"478.13064ms","start":"2026-04-24T07:38:01.348758Z","end":"2026-04-24T07:38:01.826888Z","steps":["trace[1436659137] 'process raft request' (duration: 477.828684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.827038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.122436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:01.827097Z","caller":"traceutil/trace.go:171","msg":"trace[641102323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1142; }","duration":"239.269749ms","start":"2026-04-24T07:38:01.587811Z","end":"2026-04-24T07:38:01.827081Z","steps":["trace[641102323] 'agreement among raft nodes before linearized reading' (duration: 239.122836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.827221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:01.348739Z","time spent":"478.338452ms","remote":"127.0.0.1:52006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:38:01.827389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.242348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-24T07:38:01.827446Z","caller":"traceutil/trace.go:171","msg":"trace[1936120505] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1142; }","duration":"284.33254ms","start":"2026-04-24T07:38:01.5431Z","end":"2026-04-24T07:38:01.827432Z","steps":["trace[1936120505] 'agreement among raft nodes before linearized reading' (duration: 284.227638ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:01.827525Z","caller":"traceutil/trace.go:171","msg":"trace[1924290603] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"513.726339ms","start":"2026-04-24T07:38:01.313778Z","end":"2026-04-24T07:38:01.827504Z","steps":["trace[1924290603] 'process raft request' (duration: 512.680812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.827646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:01.313758Z","time spent":"513.83388ms","remote":"127.0.0.1:52234","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-24T07:38:01.828127Z","caller":"traceutil/trace.go:171","msg":"trace[1832423109] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"514.296117ms","start":"2026-04-24T07:38:01.313809Z","end":"2026-04-24T07:38:01.828105Z","steps":["trace[1832423109] 'process raft request' (duration: 512.703342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.828233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:01.313775Z","time spent":"514.406879ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:38:01.828133Z","caller":"traceutil/trace.go:171","msg":"trace[1339145660] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"514.072444ms","start":"2026-04-24T07:38:01.314044Z","end":"2026-04-24T07:38:01.828116Z","steps":["trace[1339145660] 'process raft request' (duration: 512.50451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:01.828404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:01.313996Z","time spent":"514.358538ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-24T07:38:02.790215Z","caller":"traceutil/trace.go:171","msg":"trace[1036896152] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1143; }","duration":"104.039537ms","start":"2026-04-24T07:38:02.68614Z","end":"2026-04-24T07:38:02.79018Z","steps":["trace[1036896152] 'process raft request' (duration: 103.694542ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:06.022594Z","caller":"traceutil/trace.go:171","msg":"trace[1961619709] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1201; }","duration":"100.374055ms","start":"2026-04-24T07:38:05.922195Z","end":"2026-04-24T07:38:06.022569Z","steps":["trace[1961619709] 'read index received' (duration: 100.209782ms)","trace[1961619709] 'applied index is now lower than readState.Index' (duration: 163.073µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:06.022644Z","caller":"traceutil/trace.go:171","msg":"trace[1925407512] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"129.864513ms","start":"2026-04-24T07:38:05.892752Z","end":"2026-04-24T07:38:06.022617Z","steps":["trace[1925407512] 'process raft request' (duration: 129.666361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:06.022832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.615798ms","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-24T07:38:06.022869Z","caller":"traceutil/trace.go:171","msg":"trace[683289292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1155; }","duration":"100.70438ms","start":"2026-04-24T07:38:05.922153Z","end":"2026-04-24T07:38:06.022857Z","steps":["trace[683289292] 'agreement among raft nodes before linearized reading' (duration: 100.561818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:06.022935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.358624ms","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-24T07:38:06.022996Z","caller":"traceutil/trace.go:171","msg":"trace[930366198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1155; }","duration":"100.441125ms","start":"2026-04-24T07:38:05.922541Z","end":"2026-04-24T07:38:06.022982Z","steps":["trace[930366198] 'agreement among raft nodes before linearized reading' (duration: 100.296153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:06.023147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.402684ms","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-24T07:38:06.023191Z","caller":"traceutil/trace.go:171","msg":"trace[2121047303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1155; }","duration":"100.467347ms","start":"2026-04-24T07:38:05.922713Z","end":"2026-04-24T07:38:06.02318Z","steps":["trace[2121047303] 'agreement among raft nodes before linearized reading' (duration: 100.364564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:06.47691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.265773ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-24T07:38:06.477059Z","caller":"traceutil/trace.go:171","msg":"trace[800675400] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"340.040409ms","start":"2026-04-24T07:38:06.136992Z","end":"2026-04-24T07:38:06.477032Z","steps":["trace[800675400] 'read index received' (duration: 139.584423ms)","trace[800675400] 'applied index is now lower than readState.Index' (duration: 200.453286ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:38:06.477268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.254552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-04-24T07:38:06.477415Z","caller":"traceutil/trace.go:171","msg":"trace[1904351115] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1158; }","duration":"340.401473ms","start":"2026-04-24T07:38:06.136949Z","end":"2026-04-24T07:38:06.47735Z","steps":["trace[1904351115] 'agreement among raft nodes before linearized reading' (duration: 340.16218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:06.477482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:06.136932Z","time spent":"340.532655ms","remote":"127.0.0.1:52038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12778,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"info","ts":"2026-04-24T07:38:07.974591Z","caller":"traceutil/trace.go:171","msg":"trace[1119710858] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1208; }","duration":"124.820445ms","start":"2026-04-24T07:38:07.849749Z","end":"2026-04-24T07:38:07.974569Z","steps":["trace[1119710858] 'read index received' (duration: 124.624992ms)","trace[1119710858] 'applied index is now lower than readState.Index' (duration: 194.583µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:07.974929Z","caller":"traceutil/trace.go:171","msg":"trace[1525384267] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"137.582305ms","start":"2026-04-24T07:38:07.837289Z","end":"2026-04-24T07:38:07.974871Z","steps":["trace[1525384267] 'process raft request' (duration: 137.152608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:07.975744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.986793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" limit:500 ","response":"range_response_count:133 size:99944"} {"level":"info","ts":"2026-04-24T07:38:07.975815Z","caller":"traceutil/trace.go:171","msg":"trace[965127905] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:133; response_revision:1161; }","duration":"126.092735ms","start":"2026-04-24T07:38:07.849707Z","end":"2026-04-24T07:38:07.9758Z","steps":["trace[965127905] 'agreement among raft nodes before linearized reading' (duration: 125.433764ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:09.315734Z","caller":"traceutil/trace.go:171","msg":"trace[1895947823] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"240.885528ms","start":"2026-04-24T07:38:09.074826Z","end":"2026-04-24T07:38:09.315711Z","steps":["trace[1895947823] 'read index received' (duration: 240.832418ms)","trace[1895947823] 'applied index is now lower than readState.Index' (duration: 52.03µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:09.315993Z","caller":"traceutil/trace.go:171","msg":"trace[1262976278] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"249.8848ms","start":"2026-04-24T07:38:09.066071Z","end":"2026-04-24T07:38:09.315955Z","steps":["trace[1262976278] 'process raft request' (duration: 249.486564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:09.316152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.313504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" ","response":"range_response_count:1 size:706"} {"level":"info","ts":"2026-04-24T07:38:09.316265Z","caller":"traceutil/trace.go:171","msg":"trace[1620147724] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient; range_end:; response_count:1; response_revision:1166; }","duration":"241.456426ms","start":"2026-04-24T07:38:09.074788Z","end":"2026-04-24T07:38:09.316244Z","steps":["trace[1620147724] 'agreement among raft nodes before linearized reading' (duration: 241.232503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:09.528088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.553422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:38:09.528272Z","caller":"traceutil/trace.go:171","msg":"trace[1214920527] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"374.613522ms","start":"2026-04-24T07:38:09.153623Z","end":"2026-04-24T07:38:09.528237Z","steps":["trace[1214920527] 'process raft request' (duration: 225.829937ms)","trace[1214920527] 'compare' (duration: 148.353179ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:09.528319Z","caller":"traceutil/trace.go:171","msg":"trace[128717277] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"106.498284ms","start":"2026-04-24T07:38:09.421802Z","end":"2026-04-24T07:38:09.528301Z","steps":["trace[128717277] 'process raft request' (duration: 106.401153ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:09.528325Z","caller":"traceutil/trace.go:171","msg":"trace[1886046832] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1214; }","duration":"212.43172ms","start":"2026-04-24T07:38:09.31588Z","end":"2026-04-24T07:38:09.528311Z","steps":["trace[1886046832] 'read index received' (duration: 63.559914ms)","trace[1886046832] 'applied index is now lower than readState.Index' (duration: 148.870856ms)"],"step_count":2} {"level":"warn","ts":"2026-04-24T07:38:09.528441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:09.153602Z","time spent":"374.739225ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-24T07:38:09.528566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.746225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:09.528644Z","caller":"traceutil/trace.go:171","msg":"trace[1936739045] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1168; }","duration":"229.873847ms","start":"2026-04-24T07:38:09.298758Z","end":"2026-04-24T07:38:09.528632Z","steps":["trace[1936739045] 'agreement among raft nodes before linearized reading' (duration: 229.699104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:09.528728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.664125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" ","response":"range_response_count:1 size:718"} {"level":"info","ts":"2026-04-24T07:38:09.528774Z","caller":"traceutil/trace.go:171","msg":"trace[1177567045] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient; range_end:; response_count:1; response_revision:1168; }","duration":"385.737976ms","start":"2026-04-24T07:38:09.143024Z","end":"2026-04-24T07:38:09.528762Z","steps":["trace[1177567045] 'agreement among raft nodes before linearized reading' (duration: 385.653145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:09.528751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.158138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" ","response":"range_response_count:1 size:706"} {"level":"warn","ts":"2026-04-24T07:38:09.528805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:09.143007Z","time spent":"385.790006ms","remote":"127.0.0.1:52344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":741,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" "} {"level":"info","ts":"2026-04-24T07:38:09.528828Z","caller":"traceutil/trace.go:171","msg":"trace[1620697044] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient; range_end:; response_count:1; response_revision:1168; }","duration":"144.276939ms","start":"2026-04-24T07:38:09.384528Z","end":"2026-04-24T07:38:09.528805Z","steps":["trace[1620697044] 'agreement among raft nodes before linearized reading' (duration: 144.151688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:14.470534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.010347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-24T07:38:14.470648Z","caller":"traceutil/trace.go:171","msg":"trace[464851445] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"287.865799ms","start":"2026-04-24T07:38:14.182762Z","end":"2026-04-24T07:38:14.470628Z","steps":["trace[464851445] 'process raft request' (duration: 47.679469ms)","trace[464851445] 'compare' (duration: 239.876375ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:14.476855Z","caller":"traceutil/trace.go:171","msg":"trace[904558598] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1231; }","duration":"285.814818ms","start":"2026-04-24T07:38:14.191019Z","end":"2026-04-24T07:38:14.476834Z","steps":["trace[904558598] 'read index received' (duration: 39.402529ms)","trace[904558598] 'applied index is now lower than readState.Index' (duration: 246.411509ms)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:14.476963Z","caller":"traceutil/trace.go:171","msg":"trace[1973460954] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"293.845175ms","start":"2026-04-24T07:38:14.183105Z","end":"2026-04-24T07:38:14.47695Z","steps":["trace[1973460954] 'process raft request' (duration: 293.617792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:14.477294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.799031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-controller\" ","response":"range_response_count:1 size:724"} {"level":"info","ts":"2026-04-24T07:38:14.477373Z","caller":"traceutil/trace.go:171","msg":"trace[451091355] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-controller; range_end:; response_count:1; response_revision:1184; }","duration":"225.925733ms","start":"2026-04-24T07:38:14.251428Z","end":"2026-04-24T07:38:14.477354Z","steps":["trace[451091355] 'agreement among raft nodes before linearized reading' (duration: 225.76799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:14.477398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.842733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-04-24T07:38:14.477477Z","caller":"traceutil/trace.go:171","msg":"trace[1347827564] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1184; }","duration":"214.953354ms","start":"2026-04-24T07:38:14.262503Z","end":"2026-04-24T07:38:14.477457Z","steps":["trace[1347827564] 'agreement among raft nodes before linearized reading' (duration: 214.829682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:14.477751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.717792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-24T07:38:14.477805Z","caller":"traceutil/trace.go:171","msg":"trace[55716037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1184; }","duration":"286.793453ms","start":"2026-04-24T07:38:14.190996Z","end":"2026-04-24T07:38:14.47779Z","steps":["trace[55716037] 'agreement among raft nodes before linearized reading' (duration: 286.074322ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:18.303546Z","caller":"traceutil/trace.go:171","msg":"trace[512814510] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"226.621962ms","start":"2026-04-24T07:38:18.076902Z","end":"2026-04-24T07:38:18.303524Z","steps":["trace[512814510] 'read index received' (duration: 226.426749ms)","trace[512814510] 'applied index is now lower than readState.Index' (duration: 194.253µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:18.303563Z","caller":"traceutil/trace.go:171","msg":"trace[1844939551] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"253.648317ms","start":"2026-04-24T07:38:18.049899Z","end":"2026-04-24T07:38:18.303547Z","steps":["trace[1844939551] 'process raft request' (duration: 253.451744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:18.303649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.740364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-04-24T07:38:18.303675Z","caller":"traceutil/trace.go:171","msg":"trace[424659562] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:1; response_revision:1194; }","duration":"226.783875ms","start":"2026-04-24T07:38:18.076884Z","end":"2026-04-24T07:38:18.303668Z","steps":["trace[424659562] 'agreement among raft nodes before linearized reading' (duration: 226.706973ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:18.317363Z","caller":"traceutil/trace.go:171","msg":"trace[1533664157] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"230.482027ms","start":"2026-04-24T07:38:18.086861Z","end":"2026-04-24T07:38:18.317343Z","steps":["trace[1533664157] 'process raft request' (duration: 230.293894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:18.317364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.544747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-04-24T07:38:18.317432Z","caller":"traceutil/trace.go:171","msg":"trace[734638717] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:1195; }","duration":"192.656318ms","start":"2026-04-24T07:38:18.124765Z","end":"2026-04-24T07:38:18.317421Z","steps":["trace[734638717] 'agreement among raft nodes before linearized reading' (duration: 192.510786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:18.317565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.475982ms","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-24T07:38:18.31762Z","caller":"traceutil/trace.go:171","msg":"trace[799944190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1195; }","duration":"121.579494ms","start":"2026-04-24T07:38:18.196031Z","end":"2026-04-24T07:38:18.317611Z","steps":["trace[799944190] 'agreement among raft nodes before linearized reading' (duration: 121.33476ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:21.89784Z","caller":"traceutil/trace.go:171","msg":"trace[1302473685] linearizableReadLoop","detail":"{readStateIndex:1260; appliedIndex:1259; }","duration":"206.755292ms","start":"2026-04-24T07:38:21.691067Z","end":"2026-04-24T07:38:21.897822Z","steps":["trace[1302473685] 'read index received' (duration: 206.584899ms)","trace[1302473685] 'applied index is now lower than readState.Index' (duration: 169.783µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:21.89805Z","caller":"traceutil/trace.go:171","msg":"trace[1246187944] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"220.190251ms","start":"2026-04-24T07:38:21.67785Z","end":"2026-04-24T07:38:21.898041Z","steps":["trace[1246187944] 'process raft request' (duration: 219.853826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:21.898239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.212516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-24T07:38:21.89826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.185167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-24T07:38:21.89829Z","caller":"traceutil/trace.go:171","msg":"trace[1263903730] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1209; }","duration":"197.344408ms","start":"2026-04-24T07:38:21.700936Z","end":"2026-04-24T07:38:21.89828Z","steps":["trace[1263903730] 'agreement among raft nodes before linearized reading' (duration: 197.162535ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:21.898329Z","caller":"traceutil/trace.go:171","msg":"trace[1234212398] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1209; }","duration":"207.275029ms","start":"2026-04-24T07:38:21.691023Z","end":"2026-04-24T07:38:21.898298Z","steps":["trace[1234212398] 'agreement among raft nodes before linearized reading' (duration: 207.100997ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:22.856104Z","caller":"traceutil/trace.go:171","msg":"trace[2019136880] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1261; }","duration":"294.709723ms","start":"2026-04-24T07:38:22.561367Z","end":"2026-04-24T07:38:22.856077Z","steps":["trace[2019136880] 'read index received' (duration: 294.390908ms)","trace[2019136880] 'applied index is now lower than readState.Index' (duration: 317.905µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:22.856187Z","caller":"traceutil/trace.go:171","msg":"trace[1496440398] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"306.146863ms","start":"2026-04-24T07:38:22.55002Z","end":"2026-04-24T07:38:22.856167Z","steps":["trace[1496440398] 'process raft request' (duration: 305.854689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-24T07:38:22.55Z","time spent":"306.234935ms","remote":"127.0.0.1:52234","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-24T07:38:22.856438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.067118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/default\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-24T07:38:22.85701Z","caller":"traceutil/trace.go:171","msg":"trace[1297818022] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/default; range_end:; response_count:1; response_revision:1211; }","duration":"295.665756ms","start":"2026-04-24T07:38:22.561328Z","end":"2026-04-24T07:38:22.856994Z","steps":["trace[1297818022] 'agreement among raft nodes before linearized reading' (duration: 294.928155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.918716ms","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-24T07:38:22.857319Z","caller":"traceutil/trace.go:171","msg":"trace[818633095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1211; }","duration":"207.634855ms","start":"2026-04-24T07:38:22.649649Z","end":"2026-04-24T07:38:22.857284Z","steps":["trace[818633095] 'agreement among raft nodes before linearized reading' (duration: 206.842054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.224285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/\" range_end:\"/registry/configmaps/kube-public0\" limit:500 ","response":"range_response_count:2 size:3916"} {"level":"info","ts":"2026-04-24T07:38:22.857459Z","caller":"traceutil/trace.go:171","msg":"trace[1370990721] range","detail":"{range_begin:/registry/configmaps/kube-public/; range_end:/registry/configmaps/kube-public0; response_count:2; response_revision:1211; }","duration":"231.113788ms","start":"2026-04-24T07:38:22.626327Z","end":"2026-04-24T07:38:22.857441Z","steps":["trace[1370990721] 'agreement among raft nodes before linearized reading' (duration: 230.196475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.58202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-public/\" range_end:\"/registry/cronjobs/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:22.857601Z","caller":"traceutil/trace.go:171","msg":"trace[1715723433] range","detail":"{range_begin:/registry/cronjobs/kube-public/; range_end:/registry/cronjobs/kube-public0; response_count:0; response_revision:1211; }","duration":"241.568433ms","start":"2026-04-24T07:38:22.616008Z","end":"2026-04-24T07:38:22.857576Z","steps":["trace[1715723433] 'agreement among raft nodes before linearized reading' (duration: 240.60079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.299669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-24T07:38:22.857749Z","caller":"traceutil/trace.go:171","msg":"trace[1776327280] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role; range_end:; response_count:1; response_revision:1211; }","duration":"271.434195ms","start":"2026-04-24T07:38:22.586295Z","end":"2026-04-24T07:38:22.857729Z","steps":["trace[1776327280] 'agreement among raft nodes before linearized reading' (duration: 270.150486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.85668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.722261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:22.857848Z","caller":"traceutil/trace.go:171","msg":"trace[2007781928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"270.905468ms","start":"2026-04-24T07:38:22.586928Z","end":"2026-04-24T07:38:22.857833Z","steps":["trace[2007781928] 'agreement among raft nodes before linearized reading' (duration: 269.736032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:22.856671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.297066ms","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-24T07:38:22.85796Z","caller":"traceutil/trace.go:171","msg":"trace[860414567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1211; }","duration":"236.584264ms","start":"2026-04-24T07:38:22.621358Z","end":"2026-04-24T07:38:22.857942Z","steps":["trace[860414567] 'agreement among raft nodes before linearized reading' (duration: 235.113093ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:24.016856Z","caller":"traceutil/trace.go:171","msg":"trace[1204946209] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"102.976217ms","start":"2026-04-24T07:38:23.913856Z","end":"2026-04-24T07:38:24.016832Z","steps":["trace[1204946209] 'read index received' (duration: 102.772454ms)","trace[1204946209] 'applied index is now lower than readState.Index' (duration: 202.523µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:24.017024Z","caller":"traceutil/trace.go:171","msg":"trace[1513969292] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"114.073232ms","start":"2026-04-24T07:38:23.902938Z","end":"2026-04-24T07:38:24.017011Z","steps":["trace[1513969292] 'process raft request' (duration: 113.750278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.017417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.566024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4460"} {"level":"info","ts":"2026-04-24T07:38:24.017499Z","caller":"traceutil/trace.go:171","msg":"trace[1565959835] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1215; }","duration":"103.700736ms","start":"2026-04-24T07:38:23.913779Z","end":"2026-04-24T07:38:24.01748Z","steps":["trace[1565959835] 'agreement among raft nodes before linearized reading' (duration: 103.467883ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:24.59545Z","caller":"traceutil/trace.go:171","msg":"trace[1157531696] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"201.581424ms","start":"2026-04-24T07:38:24.393848Z","end":"2026-04-24T07:38:24.59543Z","steps":["trace[1157531696] 'read index received' (duration: 201.408941ms)","trace[1157531696] 'applied index is now lower than readState.Index' (duration: 171.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-24T07:38:24.595517Z","caller":"traceutil/trace.go:171","msg":"trace[148839408] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"208.900756ms","start":"2026-04-24T07:38:24.386571Z","end":"2026-04-24T07:38:24.595472Z","steps":["trace[148839408] 'process raft request' (duration: 208.736754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.595635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.760887ms","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-24T07:38:24.595699Z","caller":"traceutil/trace.go:171","msg":"trace[1455126671] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1216; }","duration":"201.863238ms","start":"2026-04-24T07:38:24.393816Z","end":"2026-04-24T07:38:24.59568Z","steps":["trace[1455126671] 'agreement among raft nodes before linearized reading' (duration: 201.756167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.595697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.611274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-24T07:38:24.595775Z","caller":"traceutil/trace.go:171","msg":"trace[1510227877] range","detail":"{range_begin:/registry/statefulsets/kube-node-lease/; range_end:/registry/statefulsets/kube-node-lease0; response_count:0; response_revision:1216; }","duration":"191.739346ms","start":"2026-04-24T07:38:24.404017Z","end":"2026-04-24T07:38:24.595756Z","steps":["trace[1510227877] 'agreement among raft nodes before linearized reading' (duration: 191.606714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.5959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.185117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/\" range_end:\"/registry/daemonsets/kube-system0\" limit:500 ","response":"range_response_count:2 size:17391"} {"level":"info","ts":"2026-04-24T07:38:24.59599Z","caller":"traceutil/trace.go:171","msg":"trace[59043753] range","detail":"{range_begin:/registry/daemonsets/kube-system/; range_end:/registry/daemonsets/kube-system0; response_count:2; response_revision:1216; }","duration":"136.325299ms","start":"2026-04-24T07:38:24.459646Z","end":"2026-04-24T07:38:24.595971Z","steps":["trace[59043753] 'agreement among raft nodes before linearized reading' (duration: 136.047095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.596003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.244028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-04-24T07:38:24.596066Z","caller":"traceutil/trace.go:171","msg":"trace[1674960632] range","detail":"{range_begin:/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1216; }","duration":"161.326509ms","start":"2026-04-24T07:38:24.434719Z","end":"2026-04-24T07:38:24.596046Z","steps":["trace[1674960632] 'agreement among raft nodes before linearized reading' (duration: 161.213458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:24.596125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.345277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-04-24T07:38:24.596175Z","caller":"traceutil/trace.go:171","msg":"trace[945450139] range","detail":"{range_begin:/registry/configmaps/kube-public/kube-root-ca.crt; range_end:; response_count:1; response_revision:1216; }","duration":"180.423468ms","start":"2026-04-24T07:38:24.415738Z","end":"2026-04-24T07:38:24.596161Z","steps":["trace[945450139] 'agreement among raft nodes before linearized reading' (duration: 180.252234ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:33.619547Z","caller":"traceutil/trace.go:171","msg":"trace[268372325] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"109.040111ms","start":"2026-04-24T07:38:33.510483Z","end":"2026-04-24T07:38:33.619523Z","steps":["trace[268372325] 'process raft request' (duration: 108.896239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-24T07:38:33.619642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.990461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-04-24T07:38:33.619704Z","caller":"traceutil/trace.go:171","msg":"trace[1111391245] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1247; }","duration":"101.094192ms","start":"2026-04-24T07:38:33.518594Z","end":"2026-04-24T07:38:33.619689Z","steps":["trace[1111391245] 'agreement among raft nodes before linearized reading' (duration: 100.976831ms)"],"step_count":1} {"level":"info","ts":"2026-04-24T07:38:33.619555Z","caller":"traceutil/trace.go:171","msg":"trace[1661013113] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1300; }","duration":"100.898129ms","start":"2026-04-24T07:38:33.518632Z","end":"2026-04-24T07:38:33.61953Z","steps":["trace[1661013113] 'read index received' (duration: 100.868869ms)","trace[1661013113] 'applied index is now lower than readState.Index' (duration: 24.79µs)"],"step_count":2}