{"level":"warn","ts":"2026-04-17T11:05:50.992905Z","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-17T11:05:50.993001Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-17T11:05:50.993069Z","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-17T11:05:50.993087Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-17T11:05:50.993106Z","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-17T11:05:50.993696Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-04-17T11:05:50.993767Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-17T11:05:51.016197Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"16.786156ms"} {"level":"info","ts":"2026-04-17T11:05:51.061857Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-04-17T11:05:51.061949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T11:05:51.061972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-04-17T11:05:51.061983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T11:05:51.061997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-04-17T11:05:51.062033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-04-17T11:05:51.191369Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T11:05:51.198029Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T11:05:51.202172Z","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-17T11:05:51.205246Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T11:05:51.205369Z","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-17T11:05:51.205452Z","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-17T11:05:51.205464Z","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-17T11:05:51.206859Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T11:05:51.21841Z","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-17T11:05:51.218661Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-17T11:05:51.218685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-17T11:05:51.219239Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T11:05:51.21928Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T11:05:51.233325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-04-17T11:05:51.23462Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-17T11:05:51.663201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T11:05:51.663313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T11:05:51.663349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-04-17T11:05:51.663371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-04-17T11:05:51.663382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-17T11:05:51.6634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-04-17T11:05:51.663421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-17T11:05:51.677504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T11:05:51.677508Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T11:05:51.677497Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T11:05:51.677691Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T11:05:51.679057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T11:05:51.679215Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T11:05:51.679265Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T11:05:51.679932Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T11:05:51.679966Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T11:05:51.682153Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T11:05:51.68288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"warn","ts":"2026-04-17T11:06:10.037738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.315863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:06:10.037837Z","caller":"traceutil/trace.go:171","msg":"trace[303258872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"388.475226ms","start":"2026-04-17T11:06:09.649346Z","end":"2026-04-17T11:06:10.037822Z","steps":["trace[303258872] 'range keys from in-memory index tree' (duration: 388.174241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:10.037813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.117001ms","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-17T11:06:10.037889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:09.649324Z","time spent":"388.557447ms","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T11:06:10.03792Z","caller":"traceutil/trace.go:171","msg":"trace[548501000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"671.274574ms","start":"2026-04-17T11:06:09.36662Z","end":"2026-04-17T11:06:10.037894Z","steps":["trace[548501000] 'range keys from in-memory index tree' (duration: 671.01578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:10.037965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:09.366604Z","time spent":"671.352755ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T11:06:10.521347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.323177ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-17T11:06:10.521553Z","caller":"traceutil/trace.go:171","msg":"trace[2091340533] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"480.283698ms","start":"2026-04-17T11:06:10.041255Z","end":"2026-04-17T11:06:10.521539Z","steps":["trace[2091340533] 'process raft request' (duration: 480.178876ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:10.521548Z","caller":"traceutil/trace.go:171","msg":"trace[680549716] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:418; }","duration":"482.397515ms","start":"2026-04-17T11:06:10.039123Z","end":"2026-04-17T11:06:10.521521Z","steps":["trace[680549716] 'read index received' (duration: 92.839864ms)","trace[680549716] 'applied index is now lower than readState.Index' (duration: 389.555701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:10.521653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.512827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:06:10.521678Z","caller":"traceutil/trace.go:171","msg":"trace[1539845831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:405; }","duration":"482.587598ms","start":"2026-04-17T11:06:10.039084Z","end":"2026-04-17T11:06:10.521671Z","steps":["trace[1539845831] 'agreement among raft nodes before linearized reading' (duration: 482.519207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:10.5217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:10.039065Z","time spent":"482.63102ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T11:06:10.521942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:10.04124Z","time spent":"480.351ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:11.351826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.414167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-17T11:06:11.351883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.785328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-17T11:06:11.351958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.945209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-17T11:06:11.351963Z","caller":"traceutil/trace.go:171","msg":"trace[665822470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"299.91587ms","start":"2026-04-17T11:06:11.052029Z","end":"2026-04-17T11:06:11.351944Z","steps":["trace[665822470] 'range keys from in-memory index tree' (duration: 299.561364ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:11.351994Z","caller":"traceutil/trace.go:171","msg":"trace[1778990130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"190.014732ms","start":"2026-04-17T11:06:11.16197Z","end":"2026-04-17T11:06:11.351985Z","steps":["trace[1778990130] 'range keys from in-memory index tree' (duration: 189.867348ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:11.351907Z","caller":"traceutil/trace.go:171","msg":"trace[830568699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:405; }","duration":"152.532941ms","start":"2026-04-17T11:06:11.199357Z","end":"2026-04-17T11:06:11.35189Z","steps":["trace[830568699] 'range keys from in-memory index tree' (duration: 152.328627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:11.352091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.08916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:06:11.352163Z","caller":"traceutil/trace.go:171","msg":"trace[924645535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:405; }","duration":"702.207682ms","start":"2026-04-17T11:06:10.649935Z","end":"2026-04-17T11:06:11.352143Z","steps":["trace[924645535] 'range keys from in-memory index tree' (duration: 701.952898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:11.352201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:10.649916Z","time spent":"702.277414ms","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T11:06:17.150885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424014339,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T11:06:17.169107Z","caller":"traceutil/trace.go:171","msg":"trace[1024930470] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"620.014253ms","start":"2026-04-17T11:06:16.549069Z","end":"2026-04-17T11:06:17.169083Z","steps":["trace[1024930470] 'process raft request' (duration: 619.83416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.169253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:16.549056Z","time spent":"620.118577ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:17.875076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.126437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:06:17.875231Z","caller":"traceutil/trace.go:171","msg":"trace[532717694] linearizableReadLoop","detail":"{readStateIndex:470; appliedIndex:468; }","duration":"1.224366522s","start":"2026-04-17T11:06:16.650849Z","end":"2026-04-17T11:06:17.875215Z","steps":["trace[532717694] 'read index received' (duration: 518.134048ms)","trace[532717694] 'applied index is now lower than readState.Index' (duration: 706.231004ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:06:17.875307Z","caller":"traceutil/trace.go:171","msg":"trace[1879104894] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"934.416666ms","start":"2026-04-17T11:06:16.940849Z","end":"2026-04-17T11:06:17.875265Z","steps":["trace[1879104894] 'process raft request' (duration: 667.000694ms)","trace[1879104894] 'compare' (duration: 266.951204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:17.875392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.616693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:06:17.875437Z","caller":"traceutil/trace.go:171","msg":"trace[1380032049] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:454; }","duration":"630.701734ms","start":"2026-04-17T11:06:17.244709Z","end":"2026-04-17T11:06:17.875411Z","steps":["trace[1380032049] 'agreement among raft nodes before linearized reading' (duration: 630.661824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.875478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:17.244677Z","time spent":"630.791986ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-17T11:06:17.87555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.179537ms","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-17T11:06:17.875597Z","caller":"traceutil/trace.go:171","msg":"trace[2116026925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:454; }","duration":"450.238509ms","start":"2026-04-17T11:06:17.425345Z","end":"2026-04-17T11:06:17.875584Z","steps":["trace[2116026925] 'agreement among raft nodes before linearized reading' (duration: 450.161377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.875614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.487087ms","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-17T11:06:17.875676Z","caller":"traceutil/trace.go:171","msg":"trace[1615640887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:454; }","duration":"460.588788ms","start":"2026-04-17T11:06:17.41507Z","end":"2026-04-17T11:06:17.875659Z","steps":["trace[1615640887] 'agreement among raft nodes before linearized reading' (duration: 460.461626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.875474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:16.940824Z","time spent":"934.570139ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:17.875714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:17.415045Z","time spent":"460.662048ms","remote":"127.0.0.1:39538","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-17T11:06:17.875631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:17.425338Z","time spent":"450.286479ms","remote":"127.0.0.1:39538","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-17T11:06:17.875346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224500044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T11:06:17.875871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.89238ms","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-17T11:06:17.875897Z","caller":"traceutil/trace.go:171","msg":"trace[2024088604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:454; }","duration":"450.995712ms","start":"2026-04-17T11:06:17.424893Z","end":"2026-04-17T11:06:17.875888Z","steps":["trace[2024088604] 'agreement among raft nodes before linearized reading' (duration: 450.90106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.875929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:17.424872Z","time spent":"451.050742ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T11:06:17.875926Z","caller":"traceutil/trace.go:171","msg":"trace[411278564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:454; }","duration":"1.225059604s","start":"2026-04-17T11:06:16.650811Z","end":"2026-04-17T11:06:17.87587Z","steps":["trace[411278564] 'agreement among raft nodes before linearized reading' (duration: 1.224499774s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:17.876042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:16.650795Z","time spent":"1.225215236s","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T11:06:18.599797Z","caller":"traceutil/trace.go:171","msg":"trace[867275589] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"160.273372ms","start":"2026-04-17T11:06:18.439508Z","end":"2026-04-17T11:06:18.599782Z","steps":["trace[867275589] 'process raft request' (duration: 150.575496ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:18.601988Z","caller":"traceutil/trace.go:171","msg":"trace[686362214] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"126.479017ms","start":"2026-04-17T11:06:18.475486Z","end":"2026-04-17T11:06:18.601965Z","steps":["trace[686362214] 'process raft request' (duration: 126.338045ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:18.602314Z","caller":"traceutil/trace.go:171","msg":"trace[544178588] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"145.096154ms","start":"2026-04-17T11:06:18.457187Z","end":"2026-04-17T11:06:18.602284Z","steps":["trace[544178588] 'process raft request' (duration: 144.580283ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:18.602351Z","caller":"traceutil/trace.go:171","msg":"trace[1646808998] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"162.500016ms","start":"2026-04-17T11:06:18.439831Z","end":"2026-04-17T11:06:18.602331Z","steps":["trace[1646808998] 'process raft request' (duration: 161.812593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:19.594475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.991477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:06:19.595063Z","caller":"traceutil/trace.go:171","msg":"trace[1441751299] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:521; }","duration":"421.036403ms","start":"2026-04-17T11:06:19.174005Z","end":"2026-04-17T11:06:19.595042Z","steps":["trace[1441751299] 'read index received' (duration: 47.47657ms)","trace[1441751299] 'applied index is now lower than readState.Index' (duration: 373.558843ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:06:19.595101Z","caller":"traceutil/trace.go:171","msg":"trace[477230525] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"941.179924ms","start":"2026-04-17T11:06:18.653863Z","end":"2026-04-17T11:06:19.595043Z","steps":["trace[477230525] 'process raft request' (duration: 567.549099ms)","trace[477230525] 'compare' (duration: 372.728167ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:19.595354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.335256ms","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-17T11:06:19.595418Z","caller":"traceutil/trace.go:171","msg":"trace[430909990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"421.42672ms","start":"2026-04-17T11:06:19.173975Z","end":"2026-04-17T11:06:19.595402Z","steps":["trace[430909990] 'agreement among raft nodes before linearized reading' (duration: 421.315305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:19.595471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:19.173958Z","time spent":"421.499593ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T11:06:19.595115Z","caller":"traceutil/trace.go:171","msg":"trace[1484476923] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"938.031161ms","start":"2026-04-17T11:06:18.657045Z","end":"2026-04-17T11:06:19.595076Z","steps":["trace[1484476923] 'process raft request' (duration: 937.731579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:19.595662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:18.657025Z","time spent":"938.536883ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:19.595309Z","caller":"traceutil/trace.go:171","msg":"trace[1535797177] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"910.795295ms","start":"2026-04-17T11:06:18.68449Z","end":"2026-04-17T11:06:19.595285Z","steps":["trace[1535797177] 'process raft request' (duration: 910.471971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:19.595833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:18.684454Z","time spent":"911.341428ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T11:06:19.596042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:18.653845Z","time spent":"941.818901ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:20.107958Z","caller":"traceutil/trace.go:171","msg":"trace[1768696914] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"350.102883ms","start":"2026-04-17T11:06:19.75783Z","end":"2026-04-17T11:06:20.107933Z","steps":["trace[1768696914] 'process raft request' (duration: 340.793085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:20.108105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:19.757814Z","time spent":"350.23088ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T11:06:20.108322Z","caller":"traceutil/trace.go:171","msg":"trace[1159253296] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"345.206774ms","start":"2026-04-17T11:06:19.763088Z","end":"2026-04-17T11:06:20.108294Z","steps":["trace[1159253296] 'process raft request' (duration: 344.960444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:20.108439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:19.763063Z","time spent":"345.313209ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:20.108817Z","caller":"traceutil/trace.go:171","msg":"trace[1921718247] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"321.299995ms","start":"2026-04-17T11:06:19.787503Z","end":"2026-04-17T11:06:20.108803Z","steps":["trace[1921718247] 'process raft request' (duration: 320.73007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:20.109007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:19.787483Z","time spent":"321.390609ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:20.134747Z","caller":"traceutil/trace.go:171","msg":"trace[1823224647] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"246.432351ms","start":"2026-04-17T11:06:19.888285Z","end":"2026-04-17T11:06:20.134717Z","steps":["trace[1823224647] 'read index received' (duration: 210.41587ms)","trace[1823224647] 'applied index is now lower than readState.Index' (duration: 36.015431ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:20.134905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.601809ms","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-17T11:06:20.134952Z","caller":"traceutil/trace.go:171","msg":"trace[1075793427] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"246.673451ms","start":"2026-04-17T11:06:19.888248Z","end":"2026-04-17T11:06:20.134921Z","steps":["trace[1075793427] 'agreement among raft nodes before linearized reading' (duration: 246.595728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:20.135133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.485404ms","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-17T11:06:20.135152Z","caller":"traceutil/trace.go:171","msg":"trace[1051847129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"246.522036ms","start":"2026-04-17T11:06:19.888624Z","end":"2026-04-17T11:06:20.135146Z","steps":["trace[1051847129] 'agreement among raft nodes before linearized reading' (duration: 246.483484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:20.13528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.464672ms","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-17T11:06:20.135299Z","caller":"traceutil/trace.go:171","msg":"trace[1474631070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:516; }","duration":"246.498935ms","start":"2026-04-17T11:06:19.888795Z","end":"2026-04-17T11:06:20.135293Z","steps":["trace[1474631070] 'agreement among raft nodes before linearized reading' (duration: 246.464243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:26.691338Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424014533,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T11:06:27.192207Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424014533,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T11:06:27.692567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424014533,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T11:06:28.192988Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424014533,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T11:06:28.456758Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.242350117s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T11:06:28.458558Z","caller":"traceutil/trace.go:171","msg":"trace[3908966] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"2.459296907s","start":"2026-04-17T11:06:25.999243Z","end":"2026-04-17T11:06:28.45854Z","steps":["trace[3908966] 'process raft request' (duration: 2.457900939s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.45867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:25.99922Z","time spent":"2.459391501s","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:28.470544Z","caller":"traceutil/trace.go:171","msg":"trace[1436800836] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.204915171s","start":"2026-04-17T11:06:27.265605Z","end":"2026-04-17T11:06:28.47052Z","steps":["trace[1436800836] 'process raft request' (duration: 1.204736424s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.470658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:27.265584Z","time spent":"1.205020166s","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:28.470769Z","caller":"traceutil/trace.go:171","msg":"trace[1433165344] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"411.043653ms","start":"2026-04-17T11:06:28.059696Z","end":"2026-04-17T11:06:28.47074Z","steps":["trace[1433165344] 'process raft request' (duration: 410.773962ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:28.470771Z","caller":"traceutil/trace.go:171","msg":"trace[989992286] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:588; }","duration":"2.280482885s","start":"2026-04-17T11:06:26.19026Z","end":"2026-04-17T11:06:28.470742Z","steps":["trace[989992286] 'read index received' (duration: 2.266916153s)","trace[989992286] 'applied index is now lower than readState.Index' (duration: 13.565912ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:28.47102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.278196159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-17T11:06:28.47103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.824033917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:06:28.471051Z","caller":"traceutil/trace.go:171","msg":"trace[1256884173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:569; }","duration":"2.278264263s","start":"2026-04-17T11:06:26.192778Z","end":"2026-04-17T11:06:28.471042Z","steps":["trace[1256884173] 'agreement among raft nodes before linearized reading' (duration: 2.2781987s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.471043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.760243124s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rb56j\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-17T11:06:28.471073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:26.192757Z","time spent":"2.278311144s","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T11:06:28.471073Z","caller":"traceutil/trace.go:171","msg":"trace[980545517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"1.824084868s","start":"2026-04-17T11:06:26.646963Z","end":"2026-04-17T11:06:28.471048Z","steps":["trace[980545517] 'agreement among raft nodes before linearized reading' (duration: 1.824044977s)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:28.471083Z","caller":"traceutil/trace.go:171","msg":"trace[936276992] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rb56j; range_end:; response_count:1; response_revision:569; }","duration":"1.760316096s","start":"2026-04-17T11:06:26.710754Z","end":"2026-04-17T11:06:28.47107Z","steps":["trace[936276992] 'agreement among raft nodes before linearized reading' (duration: 1.760240304s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.471096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:26.646949Z","time spent":"1.82414326s","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T11:06:28.471108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:26.710739Z","time spent":"1.760363968s","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-rb56j\" "} {"level":"warn","ts":"2026-04-17T11:06:28.471215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.278345697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-17T11:06:28.47124Z","caller":"traceutil/trace.go:171","msg":"trace[1097508782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:569; }","duration":"2.278385667s","start":"2026-04-17T11:06:26.192848Z","end":"2026-04-17T11:06:28.471233Z","steps":["trace[1097508782] 'agreement among raft nodes before linearized reading' (duration: 2.278322654s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.471259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:26.192842Z","time spent":"2.278412598s","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T11:06:28.471285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.286001ms","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-17T11:06:28.471309Z","caller":"traceutil/trace.go:171","msg":"trace[627883054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:569; }","duration":"828.344133ms","start":"2026-04-17T11:06:27.642958Z","end":"2026-04-17T11:06:28.471302Z","steps":["trace[627883054] 'agreement among raft nodes before linearized reading' (duration: 828.26993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.471329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:27.64294Z","time spent":"828.385795ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T11:06:28.471223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:28.05968Z","time spent":"411.209269ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:28.471404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.280680314s","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-17T11:06:28.471502Z","caller":"traceutil/trace.go:171","msg":"trace[242660477] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:569; }","duration":"2.281284748s","start":"2026-04-17T11:06:26.190209Z","end":"2026-04-17T11:06:28.471494Z","steps":["trace[242660477] 'agreement among raft nodes before linearized reading' (duration: 2.280629301s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:28.471523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:26.19019Z","time spent":"2.28132684s","remote":"127.0.0.1:39538","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-17T11:06:33.095744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.632706ms","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-17T11:06:33.095863Z","caller":"traceutil/trace.go:171","msg":"trace[862898031] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:648; }","duration":"115.766662ms","start":"2026-04-17T11:06:32.98008Z","end":"2026-04-17T11:06:33.095847Z","steps":["trace[862898031] 'range keys from in-memory index tree' (duration: 115.616805ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:33.097644Z","caller":"traceutil/trace.go:171","msg":"trace[1046262290] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"102.74602ms","start":"2026-04-17T11:06:32.994876Z","end":"2026-04-17T11:06:33.097622Z","steps":["trace[1046262290] 'process raft request' (duration: 102.256391ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:40.888176Z","caller":"traceutil/trace.go:171","msg":"trace[1479363496] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"364.406681ms","start":"2026-04-17T11:06:40.523746Z","end":"2026-04-17T11:06:40.888152Z","steps":["trace[1479363496] 'process raft request' (duration: 364.235034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:40.888323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:40.523727Z","time spent":"364.527374ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:40.893812Z","caller":"traceutil/trace.go:171","msg":"trace[1275829469] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:740; }","duration":"364.546915ms","start":"2026-04-17T11:06:40.529243Z","end":"2026-04-17T11:06:40.89379Z","steps":["trace[1275829469] 'read index received' (duration: 358.756117ms)","trace[1275829469] 'applied index is now lower than readState.Index' (duration: 5.789588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:06:40.894011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.793482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T11:06:40.894035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.711043ms","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-17T11:06:40.894035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.773404ms","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-17T11:06:40.894077Z","caller":"traceutil/trace.go:171","msg":"trace[1965229760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:715; }","duration":"241.917616ms","start":"2026-04-17T11:06:40.652146Z","end":"2026-04-17T11:06:40.894064Z","steps":["trace[1965229760] 'agreement among raft nodes before linearized reading' (duration: 241.829713ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:40.894081Z","caller":"traceutil/trace.go:171","msg":"trace[1334264911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"364.796575ms","start":"2026-04-17T11:06:40.529273Z","end":"2026-04-17T11:06:40.89407Z","steps":["trace[1334264911] 'agreement among raft nodes before linearized reading' (duration: 364.67538ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:40.894097Z","caller":"traceutil/trace.go:171","msg":"trace[1407789713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"364.862788ms","start":"2026-04-17T11:06:40.529217Z","end":"2026-04-17T11:06:40.89408Z","steps":["trace[1407789713] 'agreement among raft nodes before linearized reading' (duration: 364.691091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:40.89414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:40.529258Z","time spent":"364.856588ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T11:06:40.89417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:40.529203Z","time spent":"364.953631ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T11:06:40.893897Z","caller":"traceutil/trace.go:171","msg":"trace[1083643822] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"366.995573ms","start":"2026-04-17T11:06:40.526872Z","end":"2026-04-17T11:06:40.893868Z","steps":["trace[1083643822] 'process raft request' (duration: 366.796535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:40.895384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:40.526846Z","time spent":"368.45058ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:43.088358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.738834ms","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-17T11:06:43.088434Z","caller":"traceutil/trace.go:171","msg":"trace[1587181326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:726; }","duration":"182.846678ms","start":"2026-04-17T11:06:42.905569Z","end":"2026-04-17T11:06:43.088416Z","steps":["trace[1587181326] 'range keys from in-memory index tree' (duration: 182.577627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:43.08845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.609137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-17T11:06:43.088526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.831922ms","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-17T11:06:43.088522Z","caller":"traceutil/trace.go:171","msg":"trace[356582148] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:726; }","duration":"196.719892ms","start":"2026-04-17T11:06:42.891785Z","end":"2026-04-17T11:06:43.088505Z","steps":["trace[356582148] 'range keys from in-memory index tree' (duration: 196.450281ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.088557Z","caller":"traceutil/trace.go:171","msg":"trace[1994461184] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"189.876313ms","start":"2026-04-17T11:06:42.89867Z","end":"2026-04-17T11:06:43.088546Z","steps":["trace[1994461184] 'range keys from in-memory index tree' (duration: 189.766528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:43.088456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.259941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-b8mqn\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-17T11:06:43.088434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.204544ms","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-17T11:06:43.088751Z","caller":"traceutil/trace.go:171","msg":"trace[157850607] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:726; }","duration":"108.562708ms","start":"2026-04-17T11:06:42.980175Z","end":"2026-04-17T11:06:43.088737Z","steps":["trace[157850607] 'range keys from in-memory index tree' (duration: 108.187263ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.088693Z","caller":"traceutil/trace.go:171","msg":"trace[1120887164] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-b8mqn; range_end:; response_count:1; response_revision:726; }","duration":"282.516321ms","start":"2026-04-17T11:06:42.806129Z","end":"2026-04-17T11:06:43.088645Z","steps":["trace[1120887164] 'range keys from in-memory index tree' (duration: 282.059164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:43.088563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.315677ms","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-17T11:06:43.088894Z","caller":"traceutil/trace.go:171","msg":"trace[142003276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"182.687531ms","start":"2026-04-17T11:06:42.906201Z","end":"2026-04-17T11:06:43.088889Z","steps":["trace[142003276] 'range keys from in-memory index tree' (duration: 182.172801ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.712356Z","caller":"traceutil/trace.go:171","msg":"trace[1722492081] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"620.072946ms","start":"2026-04-17T11:06:43.092262Z","end":"2026-04-17T11:06:43.712335Z","steps":["trace[1722492081] 'process raft request' (duration: 619.872868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:43.712546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:43.092241Z","time spent":"620.183492ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:06:43.725391Z","caller":"traceutil/trace.go:171","msg":"trace[431517140] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"632.920337ms","start":"2026-04-17T11:06:43.092453Z","end":"2026-04-17T11:06:43.725373Z","steps":["trace[431517140] 'process raft request' (duration: 632.808643ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.72567Z","caller":"traceutil/trace.go:171","msg":"trace[1665967335] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"632.518332ms","start":"2026-04-17T11:06:43.093133Z","end":"2026-04-17T11:06:43.725651Z","steps":["trace[1665967335] 'process raft request' (duration: 632.207469ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.725696Z","caller":"traceutil/trace.go:171","msg":"trace[1605505466] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"628.118429ms","start":"2026-04-17T11:06:43.097555Z","end":"2026-04-17T11:06:43.725673Z","steps":["trace[1605505466] 'process raft request' (duration: 628.070128ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:06:43.725733Z","caller":"traceutil/trace.go:171","msg":"trace[2113270110] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"628.262355ms","start":"2026-04-17T11:06:43.097438Z","end":"2026-04-17T11:06:43.7257Z","steps":["trace[2113270110] 'process raft request' (duration: 628.093529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:06:43.725799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:43.093126Z","time spent":"632.618765ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:43.725838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:43.097545Z","time spent":"628.214704ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:43.725922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:43.097401Z","time spent":"628.419152ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:06:43.725798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:06:43.092438Z","time spent":"633.000151ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:07:18.29525Z","caller":"traceutil/trace.go:171","msg":"trace[1444788578] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"129.558823ms","start":"2026-04-17T11:07:18.165669Z","end":"2026-04-17T11:07:18.295228Z","steps":["trace[1444788578] 'process raft request' (duration: 129.532641ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:18.295329Z","caller":"traceutil/trace.go:171","msg":"trace[1384991945] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"131.568793ms","start":"2026-04-17T11:07:18.163723Z","end":"2026-04-17T11:07:18.295292Z","steps":["trace[1384991945] 'process raft request' (duration: 131.359275ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:18.295455Z","caller":"traceutil/trace.go:171","msg":"trace[1809349408] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"131.599584ms","start":"2026-04-17T11:07:18.163816Z","end":"2026-04-17T11:07:18.295416Z","steps":["trace[1809349408] 'process raft request' (duration: 131.365416ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:19.2493Z","caller":"traceutil/trace.go:171","msg":"trace[1726588393] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"281.144095ms","start":"2026-04-17T11:07:18.96813Z","end":"2026-04-17T11:07:19.249274Z","steps":["trace[1726588393] 'process raft request' (duration: 280.99481ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:26.23604Z","caller":"traceutil/trace.go:171","msg":"trace[1476908922] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"165.682887ms","start":"2026-04-17T11:07:26.070329Z","end":"2026-04-17T11:07:26.236012Z","steps":["trace[1476908922] 'process raft request' (duration: 165.419718ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:26.344632Z","caller":"traceutil/trace.go:171","msg":"trace[101675588] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"158.865508ms","start":"2026-04-17T11:07:26.185711Z","end":"2026-04-17T11:07:26.344577Z","steps":["trace[101675588] 'process raft request' (duration: 152.698342ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:38.569231Z","caller":"traceutil/trace.go:171","msg":"trace[580386445] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"121.124405ms","start":"2026-04-17T11:07:38.448077Z","end":"2026-04-17T11:07:38.569201Z","steps":["trace[580386445] 'process raft request' (duration: 59.250271ms)","trace[580386445] 'compare' (duration: 61.751321ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:07:46.510207Z","caller":"traceutil/trace.go:171","msg":"trace[1359767066] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"152.76923ms","start":"2026-04-17T11:07:46.357409Z","end":"2026-04-17T11:07:46.510178Z","steps":["trace[1359767066] 'process raft request' (duration: 152.612396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:47.166741Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407268424016010,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T11:07:47.169368Z","caller":"traceutil/trace.go:171","msg":"trace[1784771979] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"534.320836ms","start":"2026-04-17T11:07:46.635029Z","end":"2026-04-17T11:07:47.16935Z","steps":["trace[1784771979] 'read index received' (duration: 533.060717ms)","trace[1784771979] 'applied index is now lower than readState.Index' (duration: 1.259599ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:07:47.16946Z","caller":"traceutil/trace.go:171","msg":"trace[517418809] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"546.385527ms","start":"2026-04-17T11:07:46.623066Z","end":"2026-04-17T11:07:47.169452Z","steps":["trace[517418809] 'process raft request' (duration: 545.085506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:47.169541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:46.623049Z","time spent":"546.435397ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:07:47.169655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.410737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-dns\" ","response":"range_response_count:1 size:576"} {"level":"info","ts":"2026-04-17T11:07:47.169744Z","caller":"traceutil/trace.go:171","msg":"trace[1642628733] range","detail":"{range_begin:/registry/clusterroles/system:kube-dns; range_end:; response_count:1; response_revision:1118; }","duration":"506.537541ms","start":"2026-04-17T11:07:46.663186Z","end":"2026-04-17T11:07:47.169724Z","steps":["trace[1642628733] 'agreement among raft nodes before linearized reading' (duration: 506.400247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:47.16979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:46.663169Z","time spent":"506.611844ms","remote":"127.0.0.1:39600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":600,"request content":"key:\"/registry/clusterroles/system:kube-dns\" "} {"level":"warn","ts":"2026-04-17T11:07:47.169804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.77807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-04-17T11:07:47.169835Z","caller":"traceutil/trace.go:171","msg":"trace[1208749886] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:1118; }","duration":"534.843682ms","start":"2026-04-17T11:07:46.634982Z","end":"2026-04-17T11:07:47.169826Z","steps":["trace[1208749886] 'agreement among raft nodes before linearized reading' (duration: 534.785601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:47.169862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:46.634933Z","time spent":"534.923995ms","remote":"127.0.0.1:39602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":767,"request content":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" "} {"level":"warn","ts":"2026-04-17T11:07:47.170062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.028646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:07:47.170135Z","caller":"traceutil/trace.go:171","msg":"trace[2000294808] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1118; }","duration":"378.149929ms","start":"2026-04-17T11:07:46.791969Z","end":"2026-04-17T11:07:47.170118Z","steps":["trace[2000294808] 'agreement among raft nodes before linearized reading' (duration: 378.040826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:47.170176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:46.791947Z","time spent":"378.217181ms","remote":"127.0.0.1:39736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-17T11:07:50.361805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.100687ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-17T11:07:50.362117Z","caller":"traceutil/trace.go:171","msg":"trace[387259057] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"178.437433ms","start":"2026-04-17T11:07:50.18366Z","end":"2026-04-17T11:07:50.362097Z","steps":["trace[387259057] 'read index received' (duration: 40.992266ms)","trace[387259057] 'applied index is now lower than readState.Index' (duration: 137.442847ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:07:50.362368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.689771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"} {"level":"warn","ts":"2026-04-17T11:07:50.36251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.331548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-04-17T11:07:50.362571Z","caller":"traceutil/trace.go:171","msg":"trace[1751194893] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:1124; }","duration":"178.836125ms","start":"2026-04-17T11:07:50.183626Z","end":"2026-04-17T11:07:50.362462Z","steps":["trace[1751194893] 'agreement among raft nodes before linearized reading' (duration: 178.627548ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:50.362593Z","caller":"traceutil/trace.go:171","msg":"trace[1569619079] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1124; }","duration":"150.448212ms","start":"2026-04-17T11:07:50.212127Z","end":"2026-04-17T11:07:50.362576Z","steps":["trace[1569619079] 'agreement among raft nodes before linearized reading' (duration: 150.252616ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:50.645287Z","caller":"traceutil/trace.go:171","msg":"trace[2064402401] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"119.942812ms","start":"2026-04-17T11:07:50.525316Z","end":"2026-04-17T11:07:50.645259Z","steps":["trace[2064402401] 'read index received' (duration: 119.793488ms)","trace[2064402401] 'applied index is now lower than readState.Index' (duration: 147.844µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:07:50.64547Z","caller":"traceutil/trace.go:171","msg":"trace[1021871349] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"121.220892ms","start":"2026-04-17T11:07:50.524217Z","end":"2026-04-17T11:07:50.645438Z","steps":["trace[1021871349] 'process raft request' (duration: 120.85253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:50.645584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.257472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-17T11:07:50.645864Z","caller":"traceutil/trace.go:171","msg":"trace[1119247217] range","detail":"{range_begin:/registry/clusterrolebindings/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:1126; }","duration":"120.568022ms","start":"2026-04-17T11:07:50.525277Z","end":"2026-04-17T11:07:50.645845Z","steps":["trace[1119247217] 'agreement among raft nodes before linearized reading' (duration: 120.252212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:50.656218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.939269ms","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-17T11:07:50.656253Z","caller":"traceutil/trace.go:171","msg":"trace[772611225] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"129.740938ms","start":"2026-04-17T11:07:50.526494Z","end":"2026-04-17T11:07:50.656235Z","steps":["trace[772611225] 'process raft request' (duration: 129.420758ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:50.656279Z","caller":"traceutil/trace.go:171","msg":"trace[548087020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1127; }","duration":"117.025942ms","start":"2026-04-17T11:07:50.539237Z","end":"2026-04-17T11:07:50.656263Z","steps":["trace[548087020] 'agreement among raft nodes before linearized reading' (duration: 116.885298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:50.656589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.363ms","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-17T11:07:50.656624Z","caller":"traceutil/trace.go:171","msg":"trace[1785443805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1127; }","duration":"114.428391ms","start":"2026-04-17T11:07:50.542188Z","end":"2026-04-17T11:07:50.656616Z","steps":["trace[1785443805] 'agreement among raft nodes before linearized reading' (duration: 114.308457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:50.657176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.390926ms","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-17T11:07:50.657259Z","caller":"traceutil/trace.go:171","msg":"trace[265209512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1127; }","duration":"111.489679ms","start":"2026-04-17T11:07:50.545752Z","end":"2026-04-17T11:07:50.657242Z","steps":["trace[265209512] 'agreement among raft nodes before linearized reading' (duration: 110.357124ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:52.981805Z","caller":"traceutil/trace.go:171","msg":"trace[1840528501] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1176; }","duration":"328.365229ms","start":"2026-04-17T11:07:52.653413Z","end":"2026-04-17T11:07:52.981779Z","steps":["trace[1840528501] 'read index received' (duration: 328.244796ms)","trace[1840528501] 'applied index is now lower than readState.Index' (duration: 119.173µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:07:52.981903Z","caller":"traceutil/trace.go:171","msg":"trace[1920785027] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"330.368082ms","start":"2026-04-17T11:07:52.651493Z","end":"2026-04-17T11:07:52.981861Z","steps":["trace[1920785027] 'process raft request' (duration: 330.081113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:52.982054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.651483Z","time spent":"330.482894ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:07:52.982358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.917336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 ","response":"range_response_count:15 size:12285"} {"level":"info","ts":"2026-04-17T11:07:52.98241Z","caller":"traceutil/trace.go:171","msg":"trace[502657078] range","detail":"{range_begin:/registry/events/envoy-gateway-system/; range_end:/registry/events/envoy-gateway-system0; response_count:15; response_revision:1132; }","duration":"329.015011ms","start":"2026-04-17T11:07:52.653383Z","end":"2026-04-17T11:07:52.982398Z","steps":["trace[502657078] 'agreement among raft nodes before linearized reading' (duration: 328.513825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:52.982557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.653369Z","time spent":"329.173035ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":15,"response size":12309,"request content":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 "} {"level":"info","ts":"2026-04-17T11:07:53.054896Z","caller":"traceutil/trace.go:171","msg":"trace[1278654390] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"394.333866ms","start":"2026-04-17T11:07:52.660535Z","end":"2026-04-17T11:07:53.054868Z","steps":["trace[1278654390] 'process raft request' (duration: 394.091958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.054943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.313078ms","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-17T11:07:53.054962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.58632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:07:53.055002Z","caller":"traceutil/trace.go:171","msg":"trace[165525696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"311.411641ms","start":"2026-04-17T11:07:52.743578Z","end":"2026-04-17T11:07:53.054989Z","steps":["trace[165525696] 'agreement among raft nodes before linearized reading' (duration: 311.228385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.055023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.660511Z","time spent":"394.45209ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:07:53.055037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.74356Z","time spent":"311.470602ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T11:07:53.055036Z","caller":"traceutil/trace.go:171","msg":"trace[262759558] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:0; response_revision:1133; }","duration":"336.697654ms","start":"2026-04-17T11:07:52.718322Z","end":"2026-04-17T11:07:53.05502Z","steps":["trace[262759558] 'agreement among raft nodes before linearized reading' (duration: 336.56645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.054915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.154249ms","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-17T11:07:53.055199Z","caller":"traceutil/trace.go:171","msg":"trace[881758794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"370.475928ms","start":"2026-04-17T11:07:52.684699Z","end":"2026-04-17T11:07:53.055175Z","steps":["trace[881758794] 'agreement among raft nodes before linearized reading' (duration: 370.056145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.055307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.684687Z","time spent":"370.602102ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T11:07:53.055224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.718313Z","time spent":"336.88658ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 "} {"level":"warn","ts":"2026-04-17T11:07:53.055122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.751911ms","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-17T11:07:53.055607Z","caller":"traceutil/trace.go:171","msg":"trace[899290599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1133; }","duration":"311.291866ms","start":"2026-04-17T11:07:52.744302Z","end":"2026-04-17T11:07:53.055594Z","steps":["trace[899290599] 'agreement among raft nodes before linearized reading' (duration: 310.688368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.055681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.744281Z","time spent":"311.387541ms","remote":"127.0.0.1:39538","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-17T11:07:53.055456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.615771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/envoy-gateway-system/\" range_end:\"/registry/networkpolicies/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:07:53.056075Z","caller":"traceutil/trace.go:171","msg":"trace[1617217045] range","detail":"{range_begin:/registry/networkpolicies/envoy-gateway-system/; range_end:/registry/networkpolicies/envoy-gateway-system0; response_count:0; response_revision:1133; }","duration":"348.266581ms","start":"2026-04-17T11:07:52.707794Z","end":"2026-04-17T11:07:53.056061Z","steps":["trace[1617217045] 'agreement among raft nodes before linearized reading' (duration: 347.152106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.056145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:52.707775Z","time spent":"348.350523ms","remote":"127.0.0.1:39556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/envoy-gateway-system/\" range_end:\"/registry/networkpolicies/envoy-gateway-system0\" limit:500 "} {"level":"info","ts":"2026-04-17T11:07:53.191792Z","caller":"traceutil/trace.go:171","msg":"trace[1916277373] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"131.885329ms","start":"2026-04-17T11:07:53.059872Z","end":"2026-04-17T11:07:53.191758Z","steps":["trace[1916277373] 'process raft request' (duration: 129.486295ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:53.204389Z","caller":"traceutil/trace.go:171","msg":"trace[376626045] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"144.297552ms","start":"2026-04-17T11:07:53.06007Z","end":"2026-04-17T11:07:53.204368Z","steps":["trace[376626045] 'process raft request' (duration: 143.92306ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:07:53.204601Z","caller":"traceutil/trace.go:171","msg":"trace[237041552] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"143.474628ms","start":"2026-04-17T11:07:53.061117Z","end":"2026-04-17T11:07:53.204591Z","steps":["trace[237041552] 'process raft request' (duration: 143.001813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.596369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.031255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:07:53.596501Z","caller":"traceutil/trace.go:171","msg":"trace[276396789] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"325.081441ms","start":"2026-04-17T11:07:53.271402Z","end":"2026-04-17T11:07:53.596484Z","steps":["trace[276396789] 'read index received' (duration: 27.793897ms)","trace[276396789] 'applied index is now lower than readState.Index' (duration: 297.285964ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:07:53.596543Z","caller":"traceutil/trace.go:171","msg":"trace[499603057] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"385.591738ms","start":"2026-04-17T11:07:53.210924Z","end":"2026-04-17T11:07:53.596516Z","steps":["trace[499603057] 'process raft request' (duration: 88.321376ms)","trace[499603057] 'compare' (duration: 296.840408ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:07:53.596667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.255846ms","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-17T11:07:53.596679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:53.210911Z","time spent":"385.693651ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:07:53.596739Z","caller":"traceutil/trace.go:171","msg":"trace[922027773] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1137; }","duration":"325.352108ms","start":"2026-04-17T11:07:53.271374Z","end":"2026-04-17T11:07:53.596726Z","steps":["trace[922027773] 'agreement among raft nodes before linearized reading' (duration: 325.198913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.596911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:53.271362Z","time spent":"325.505533ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-17T11:07:53.597166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.497558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dl2r8\" ","response":"range_response_count:1 size:5483"} {"level":"info","ts":"2026-04-17T11:07:53.597287Z","caller":"traceutil/trace.go:171","msg":"trace[25172155] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dl2r8; range_end:; response_count:1; response_revision:1137; }","duration":"307.656473ms","start":"2026-04-17T11:07:53.289606Z","end":"2026-04-17T11:07:53.597262Z","steps":["trace[25172155] 'agreement among raft nodes before linearized reading' (duration: 307.371064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.597293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.155634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T11:07:53.597345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:53.289586Z","time spent":"307.743854ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5507,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dl2r8\" "} {"level":"info","ts":"2026-04-17T11:07:53.597366Z","caller":"traceutil/trace.go:171","msg":"trace[1581812940] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1137; }","duration":"104.273839ms","start":"2026-04-17T11:07:53.493075Z","end":"2026-04-17T11:07:53.597349Z","steps":["trace[1581812940] 'agreement among raft nodes before linearized reading' (duration: 104.145404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.597363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.72466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-17T11:07:53.597438Z","caller":"traceutil/trace.go:171","msg":"trace[1498526182] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/; range_end:/registry/persistentvolumeclaims/default0; response_count:1; response_revision:1137; }","duration":"302.809073ms","start":"2026-04-17T11:07:53.294599Z","end":"2026-04-17T11:07:53.597408Z","steps":["trace[1498526182] 'agreement among raft nodes before linearized reading' (duration: 302.645948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:07:53.597484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:07:53.29459Z","time spent":"302.880036ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":1489,"request content":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 "} {"level":"info","ts":"2026-04-17T11:08:05.133958Z","caller":"traceutil/trace.go:171","msg":"trace[1847017287] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"106.425987ms","start":"2026-04-17T11:08:05.027516Z","end":"2026-04-17T11:08:05.133942Z","steps":["trace[1847017287] 'process raft request' (duration: 106.315964ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:08:05.406567Z","caller":"traceutil/trace.go:171","msg":"trace[2111543015] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1223; }","duration":"142.303729ms","start":"2026-04-17T11:08:05.264242Z","end":"2026-04-17T11:08:05.406545Z","steps":["trace[2111543015] 'read index received' (duration: 73.988188ms)","trace[2111543015] 'applied index is now lower than readState.Index' (duration: 68.314741ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:08:05.406619Z","caller":"traceutil/trace.go:171","msg":"trace[50420333] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"145.727741ms","start":"2026-04-17T11:08:05.260863Z","end":"2026-04-17T11:08:05.406591Z","steps":["trace[50420333] 'process raft request' (duration: 77.402831ms)","trace[50420333] 'compare' (duration: 68.177386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:05.406795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.542646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-17T11:08:05.406842Z","caller":"traceutil/trace.go:171","msg":"trace[1568805119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1176; }","duration":"142.639028ms","start":"2026-04-17T11:08:05.264192Z","end":"2026-04-17T11:08:05.406831Z","steps":["trace[1568805119] 'agreement among raft nodes before linearized reading' (duration: 142.488364ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:08:06.168627Z","caller":"traceutil/trace.go:171","msg":"trace[1356015786] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1224; }","duration":"518.258989ms","start":"2026-04-17T11:08:05.650342Z","end":"2026-04-17T11:08:06.168601Z","steps":["trace[1356015786] 'read index received' (duration: 474.61907ms)","trace[1356015786] 'applied index is now lower than readState.Index' (duration: 43.638519ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:08:06.168872Z","caller":"traceutil/trace.go:171","msg":"trace[1641329462] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"757.684146ms","start":"2026-04-17T11:08:05.411174Z","end":"2026-04-17T11:08:06.168858Z","steps":["trace[1641329462] 'process raft request' (duration: 713.682705ms)","trace[1641329462] 'compare' (duration: 43.585808ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:06.168998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:05.411155Z","time spent":"757.752318ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:08:06.16919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.854906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:08:06.169228Z","caller":"traceutil/trace.go:171","msg":"trace[2007871797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"518.922878ms","start":"2026-04-17T11:08:05.650295Z","end":"2026-04-17T11:08:06.169218Z","steps":["trace[2007871797] 'agreement among raft nodes before linearized reading' (duration: 518.868317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:06.169256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:05.650269Z","time spent":"518.98169ms","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T11:08:06.955476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.690111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:08:06.955585Z","caller":"traceutil/trace.go:171","msg":"trace[593315429] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1225; }","duration":"786.871089ms","start":"2026-04-17T11:08:06.168698Z","end":"2026-04-17T11:08:06.955569Z","steps":["trace[593315429] 'read index received' (duration: 476.90945ms)","trace[593315429] 'applied index is now lower than readState.Index' (duration: 309.959759ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:06.955857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.411075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:08:06.955923Z","caller":"traceutil/trace.go:171","msg":"trace[64907502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1178; }","duration":"785.515349ms","start":"2026-04-17T11:08:06.170393Z","end":"2026-04-17T11:08:06.955908Z","steps":["trace[64907502] 'agreement among raft nodes before linearized reading' (duration: 785.406556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:06.95595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:06.170378Z","time spent":"785.566219ms","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T11:08:06.955939Z","caller":"traceutil/trace.go:171","msg":"trace[1693066036] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"1.03454643s","start":"2026-04-17T11:08:05.921352Z","end":"2026-04-17T11:08:06.955898Z","steps":["trace[1693066036] 'process raft request' (duration: 724.316192ms)","trace[1693066036] 'compare' (duration: 309.486865ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:06.956018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.301464108s","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-17T11:08:06.956088Z","caller":"traceutil/trace.go:171","msg":"trace[411859261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1178; }","duration":"1.301562931s","start":"2026-04-17T11:08:05.654502Z","end":"2026-04-17T11:08:06.956064Z","steps":["trace[411859261] 'agreement among raft nodes before linearized reading' (duration: 1.301320703s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:06.95608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.684955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"warn","ts":"2026-04-17T11:08:06.956119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:05.921336Z","time spent":"1.034681033s","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:08:06.956138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:05.654491Z","time spent":"1.301634892s","remote":"127.0.0.1:39538","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-17T11:08:06.956153Z","caller":"traceutil/trace.go:171","msg":"trace[83293461] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1178; }","duration":"427.812457ms","start":"2026-04-17T11:08:06.528322Z","end":"2026-04-17T11:08:06.956134Z","steps":["trace[83293461] 'agreement among raft nodes before linearized reading' (duration: 427.54951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:06.95621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:06.528304Z","time spent":"427.89162ms","remote":"127.0.0.1:39366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":6,"response size":2209,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"warn","ts":"2026-04-17T11:08:07.470509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.516062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:08:07.470697Z","caller":"traceutil/trace.go:171","msg":"trace[663282182] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"297.361501ms","start":"2026-04-17T11:08:07.173319Z","end":"2026-04-17T11:08:07.47068Z","steps":["trace[663282182] 'process raft request' (duration: 297.288968ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:08:07.47082Z","caller":"traceutil/trace.go:171","msg":"trace[170325844] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"509.452122ms","start":"2026-04-17T11:08:06.961357Z","end":"2026-04-17T11:08:07.470809Z","steps":["trace[170325844] 'process raft request' (duration: 232.557819ms)","trace[170325844] 'compare' (duration: 276.241874ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:07.470875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:06.961339Z","time spent":"509.506534ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:08:07.47091Z","caller":"traceutil/trace.go:171","msg":"trace[952201504] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"505.915727ms","start":"2026-04-17T11:08:06.964976Z","end":"2026-04-17T11:08:07.470892Z","steps":["trace[952201504] 'read index received' (duration: 228.921991ms)","trace[952201504] 'applied index is now lower than readState.Index' (duration: 276.991926ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:07.471111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.117153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T11:08:07.471243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.201655ms","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-17T11:08:07.471277Z","caller":"traceutil/trace.go:171","msg":"trace[444550242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1180; }","duration":"333.279487ms","start":"2026-04-17T11:08:07.13799Z","end":"2026-04-17T11:08:07.471269Z","steps":["trace[444550242] 'agreement among raft nodes before linearized reading' (duration: 333.201285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:07.471297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.137971Z","time spent":"333.321298ms","remote":"127.0.0.1:39538","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-17T11:08:07.471173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.630175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:08:07.471388Z","caller":"traceutil/trace.go:171","msg":"trace[142766327] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:0; response_revision:1180; }","duration":"437.836651ms","start":"2026-04-17T11:08:07.033492Z","end":"2026-04-17T11:08:07.471329Z","steps":["trace[142766327] 'agreement among raft nodes before linearized reading' (duration: 437.642105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:07.47145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.033474Z","time spent":"437.956936ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 "} {"level":"info","ts":"2026-04-17T11:08:07.471404Z","caller":"traceutil/trace.go:171","msg":"trace[1052572767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1180; }","duration":"506.34796ms","start":"2026-04-17T11:08:06.964914Z","end":"2026-04-17T11:08:07.471262Z","steps":["trace[1052572767] 'agreement among raft nodes before linearized reading' (duration: 506.137183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:07.47161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:06.964904Z","time spent":"506.6917ms","remote":"127.0.0.1:39274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T11:08:07.47227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.989375ms","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-17T11:08:07.47235Z","caller":"traceutil/trace.go:171","msg":"trace[1455987157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"215.082977ms","start":"2026-04-17T11:08:07.257238Z","end":"2026-04-17T11:08:07.472321Z","steps":["trace[1455987157] 'agreement among raft nodes before linearized reading' (duration: 213.899902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:08.256266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.740505ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:08:08.256355Z","caller":"traceutil/trace.go:171","msg":"trace[491011434] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"780.849686ms","start":"2026-04-17T11:08:07.475491Z","end":"2026-04-17T11:08:08.256341Z","steps":["trace[491011434] 'process raft request' (duration: 267.967797ms)","trace[491011434] 'compare' (duration: 512.56712ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:08.256403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.475469Z","time spent":"780.90978ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:08:08.72184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.65062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T11:08:08.722189Z","caller":"traceutil/trace.go:171","msg":"trace[383591913] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1228; }","duration":"1.172942925s","start":"2026-04-17T11:08:07.549234Z","end":"2026-04-17T11:08:08.722177Z","steps":["trace[383591913] 'read index received' (duration: 194.219568ms)","trace[383591913] 'applied index is now lower than readState.Index' (duration: 978.532001ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T11:08:08.722187Z","caller":"traceutil/trace.go:171","msg":"trace[826504517] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"1.246614793s","start":"2026-04-17T11:08:07.475547Z","end":"2026-04-17T11:08:08.722162Z","steps":["trace[826504517] 'process raft request' (duration: 1.037572692s)","trace[826504517] 'compare' (duration: 208.500935ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T11:08:08.722286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.475426Z","time spent":"1.246808177s","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T11:08:08.722274Z","caller":"traceutil/trace.go:171","msg":"trace[1894389908] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"1.246067465s","start":"2026-04-17T11:08:07.476172Z","end":"2026-04-17T11:08:08.722239Z","steps":["trace[1894389908] 'process raft request' (duration: 1.245745456s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:08.722459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.476163Z","time spent":"1.246191429s","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T11:08:08.72249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.276758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-17T11:08:08.722495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173222523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/\" range_end:\"/registry/pods/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5483"} {"level":"info","ts":"2026-04-17T11:08:08.722541Z","caller":"traceutil/trace.go:171","msg":"trace[751757868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1183; }","duration":"549.385341ms","start":"2026-04-17T11:08:08.173141Z","end":"2026-04-17T11:08:08.722526Z","steps":["trace[751757868] 'agreement among raft nodes before linearized reading' (duration: 549.208926ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T11:08:08.722553Z","caller":"traceutil/trace.go:171","msg":"trace[691783114] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/; range_end:/registry/pods/envoy-gateway-system0; response_count:1; response_revision:1183; }","duration":"1.173336186s","start":"2026-04-17T11:08:07.549199Z","end":"2026-04-17T11:08:08.722535Z","steps":["trace[691783114] 'agreement among raft nodes before linearized reading' (duration: 1.173035027s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:08.722575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:08.173123Z","time spent":"549.444192ms","remote":"127.0.0.1:39538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T11:08:08.722596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T11:08:07.549183Z","time spent":"1.173399328s","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":5507,"request content":"key:\"/registry/pods/envoy-gateway-system/\" range_end:\"/registry/pods/envoy-gateway-system0\" limit:500 "} {"level":"warn","ts":"2026-04-17T11:08:09.062897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.663934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-public/\" range_end:\"/registry/pods/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T11:08:09.062969Z","caller":"traceutil/trace.go:171","msg":"trace[85569539] range","detail":"{range_begin:/registry/pods/kube-public/; range_end:/registry/pods/kube-public0; response_count:0; response_revision:1184; }","duration":"157.779688ms","start":"2026-04-17T11:08:08.905173Z","end":"2026-04-17T11:08:09.062953Z","steps":["trace[85569539] 'range keys from in-memory index tree' (duration: 157.592342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T11:08:09.063176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.764163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dl2r8\" ","response":"range_response_count:1 size:5483"} {"level":"info","ts":"2026-04-17T11:08:09.063271Z","caller":"traceutil/trace.go:171","msg":"trace[1720630439] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-dl2r8; range_end:; response_count:1; response_revision:1184; }","duration":"170.906657ms","start":"2026-04-17T11:08:08.892342Z","end":"2026-04-17T11:08:09.063248Z","steps":["trace[1720630439] 'range keys from in-memory index tree' (duration: 170.571037ms)"],"step_count":1}