{"level":"warn","ts":"2026-06-09T09:49:03.231837Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T09:49:03.232363Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-06-09T09:49:03.232878Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T09:49:03.232925Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-06-09T09:49:03.233010Z","caller":"embed/etcd.go:528","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-06-09T09:49:03.233898Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-06-09T09:49:03.234033Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-06-09T09:49:03.236743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.340466ms"} {"level":"info","ts":"2026-06-09T09:49:03.242092Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-06-09T09:49:03.242142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T09:49:03.242171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-06-09T09:49:03.242185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T09:49:03.242192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-06-09T09:49:03.242331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-06-09T09:49:03.248840Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T09:49:03.250264Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T09:49:03.250339Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-06-09T09:49:03.251423Z","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-06-09T09:49:03.252943Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.24","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T09:49:03.253164Z","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-06-09T09:49:03.258741Z","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-06-09T09:49:03.258831Z","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-06-09T09:49:03.253080Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T09:49:03.259473Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:49:03.260529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-06-09T09:49:03.260680Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-06-09T09:49:03.261865Z","caller":"embed/etcd.go:762","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-06-09T09:49:03.262110Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T09:49:03.262151Z","caller":"embed/etcd.go:908","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T09:49:03.261988Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-09T09:49:03.262605Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-06-09T09:49:03.942902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T09:49:03.942972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T09:49:03.943061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-06-09T09:49:03.943099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-06-09T09:49:03.943118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-09T09:49:03.943140Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-06-09T09:49:03.943158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-06-09T09:49:03.949652Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:49:03.951288Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T09:49:03.951306Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T09:49:03.951386Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T09:49:03.951601Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T09:49:03.951665Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T09:49:03.951801Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:49:03.951931Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:49:03.951978Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:49:03.954134Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:49:03.954761Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:49:03.959086Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T09:49:03.970690Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-06-09T09:49:06.433888Z","caller":"traceutil/trace.go:171","msg":"trace[1371334325] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"103.96946ms","start":"2026-06-09T09:49:06.329883Z","end":"2026-06-09T09:49:06.433853Z","steps":["trace[1371334325] 'process raft request' (duration: 96.994833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:10.930417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.164152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-09T09:49:10.930562Z","caller":"traceutil/trace.go:171","msg":"trace[1983049019] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:329; }","duration":"144.342917ms","start":"2026-06-09T09:49:10.786193Z","end":"2026-06-09T09:49:10.930535Z","steps":["trace[1983049019] 'range keys from in-memory index tree' (duration: 144.031369ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:11.122409Z","caller":"traceutil/trace.go:171","msg":"trace[943334254] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"187.625827ms","start":"2026-06-09T09:49:10.934752Z","end":"2026-06-09T09:49:11.122378Z","steps":["trace[943334254] 'process raft request' (duration: 186.578279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:11.565460Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.645998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:49:11.565726Z","caller":"traceutil/trace.go:171","msg":"trace[2123926206] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"226.887685ms","start":"2026-06-09T09:49:11.338818Z","end":"2026-06-09T09:49:11.565705Z","steps":["trace[2123926206] 'process raft request' (duration: 226.796592ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:11.565886Z","caller":"traceutil/trace.go:171","msg":"trace[473785015] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"415.289414ms","start":"2026-06-09T09:49:11.150534Z","end":"2026-06-09T09:49:11.565823Z","steps":["trace[473785015] 'process raft request' (duration: 204.701819ms)","trace[473785015] 'compare' (duration: 209.417112ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:11.566083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:11.150520Z","time spent":"415.47461ms","remote":"127.0.0.1:55370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":237,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T09:49:40.390099Z","caller":"traceutil/trace.go:171","msg":"trace[331448299] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"303.536794ms","start":"2026-06-09T09:49:40.086530Z","end":"2026-06-09T09:49:40.390067Z","steps":["trace[331448299] 'process raft request' (duration: 295.474816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:40.390241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:40.086483Z","time spent":"303.700299ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T09:49:40.391426Z","caller":"traceutil/trace.go:171","msg":"trace[1522817981] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:572; }","duration":"149.849914ms","start":"2026-06-09T09:49:40.241563Z","end":"2026-06-09T09:49:40.391413Z","steps":["trace[1522817981] 'read index received' (duration: 140.46478ms)","trace[1522817981] 'applied index is now lower than readState.Index' (duration: 9.384554ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:40.391505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.943167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-09T09:49:40.391537Z","caller":"traceutil/trace.go:171","msg":"trace[292554217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"149.980747ms","start":"2026-06-09T09:49:40.241548Z","end":"2026-06-09T09:49:40.391529Z","steps":["trace[292554217] 'agreement among raft nodes before linearized reading' (duration: 149.911845ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391760Z","caller":"traceutil/trace.go:171","msg":"trace[1056929259] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"289.312734ms","start":"2026-06-09T09:49:40.102417Z","end":"2026-06-09T09:49:40.391730Z","steps":["trace[1056929259] 'process raft request' (duration: 288.80912ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391842Z","caller":"traceutil/trace.go:171","msg":"trace[738665276] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"276.113152ms","start":"2026-06-09T09:49:40.115716Z","end":"2026-06-09T09:49:40.391829Z","steps":["trace[738665276] 'process raft request' (duration: 275.557625ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391928Z","caller":"traceutil/trace.go:171","msg":"trace[1244648690] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"187.663258ms","start":"2026-06-09T09:49:40.204249Z","end":"2026-06-09T09:49:40.391912Z","steps":["trace[1244648690] 'process raft request' (duration: 187.125723ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391974Z","caller":"traceutil/trace.go:171","msg":"trace[1503926318] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"296.416984ms","start":"2026-06-09T09:49:40.095542Z","end":"2026-06-09T09:49:40.391959Z","steps":["trace[1503926318] 'process raft request' (duration: 295.649233ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391986Z","caller":"traceutil/trace.go:171","msg":"trace[894922836] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"304.051069ms","start":"2026-06-09T09:49:40.087927Z","end":"2026-06-09T09:49:40.391978Z","steps":["trace[894922836] 'process raft request' (duration: 303.132233ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:40.391915Z","caller":"traceutil/trace.go:171","msg":"trace[1935733202] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"303.765061ms","start":"2026-06-09T09:49:40.088098Z","end":"2026-06-09T09:49:40.391863Z","steps":["trace[1935733202] 'process raft request' (duration: 303.050441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:40.392242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:40.088093Z","time spent":"303.953287ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:49:40.392334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:40.087909Z","time spent":"304.130551ms","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:49:43.908519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.262264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.908610Z","caller":"traceutil/trace.go:171","msg":"trace[1815366833] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"167.358687ms","start":"2026-06-09T09:49:43.741235Z","end":"2026-06-09T09:49:43.908594Z","steps":["trace[1815366833] 'count revisions from in-memory index tree' (duration: 167.233433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.908775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.604253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.908800Z","caller":"traceutil/trace.go:171","msg":"trace[1272742222] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"167.630984ms","start":"2026-06-09T09:49:43.741163Z","end":"2026-06-09T09:49:43.908794Z","steps":["trace[1272742222] 'range keys from in-memory index tree' (duration: 167.48947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.908839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.610515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.908906Z","caller":"traceutil/trace.go:171","msg":"trace[997283696] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:618; }","duration":"156.694097ms","start":"2026-06-09T09:49:43.752197Z","end":"2026-06-09T09:49:43.908891Z","steps":["trace[997283696] 'count revisions from in-memory index tree' (duration: 156.565422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.909007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.937223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.909036Z","caller":"traceutil/trace.go:171","msg":"trace[2063733899] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:618; }","duration":"156.966884ms","start":"2026-06-09T09:49:43.752063Z","end":"2026-06-09T09:49:43.909030Z","steps":["trace[2063733899] 'range keys from in-memory index tree' (duration: 156.86512ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:43.921344Z","caller":"traceutil/trace.go:171","msg":"trace[220605369] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"143.956007ms","start":"2026-06-09T09:49:43.777355Z","end":"2026-06-09T09:49:43.921311Z","steps":["trace[220605369] 'read index received' (duration: 135.254632ms)","trace[220605369] 'applied index is now lower than readState.Index' (duration: 8.700595ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:43.921499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.127661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.921527Z","caller":"traceutil/trace.go:171","msg":"trace[1658873675] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:619; }","duration":"144.165753ms","start":"2026-06-09T09:49:43.777350Z","end":"2026-06-09T09:49:43.921516Z","steps":["trace[1658873675] 'agreement among raft nodes before linearized reading' (duration: 144.101601ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:43.921470Z","caller":"traceutil/trace.go:171","msg":"trace[133236018] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"165.253557ms","start":"2026-06-09T09:49:43.756173Z","end":"2026-06-09T09:49:43.921427Z","steps":["trace[133236018] 'process raft request' (duration: 157.18888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.921776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.39484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.921799Z","caller":"traceutil/trace.go:171","msg":"trace[1054762514] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:619; }","duration":"144.41811ms","start":"2026-06-09T09:49:43.777374Z","end":"2026-06-09T09:49:43.921792Z","steps":["trace[1054762514] 'agreement among raft nodes before linearized reading' (duration: 144.383919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.921973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.110502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.922027Z","caller":"traceutil/trace.go:171","msg":"trace[422444388] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:619; }","duration":"100.169733ms","start":"2026-06-09T09:49:43.821844Z","end":"2026-06-09T09:49:43.922014Z","steps":["trace[422444388] 'agreement among raft nodes before linearized reading' (duration: 100.079781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.922183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.272416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:43.922253Z","caller":"traceutil/trace.go:171","msg":"trace[1918295661] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:619; }","duration":"100.348408ms","start":"2026-06-09T09:49:43.821885Z","end":"2026-06-09T09:49:43.922234Z","steps":["trace[1918295661] 'agreement among raft nodes before linearized reading' (duration: 100.226485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:46.566333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.364327ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:49:46.566439Z","caller":"traceutil/trace.go:171","msg":"trace[1156447399] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"106.670356ms","start":"2026-06-09T09:49:46.459754Z","end":"2026-06-09T09:49:46.566424Z","steps":["trace[1156447399] 'read index received' (duration: 34.711µs)","trace[1156447399] 'applied index is now lower than readState.Index' (duration: 106.634565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:46.566557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.801961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T09:49:46.566533Z","caller":"traceutil/trace.go:171","msg":"trace[223841442] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"122.404119ms","start":"2026-06-09T09:49:46.444075Z","end":"2026-06-09T09:49:46.566479Z","steps":["trace[223841442] 'compare' (duration: 112.000057ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:49:46.566589Z","caller":"traceutil/trace.go:171","msg":"trace[322541311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"106.836071ms","start":"2026-06-09T09:49:46.459745Z","end":"2026-06-09T09:49:46.566581Z","steps":["trace[322541311] 'agreement among raft nodes before linearized reading' (duration: 106.76093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:47.816449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.29498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-09T09:49:47.816555Z","caller":"traceutil/trace.go:171","msg":"trace[1645507492] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:642; }","duration":"923.422755ms","start":"2026-06-09T09:49:46.893111Z","end":"2026-06-09T09:49:47.816534Z","steps":["trace[1645507492] 'range keys from in-memory index tree' (duration: 923.147666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:47.816597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:46.893091Z","time spent":"923.496416ms","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:49:47.816959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.161278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:49:47.817179Z","caller":"traceutil/trace.go:171","msg":"trace[3502942] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"726.291919ms","start":"2026-06-09T09:49:47.090869Z","end":"2026-06-09T09:49:47.817161Z","steps":["trace[3502942] 'process raft request' (duration: 726.184556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:47.817279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:47.090845Z","time spent":"726.383542ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:49:47.817508Z","caller":"traceutil/trace.go:171","msg":"trace[189784932] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"902.498826ms","start":"2026-06-09T09:49:46.914989Z","end":"2026-06-09T09:49:47.817488Z","steps":["trace[189784932] 'process raft request' (duration: 67.690488ms)","trace[189784932] 'compare' (duration: 833.934822ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:47.817586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:46.914967Z","time spent":"902.588577ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T09:49:49.015585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065521054s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-06-09T09:49:49.015791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:47.818114Z","time spent":"1.197665557s","remote":"127.0.0.1:55174","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-09T09:49:49.015876Z","caller":"traceutil/trace.go:171","msg":"trace[1860200615] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"1.195176348s","start":"2026-06-09T09:49:47.820673Z","end":"2026-06-09T09:49:49.015849Z","steps":["trace[1860200615] 'read index received' (duration: 129.270313ms)","trace[1860200615] 'applied index is now lower than readState.Index' (duration: 1.065902765s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:49.016114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195425214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-09T09:49:49.016156Z","caller":"traceutil/trace.go:171","msg":"trace[330872662] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:646; }","duration":"1.195480127s","start":"2026-06-09T09:49:47.820661Z","end":"2026-06-09T09:49:49.016141Z","steps":["trace[330872662] 'agreement among raft nodes before linearized reading' (duration: 1.195378684s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:49.016197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:47.820645Z","time spent":"1.195542588s","remote":"127.0.0.1:55370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:49:49.016203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183698754s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:49.016235Z","caller":"traceutil/trace.go:171","msg":"trace[419211511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"1.183727965s","start":"2026-06-09T09:49:47.832496Z","end":"2026-06-09T09:49:49.016224Z","steps":["trace[419211511] 'agreement among raft nodes before linearized reading' (duration: 1.183687074s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:49.016272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.723504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T09:49:49.016330Z","caller":"traceutil/trace.go:171","msg":"trace[1475601576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"446.784745ms","start":"2026-06-09T09:49:48.569522Z","end":"2026-06-09T09:49:49.016306Z","steps":["trace[1475601576] 'agreement among raft nodes before linearized reading' (duration: 446.670922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:49.016368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:48.569508Z","time spent":"446.853618ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:49:49.016385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.897428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:49:49.016410Z","caller":"traceutil/trace.go:171","msg":"trace[272639231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"579.921288ms","start":"2026-06-09T09:49:48.436482Z","end":"2026-06-09T09:49:49.016403Z","steps":["trace[272639231] 'agreement among raft nodes before linearized reading' (duration: 579.886817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:49.016432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:48.436463Z","time spent":"579.963769ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T09:49:49.016518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.180651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T09:49:49.016551Z","caller":"traceutil/trace.go:171","msg":"trace[480231865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"434.211932ms","start":"2026-06-09T09:49:48.582329Z","end":"2026-06-09T09:49:49.016541Z","steps":["trace[480231865] 'agreement among raft nodes before linearized reading' (duration: 434.154021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:49.016582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:48.582297Z","time spent":"434.278304ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:49:49.015803Z","caller":"traceutil/trace.go:171","msg":"trace[1212227852] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.317594108s","start":"2026-06-09T09:49:47.698153Z","end":"2026-06-09T09:49:49.015747Z","steps":["trace[1212227852] 'process raft request' (duration: 251.831397ms)","trace[1212227852] 'compare' (duration: 1.065296008s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:49:49.016792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:49:47.698127Z","time spent":"1.318598486s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:50:01.842700Z","caller":"traceutil/trace.go:171","msg":"trace[104555661] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"216.100654ms","start":"2026-06-09T09:50:01.626552Z","end":"2026-06-09T09:50:01.842653Z","steps":["trace[104555661] 'process raft request' (duration: 215.812385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:04.912427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.288082ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-09T09:50:04.912809Z","caller":"traceutil/trace.go:171","msg":"trace[586994860] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"475.224408ms","start":"2026-06-09T09:50:04.437567Z","end":"2026-06-09T09:50:04.912792Z","steps":["trace[586994860] 'read index received' (duration: 47.092µs)","trace[586994860] 'applied index is now lower than readState.Index' (duration: 475.173846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:04.912955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.810485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T09:50:04.912975Z","caller":"traceutil/trace.go:171","msg":"trace[1495607566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:818; }","duration":"469.838416ms","start":"2026-06-09T09:50:04.443130Z","end":"2026-06-09T09:50:04.912968Z","steps":["trace[1495607566] 'agreement among raft nodes before linearized reading' (duration: 469.773725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:04.912950Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.374543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:50:04.913001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:04.443101Z","time spent":"469.893458ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:50:04.913029Z","caller":"traceutil/trace.go:171","msg":"trace[517085738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"475.453976ms","start":"2026-06-09T09:50:04.437553Z","end":"2026-06-09T09:50:04.913007Z","steps":["trace[517085738] 'agreement among raft nodes before linearized reading' (duration: 475.328612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:04.913069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:04.437535Z","time spent":"475.528167ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T09:50:04.913346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.650298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fv6l8\" limit:1 ","response":"range_response_count:1 size:4261"} {"level":"info","ts":"2026-06-09T09:50:04.913416Z","caller":"traceutil/trace.go:171","msg":"trace[52882350] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fv6l8; range_end:; response_count:1; response_revision:818; }","duration":"314.72562ms","start":"2026-06-09T09:50:04.598670Z","end":"2026-06-09T09:50:04.913396Z","steps":["trace[52882350] 'agreement among raft nodes before linearized reading' (duration: 314.580806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:04.913454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:04.598654Z","time spent":"314.790612ms","remote":"127.0.0.1:55354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":4283,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fv6l8\" limit:1 "} {"level":"info","ts":"2026-06-09T09:50:05.024270Z","caller":"traceutil/trace.go:171","msg":"trace[1488304046] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"106.863969ms","start":"2026-06-09T09:50:04.917383Z","end":"2026-06-09T09:50:05.024247Z","steps":["trace[1488304046] 'process raft request' (duration: 106.699174ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:05.027600Z","caller":"traceutil/trace.go:171","msg":"trace[1363143096] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"108.507515ms","start":"2026-06-09T09:50:04.919081Z","end":"2026-06-09T09:50:05.027589Z","steps":["trace[1363143096] 'process raft request' (duration: 108.424913ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:11.267602Z","caller":"traceutil/trace.go:171","msg":"trace[337266802] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"110.349387ms","start":"2026-06-09T09:50:11.157225Z","end":"2026-06-09T09:50:11.267574Z","steps":["trace[337266802] 'process raft request' (duration: 110.069648ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:39.268821Z","caller":"traceutil/trace.go:171","msg":"trace[1678360336] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"262.51296ms","start":"2026-06-09T09:50:39.006282Z","end":"2026-06-09T09:50:39.268795Z","steps":["trace[1678360336] 'process raft request' (duration: 262.301094ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:39.558555Z","caller":"traceutil/trace.go:171","msg":"trace[1773461247] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1069; }","duration":"256.072569ms","start":"2026-06-09T09:50:39.302380Z","end":"2026-06-09T09:50:39.558453Z","steps":["trace[1773461247] 'read index received' (duration: 252.382034ms)","trace[1773461247] 'applied index is now lower than readState.Index' (duration: 3.689635ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:50:39.558620Z","caller":"traceutil/trace.go:171","msg":"trace[1385906466] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"310.385878ms","start":"2026-06-09T09:50:39.248207Z","end":"2026-06-09T09:50:39.558593Z","steps":["trace[1385906466] 'process raft request' (duration: 306.468998ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:39.558726Z","caller":"traceutil/trace.go:171","msg":"trace[1692515918] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"286.065583ms","start":"2026-06-09T09:50:39.272650Z","end":"2026-06-09T09:50:39.558715Z","steps":["trace[1692515918] 'process raft request' (duration: 285.703673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:39.558755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:39.248179Z","time spent":"310.503611ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:50:39.558807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.26694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:50:39.558858Z","caller":"traceutil/trace.go:171","msg":"trace[901542937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"123.328051ms","start":"2026-06-09T09:50:39.435519Z","end":"2026-06-09T09:50:39.558847Z","steps":["trace[901542937] 'agreement among raft nodes before linearized reading' (duration: 123.24401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:39.559031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.646645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T09:50:39.559062Z","caller":"traceutil/trace.go:171","msg":"trace[1877129095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1032; }","duration":"256.678185ms","start":"2026-06-09T09:50:39.302375Z","end":"2026-06-09T09:50:39.559053Z","steps":["trace[1877129095] 'agreement among raft nodes before linearized reading' (duration: 256.618894ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:39.902524Z","caller":"traceutil/trace.go:171","msg":"trace[2037561959] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"339.525648ms","start":"2026-06-09T09:50:39.562971Z","end":"2026-06-09T09:50:39.902497Z","steps":["trace[2037561959] 'process raft request' (duration: 329.966019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:39.902710Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:39.562953Z","time spent":"339.659811ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:50:39.909197Z","caller":"traceutil/trace.go:171","msg":"trace[970975725] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"346.078983ms","start":"2026-06-09T09:50:39.563099Z","end":"2026-06-09T09:50:39.909177Z","steps":["trace[970975725] 'process raft request' (duration: 345.863677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:39.909309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:39.563071Z","time spent":"346.180135ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:50:39.909363Z","caller":"traceutil/trace.go:171","msg":"trace[98300570] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"189.665319ms","start":"2026-06-09T09:50:39.719677Z","end":"2026-06-09T09:50:39.909342Z","steps":["trace[98300570] 'process raft request' (duration: 189.393491ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:03.709201Z","caller":"traceutil/trace.go:171","msg":"trace[2060286458] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"272.930234ms","start":"2026-06-09T09:51:03.436247Z","end":"2026-06-09T09:51:03.709177Z","steps":["trace[2060286458] 'read index received' (duration: 272.777991ms)","trace[2060286458] 'applied index is now lower than readState.Index' (duration: 151.343µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:03.709323Z","caller":"traceutil/trace.go:171","msg":"trace[1028346606] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"341.935715ms","start":"2026-06-09T09:51:03.367377Z","end":"2026-06-09T09:51:03.709312Z","steps":["trace[1028346606] 'process raft request' (duration: 341.643768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:03.709429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:03.367348Z","time spent":"342.002577ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:03.709570Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.329956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:03.709619Z","caller":"traceutil/trace.go:171","msg":"trace[105548748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1109; }","duration":"273.355336ms","start":"2026-06-09T09:51:03.436234Z","end":"2026-06-09T09:51:03.709589Z","steps":["trace[105548748] 'agreement among raft nodes before linearized reading' (duration: 273.308375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:04.623139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.534052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:04.623234Z","caller":"traceutil/trace.go:171","msg":"trace[416904364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1114; }","duration":"185.641935ms","start":"2026-06-09T09:51:04.437572Z","end":"2026-06-09T09:51:04.623214Z","steps":["trace[416904364] 'range keys from in-memory index tree' (duration: 185.457601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:04.623214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:04.312424Z","time spent":"310.783187ms","remote":"127.0.0.1:44688","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-09T09:51:05.996601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.307356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:05.996686Z","caller":"traceutil/trace.go:171","msg":"trace[552373321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1117; }","duration":"107.407839ms","start":"2026-06-09T09:51:05.889260Z","end":"2026-06-09T09:51:05.996667Z","steps":["trace[552373321] 'range keys from in-memory index tree' (duration: 107.212023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:21.333976Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680220396017915030,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T09:51:21.650178Z","caller":"traceutil/trace.go:171","msg":"trace[1233418202] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"817.2561ms","start":"2026-06-09T09:51:20.832903Z","end":"2026-06-09T09:51:21.650159Z","steps":["trace[1233418202] 'read index received' (duration: 817.158327ms)","trace[1233418202] 'applied index is now lower than readState.Index' (duration: 97.103µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:21.650417Z","caller":"traceutil/trace.go:171","msg":"trace[1701224542] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"839.622831ms","start":"2026-06-09T09:51:20.810785Z","end":"2026-06-09T09:51:21.650408Z","steps":["trace[1701224542] 'process raft request' (duration: 839.270092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:21.650489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:20.810762Z","time spent":"839.679584ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:21.650626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.725183ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:21.650652Z","caller":"traceutil/trace.go:171","msg":"trace[1907904967] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1219; }","duration":"817.749934ms","start":"2026-06-09T09:51:20.832895Z","end":"2026-06-09T09:51:21.650645Z","steps":["trace[1907904967] 'agreement among raft nodes before linearized reading' (duration: 817.712973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:21.650804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.321614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:21.650828Z","caller":"traceutil/trace.go:171","msg":"trace[1222074247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"214.345394ms","start":"2026-06-09T09:51:21.436477Z","end":"2026-06-09T09:51:21.650823Z","steps":["trace[1222074247] 'agreement among raft nodes before linearized reading' (duration: 214.311133ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:38.170355Z","caller":"traceutil/trace.go:171","msg":"trace[1776195521] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"257.862905ms","start":"2026-06-09T09:51:37.912473Z","end":"2026-06-09T09:51:38.170336Z","steps":["trace[1776195521] 'process raft request' (duration: 257.67091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.419740Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.162536ms","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-06-09T09:51:39.419834Z","caller":"traceutil/trace.go:171","msg":"trace[1300925642] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1292; }","duration":"587.262879ms","start":"2026-06-09T09:51:38.832555Z","end":"2026-06-09T09:51:39.419817Z","steps":["trace[1300925642] 'range keys from in-memory index tree' (duration: 587.119886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.419922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.230232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:39.420048Z","caller":"traceutil/trace.go:171","msg":"trace[1561767059] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1344; }","duration":"1.469160737s","start":"2026-06-09T09:51:37.950867Z","end":"2026-06-09T09:51:39.420028Z","steps":["trace[1561767059] 'read index received' (duration: 219.314543ms)","trace[1561767059] 'applied index is now lower than readState.Index' (duration: 1.249844794s)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:39.420124Z","caller":"traceutil/trace.go:171","msg":"trace[757678037] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"1.505842928s","start":"2026-06-09T09:51:37.914264Z","end":"2026-06-09T09:51:39.420107Z","steps":["trace[757678037] 'process raft request' (duration: 1.167325588s)","trace[757678037] 'compare' (duration: 337.691627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:39.420194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469325001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-09T09:51:39.420215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:37.914251Z","time spent":"1.505910939s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:39.420247Z","caller":"traceutil/trace.go:171","msg":"trace[145534052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1293; }","duration":"1.469378463s","start":"2026-06-09T09:51:37.950856Z","end":"2026-06-09T09:51:39.420234Z","steps":["trace[145534052] 'agreement among raft nodes before linearized reading' (duration: 1.4692667s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.420300Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:37.950839Z","time spent":"1.469448185s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:51:39.624924Z","caller":"traceutil/trace.go:171","msg":"trace[820427556] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"1.331839055s","start":"2026-06-09T09:51:38.293037Z","end":"2026-06-09T09:51:39.624876Z","steps":["trace[820427556] 'process raft request' (duration: 1.320938863s)","trace[820427556] 'compare' (duration: 10.779749ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:39.625086Z","caller":"traceutil/trace.go:171","msg":"trace[2124283803] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1346; }","duration":"204.977063ms","start":"2026-06-09T09:51:39.420087Z","end":"2026-06-09T09:51:39.625064Z","steps":["trace[2124283803] 'read index received' (duration: 193.824882ms)","trace[2124283803] 'applied index is now lower than readState.Index' (duration: 11.151401ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:39.625474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.293021Z","time spent":"1.33235887s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:39.625182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.507280788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:39.625589Z","caller":"traceutil/trace.go:171","msg":"trace[1356118646] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1295; }","duration":"1.507675508s","start":"2026-06-09T09:51:38.117880Z","end":"2026-06-09T09:51:39.625556Z","steps":["trace[1356118646] 'agreement among raft nodes before linearized reading' (duration: 1.507266257s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.625676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.117866Z","time spent":"1.507779261s","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-09T09:51:39.625210Z","caller":"traceutil/trace.go:171","msg":"trace[374521220] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"816.521299ms","start":"2026-06-09T09:51:38.808682Z","end":"2026-06-09T09:51:39.625203Z","steps":["trace[374521220] 'process raft request' (duration: 816.300532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.625817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.808659Z","time spent":"817.126895ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:39.625231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.356303ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:39.625940Z","caller":"traceutil/trace.go:171","msg":"trace[1665758957] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1295; }","duration":"206.059163ms","start":"2026-06-09T09:51:39.419870Z","end":"2026-06-09T09:51:39.625929Z","steps":["trace[1665758957] 'agreement among raft nodes before linearized reading' (duration: 205.350343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.625259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.399758266s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-09T09:51:39.626160Z","caller":"traceutil/trace.go:171","msg":"trace[309505469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1295; }","duration":"1.40064876s","start":"2026-06-09T09:51:38.225498Z","end":"2026-06-09T09:51:39.626147Z","steps":["trace[309505469] 'agreement among raft nodes before linearized reading' (duration: 1.399741154s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.626201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.225489Z","time spent":"1.400700771s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:51:39.625280Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407431029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-09T09:51:39.626334Z","caller":"traceutil/trace.go:171","msg":"trace[1701040140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1295; }","duration":"1.408478918s","start":"2026-06-09T09:51:38.217846Z","end":"2026-06-09T09:51:39.626325Z","steps":["trace[1701040140] 'agreement among raft nodes before linearized reading' (duration: 1.407420319s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.626366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.217831Z","time spent":"1.408526259s","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:51:39.638439Z","caller":"traceutil/trace.go:171","msg":"trace[1004764764] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"213.45605ms","start":"2026-06-09T09:51:39.424956Z","end":"2026-06-09T09:51:39.638412Z","steps":["trace[1004764764] 'process raft request' (duration: 213.317716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.638444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.252334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:39.638602Z","caller":"traceutil/trace.go:171","msg":"trace[2043762147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"204.420998ms","start":"2026-06-09T09:51:39.434171Z","end":"2026-06-09T09:51:39.638592Z","steps":["trace[2043762147] 'agreement among raft nodes before linearized reading' (duration: 204.208012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.881712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.967375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:39.881923Z","caller":"traceutil/trace.go:171","msg":"trace[672777090] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1349; }","duration":"242.522148ms","start":"2026-06-09T09:51:39.639383Z","end":"2026-06-09T09:51:39.881905Z","steps":["trace[672777090] 'read index received' (duration: 93.198403ms)","trace[672777090] 'applied index is now lower than readState.Index' (duration: 149.322815ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:39.881957Z","caller":"traceutil/trace.go:171","msg":"trace[1384819613] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"250.521601ms","start":"2026-06-09T09:51:39.631419Z","end":"2026-06-09T09:51:39.881941Z","steps":["trace[1384819613] 'process raft request' (duration: 250.419508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.882056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.669852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:39.882091Z","caller":"traceutil/trace.go:171","msg":"trace[1167084012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1298; }","duration":"242.704983ms","start":"2026-06-09T09:51:39.639377Z","end":"2026-06-09T09:51:39.882082Z","steps":["trace[1167084012] 'agreement among raft nodes before linearized reading' (duration: 242.648022ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:39.882258Z","caller":"traceutil/trace.go:171","msg":"trace[874971474] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"250.567553ms","start":"2026-06-09T09:51:39.631332Z","end":"2026-06-09T09:51:39.881899Z","steps":["trace[874971474] 'process raft request' (duration: 101.31984ms)","trace[874971474] 'compare' (duration: 148.817971ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:40.311018Z","caller":"traceutil/trace.go:171","msg":"trace[2058295985] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"210.194039ms","start":"2026-06-09T09:51:40.100795Z","end":"2026-06-09T09:51:40.310989Z","steps":["trace[2058295985] 'process raft request' (duration: 210.028504ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:40.782062Z","caller":"traceutil/trace.go:171","msg":"trace[577435548] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"374.276864ms","start":"2026-06-09T09:51:40.407766Z","end":"2026-06-09T09:51:40.782043Z","steps":["trace[577435548] 'read index received' (duration: 374.12545ms)","trace[577435548] 'applied index is now lower than readState.Index' (duration: 150.824µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:40.782171Z","caller":"traceutil/trace.go:171","msg":"trace[1791539277] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"604.672336ms","start":"2026-06-09T09:51:40.177469Z","end":"2026-06-09T09:51:40.782142Z","steps":["trace[1791539277] 'process raft request' (duration: 604.46022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:40.782278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.47349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:51:40.782326Z","caller":"traceutil/trace.go:171","msg":"trace[1734275067] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1300; }","duration":"374.560452ms","start":"2026-06-09T09:51:40.407756Z","end":"2026-06-09T09:51:40.782316Z","steps":["trace[1734275067] 'agreement among raft nodes before linearized reading' (duration: 374.449369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:40.782332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:40.177450Z","time spent":"604.798849ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:40.782387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:40.407740Z","time spent":"374.621185ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-09T09:51:40.782397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.016396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:40.782454Z","caller":"traceutil/trace.go:171","msg":"trace[1548033901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1300; }","duration":"347.076718ms","start":"2026-06-09T09:51:40.435364Z","end":"2026-06-09T09:51:40.782441Z","steps":["trace[1548033901] 'agreement among raft nodes before linearized reading' (duration: 346.992876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:40.782484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:40.435333Z","time spent":"347.146049ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T09:51:41.463331Z","caller":"traceutil/trace.go:171","msg":"trace[1742138838] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"335.824244ms","start":"2026-06-09T09:51:41.127478Z","end":"2026-06-09T09:51:41.463302Z","steps":["trace[1742138838] 'process raft request' (duration: 335.625449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:41.463524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:41.127452Z","time spent":"335.979558ms","remote":"127.0.0.1:55342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6062,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:42.054801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.160909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-09T09:51:42.055010Z","caller":"traceutil/trace.go:171","msg":"trace[1174815039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1304; }","duration":"168.377575ms","start":"2026-06-09T09:51:41.886613Z","end":"2026-06-09T09:51:42.054991Z","steps":["trace[1174815039] 'range keys from in-memory index tree' (duration: 168.061276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:42.054863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.279031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-09T09:51:42.055415Z","caller":"traceutil/trace.go:171","msg":"trace[491794824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"168.832557ms","start":"2026-06-09T09:51:41.886553Z","end":"2026-06-09T09:51:42.055385Z","steps":["trace[491794824] 'range keys from in-memory index tree' (duration: 168.182318ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:50.686405Z","caller":"traceutil/trace.go:171","msg":"trace[826392053] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"168.179279ms","start":"2026-06-09T09:51:50.518201Z","end":"2026-06-09T09:51:50.686381Z","steps":["trace[826392053] 'process raft request' (duration: 168.024884ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.103929Z","caller":"traceutil/trace.go:171","msg":"trace[726459189] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1432; }","duration":"271.104563ms","start":"2026-06-09T09:51:50.832803Z","end":"2026-06-09T09:51:51.103908Z","steps":["trace[726459189] 'read index received' (duration: 270.929408ms)","trace[726459189] 'applied index is now lower than readState.Index' (duration: 174.385µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:51.104025Z","caller":"traceutil/trace.go:171","msg":"trace[1948598810] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"288.62969ms","start":"2026-06-09T09:51:50.815350Z","end":"2026-06-09T09:51:51.103980Z","steps":["trace[1948598810] 'process raft request' (duration: 288.409214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.104172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.339569ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:51:51.104197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.350305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:51.104389Z","caller":"traceutil/trace.go:171","msg":"trace[1091764524] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1378; }","duration":"159.51784ms","start":"2026-06-09T09:51:50.944816Z","end":"2026-06-09T09:51:51.104334Z","steps":["trace[1091764524] 'agreement among raft nodes before linearized reading' (duration: 159.259632ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.104267Z","caller":"traceutil/trace.go:171","msg":"trace[1768255530] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1378; }","duration":"271.446602ms","start":"2026-06-09T09:51:50.832796Z","end":"2026-06-09T09:51:51.104242Z","steps":["trace[1768255530] 'agreement among raft nodes before linearized reading' (duration: 271.262017ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.782122Z","caller":"traceutil/trace.go:171","msg":"trace[661259110] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1433; }","duration":"345.754521ms","start":"2026-06-09T09:51:51.436346Z","end":"2026-06-09T09:51:51.782101Z","steps":["trace[661259110] 'read index received' (duration: 345.71478ms)","trace[661259110] 'applied index is now lower than readState.Index' (duration: 38.671µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:51.782234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.879514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:51.782258Z","caller":"traceutil/trace.go:171","msg":"trace[1932542560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1379; }","duration":"345.918505ms","start":"2026-06-09T09:51:51.436332Z","end":"2026-06-09T09:51:51.782250Z","steps":["trace[1932542560] 'agreement among raft nodes before linearized reading' (duration: 345.858884ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.782241Z","caller":"traceutil/trace.go:171","msg":"trace[471769107] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"410.388798ms","start":"2026-06-09T09:51:51.371821Z","end":"2026-06-09T09:51:51.782210Z","steps":["trace[471769107] 'process raft request' (duration: 410.150542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.782397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.436314Z","time spent":"346.074139ms","remote":"127.0.0.1:49624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T09:51:51.782421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.371802Z","time spent":"410.523032ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:51:51.965805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.25278ms","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-06-09T09:51:51.965922Z","caller":"traceutil/trace.go:171","msg":"trace[501992811] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1379; }","duration":"132.355153ms","start":"2026-06-09T09:51:51.833513Z","end":"2026-06-09T09:51:51.965868Z","steps":["trace[501992811] 'range keys from in-memory index tree' (duration: 132.207979ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.966340Z","caller":"traceutil/trace.go:171","msg":"trace[1333809822] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1434; }","duration":"183.025852ms","start":"2026-06-09T09:51:51.783272Z","end":"2026-06-09T09:51:51.966298Z","steps":["trace[1333809822] 'read index received' (duration: 177.062116ms)","trace[1333809822] 'applied index is now lower than readState.Index' (duration: 5.962856ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:51.966605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.32212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:51.966672Z","caller":"traceutil/trace.go:171","msg":"trace[156834092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1381; }","duration":"183.388302ms","start":"2026-06-09T09:51:51.783269Z","end":"2026-06-09T09:51:51.966657Z","steps":["trace[156834092] 'agreement among raft nodes before linearized reading' (duration: 183.282989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.966683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.965908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T09:51:51.966772Z","caller":"traceutil/trace.go:171","msg":"trace[1396516773] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"446.412151ms","start":"2026-06-09T09:51:51.520316Z","end":"2026-06-09T09:51:51.966728Z","steps":["trace[1396516773] 'process raft request' (duration: 440.077674ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.966862Z","caller":"traceutil/trace.go:171","msg":"trace[11237198] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1381; }","duration":"148.144642ms","start":"2026-06-09T09:51:51.818703Z","end":"2026-06-09T09:51:51.966847Z","steps":["trace[11237198] 'agreement among raft nodes before linearized reading' (duration: 147.932466ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.966995Z","caller":"traceutil/trace.go:171","msg":"trace[1002767104] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"198.883734ms","start":"2026-06-09T09:51:51.768091Z","end":"2026-06-09T09:51:51.966975Z","steps":["trace[1002767104] 'process raft request' (duration: 198.136983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.967048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.520288Z","time spent":"446.620016ms","remote":"127.0.0.1:55424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}