{"level":"warn","ts":"2026-04-27T20:55:59.631976Z","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-27T20:55:59.632091Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.3: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.3:2380","--initial-cluster=instance=https://199.19.213.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.3: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-27T20:55:59.632166Z","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-27T20:55:59.632183Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-04-27T20:55:59.632208Z","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-27T20:55:59.632869Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"]} {"level":"info","ts":"2026-04-27T20:55:59.632958Z","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.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.3: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-27T20:55:59.638406Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.169269ms"} {"level":"info","ts":"2026-04-27T20:55:59.645838Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cf904ec39d3e333","cluster-id":"7b1ae51097bedd0e"} {"level":"info","ts":"2026-04-27T20:55:59.645954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T20:55:59.645989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 0"} {"level":"info","ts":"2026-04-27T20:55:59.646011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cf904ec39d3e333 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T20:55:59.646031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 1"} {"level":"info","ts":"2026-04-27T20:55:59.646079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"warn","ts":"2026-04-27T20:55:59.653218Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T20:55:59.654576Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T20:55:59.657018Z","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-27T20:55:59.660189Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cf904ec39d3e333","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T20:55:59.660962Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cf904ec39d3e333","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T20:55:59.661232Z","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-27T20:55:59.661376Z","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-27T20:55:59.661398Z","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-27T20:55:59.661859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"info","ts":"2026-04-27T20:55:59.662703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","added-peer-id":"3cf904ec39d3e333","added-peer-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-04-27T20:55:59.66634Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-04-27T20:55:59.666342Z","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-27T20:55:59.666412Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-04-27T20:55:59.666871Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cf904ec39d3e333","initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T20:55:59.666943Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T20:55:59.947082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T20:55:59.947193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T20:55:59.94723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgPreVoteResp from 3cf904ec39d3e333 at term 1"} {"level":"info","ts":"2026-04-27T20:55:59.947253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became candidate at term 2"} {"level":"info","ts":"2026-04-27T20:55:59.947265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgVoteResp from 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-04-27T20:55:59.947282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became leader at term 2"} {"level":"info","ts":"2026-04-27T20:55:59.947297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cf904ec39d3e333 elected leader 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-04-27T20:55:59.949867Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cf904ec39d3e333","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.3:2379]}","request-path":"/0/members/3cf904ec39d3e333/attributes","cluster-id":"7b1ae51097bedd0e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T20:55:59.950391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:55:59.950668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T20:55:59.950707Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T20:55:59.951189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T20:55:59.95122Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T20:55:59.951424Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:55:59.951644Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:55:59.951744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T20:55:59.953181Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T20:55:59.953999Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.3:2379"} {"level":"info","ts":"2026-04-27T20:56:07.982453Z","caller":"traceutil/trace.go:171","msg":"trace[1915451175] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"129.024826ms","start":"2026-04-27T20:56:07.8534Z","end":"2026-04-27T20:56:07.982425Z","steps":["trace[1915451175] 'read index received' (duration: 128.865785ms)","trace[1915451175] 'applied index is now lower than readState.Index' (duration: 157.931µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:56:07.982552Z","caller":"traceutil/trace.go:171","msg":"trace[1502446987] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"168.899999ms","start":"2026-04-27T20:56:07.813622Z","end":"2026-04-27T20:56:07.982522Z","steps":["trace[1502446987] 'process raft request' (duration: 168.640297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:07.982621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.200197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-27T20:56:07.982734Z","caller":"traceutil/trace.go:171","msg":"trace[50421111] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:285; }","duration":"129.327318ms","start":"2026-04-27T20:56:07.853385Z","end":"2026-04-27T20:56:07.982712Z","steps":["trace[50421111] 'agreement among raft nodes before linearized reading' (duration: 129.162617ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:12.204222Z","caller":"traceutil/trace.go:171","msg":"trace[356497504] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"306.630453ms","start":"2026-04-27T20:56:11.897555Z","end":"2026-04-27T20:56:12.204186Z","steps":["trace[356497504] 'process raft request' (duration: 299.566315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:12.205216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:11.897533Z","time spent":"306.796594ms","remote":"127.0.0.1:60544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T20:56:12.518314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.989957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T20:56:12.518424Z","caller":"traceutil/trace.go:171","msg":"trace[1333725416] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:366; }","duration":"521.80397ms","start":"2026-04-27T20:56:11.996605Z","end":"2026-04-27T20:56:12.518409Z","steps":["trace[1333725416] 'read index received' (duration: 200.63712ms)","trace[1333725416] 'applied index is now lower than readState.Index' (duration: 321.1657ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:56:12.5187Z","caller":"traceutil/trace.go:171","msg":"trace[1543989771] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"605.465317ms","start":"2026-04-27T20:56:11.913224Z","end":"2026-04-27T20:56:12.518689Z","steps":["trace[1543989771] 'process raft request' (duration: 491.815236ms)","trace[1543989771] 'compare' (duration: 112.827456ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:12.518843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:11.913193Z","time spent":"605.538869ms","remote":"127.0.0.1:60350","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-04-27T20:56:12.519166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.996555ms","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-27T20:56:12.519301Z","caller":"traceutil/trace.go:171","msg":"trace[1906906046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"447.159905ms","start":"2026-04-27T20:56:12.072088Z","end":"2026-04-27T20:56:12.519248Z","steps":["trace[1906906046] 'agreement among raft nodes before linearized reading' (duration: 446.774333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:12.519385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:12.072053Z","time spent":"447.319227ms","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T20:56:12.519423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.819966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T20:56:12.519643Z","caller":"traceutil/trace.go:171","msg":"trace[1440901200] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"523.017948ms","start":"2026-04-27T20:56:11.996546Z","end":"2026-04-27T20:56:12.519564Z","steps":["trace[1440901200] 'agreement among raft nodes before linearized reading' (duration: 522.714535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:12.51968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:11.996521Z","time spent":"523.150138ms","remote":"127.0.0.1:60350","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":"info","ts":"2026-04-27T20:56:32.634735Z","caller":"traceutil/trace.go:171","msg":"trace[2089076512] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"132.177831ms","start":"2026-04-27T20:56:32.502518Z","end":"2026-04-27T20:56:32.634696Z","steps":["trace[2089076512] 'process raft request' (duration: 131.790374ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.640832Z","caller":"traceutil/trace.go:171","msg":"trace[213720576] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"118.478264ms","start":"2026-04-27T20:56:32.522326Z","end":"2026-04-27T20:56:32.640805Z","steps":["trace[213720576] 'process raft request' (duration: 118.174691ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641092Z","caller":"traceutil/trace.go:171","msg":"trace[900043844] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"118.760135ms","start":"2026-04-27T20:56:32.52231Z","end":"2026-04-27T20:56:32.64107Z","steps":["trace[900043844] 'process raft request' (duration: 118.224982ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641232Z","caller":"traceutil/trace.go:171","msg":"trace[2049360702] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"134.844897ms","start":"2026-04-27T20:56:32.506376Z","end":"2026-04-27T20:56:32.641221Z","steps":["trace[2049360702] 'process raft request' (duration: 133.888275ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641245Z","caller":"traceutil/trace.go:171","msg":"trace[128759524] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"118.873301ms","start":"2026-04-27T20:56:32.522364Z","end":"2026-04-27T20:56:32.641238Z","steps":["trace[128759524] 'process raft request' (duration: 118.200961ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641268Z","caller":"traceutil/trace.go:171","msg":"trace[1883734294] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"118.15341ms","start":"2026-04-27T20:56:32.52311Z","end":"2026-04-27T20:56:32.641263Z","steps":["trace[1883734294] 'process raft request' (duration: 117.484421ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.64129Z","caller":"traceutil/trace.go:171","msg":"trace[727813692] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"112.867779ms","start":"2026-04-27T20:56:32.528417Z","end":"2026-04-27T20:56:32.641284Z","steps":["trace[727813692] 'process raft request' (duration: 112.229721ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641308Z","caller":"traceutil/trace.go:171","msg":"trace[986573125] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"103.552314ms","start":"2026-04-27T20:56:32.537751Z","end":"2026-04-27T20:56:32.641304Z","steps":["trace[986573125] 'process raft request' (duration: 102.942997ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641741Z","caller":"traceutil/trace.go:171","msg":"trace[1685545209] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"119.490307ms","start":"2026-04-27T20:56:32.522243Z","end":"2026-04-27T20:56:32.641733Z","steps":["trace[1685545209] 'process raft request' (duration: 118.16452ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:32.641764Z","caller":"traceutil/trace.go:171","msg":"trace[1668231362] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"129.790396ms","start":"2026-04-27T20:56:32.511968Z","end":"2026-04-27T20:56:32.641758Z","steps":["trace[1668231362] 'process raft request' (duration: 128.407976ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:33.573304Z","caller":"traceutil/trace.go:171","msg":"trace[334311565] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"165.776198ms","start":"2026-04-27T20:56:33.4075Z","end":"2026-04-27T20:56:33.573277Z","steps":["trace[334311565] 'process raft request' (duration: 165.380961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:39.858424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054702842s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T20:56:39.858567Z","caller":"traceutil/trace.go:171","msg":"trace[383869997] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"1.10937914s","start":"2026-04-27T20:56:38.749165Z","end":"2026-04-27T20:56:39.858544Z","steps":["trace[383869997] 'read index received' (duration: 54.341894ms)","trace[383869997] 'applied index is now lower than readState.Index' (duration: 1.055035816s)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:56:39.858581Z","caller":"traceutil/trace.go:171","msg":"trace[1102800502] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.13232485s","start":"2026-04-27T20:56:38.726231Z","end":"2026-04-27T20:56:39.858556Z","steps":["trace[1102800502] 'process raft request' (duration: 77.385199ms)","trace[1102800502] 'compare' (duration: 1.054491283s)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:39.85876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:38.726206Z","time spent":"1.132443905s","remote":"127.0.0.1:60414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:56:39.858847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109664901s","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-27T20:56:39.858915Z","caller":"traceutil/trace.go:171","msg":"trace[1944821301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"1.109780506s","start":"2026-04-27T20:56:38.749118Z","end":"2026-04-27T20:56:39.858899Z","steps":["trace[1944821301] 'agreement among raft nodes before linearized reading' (duration: 1.109536556s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:39.858972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:38.749095Z","time spent":"1.109864509s","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T20:56:39.859102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065399866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:39.859139Z","caller":"traceutil/trace.go:171","msg":"trace[1953028102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"1.06550068s","start":"2026-04-27T20:56:38.793629Z","end":"2026-04-27T20:56:39.85913Z","steps":["trace[1953028102] 'agreement among raft nodes before linearized reading' (duration: 1.065404886s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:39.859181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:38.79361Z","time spent":"1.065548351s","remote":"127.0.0.1:60106","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-04-27T20:56:39.859691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.415135ms","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-27T20:56:39.85972Z","caller":"traceutil/trace.go:171","msg":"trace[1708582077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"220.484029ms","start":"2026-04-27T20:56:39.639228Z","end":"2026-04-27T20:56:39.859712Z","steps":["trace[1708582077] 'agreement among raft nodes before linearized reading' (duration: 220.325572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:39.861554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.453452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T20:56:39.86167Z","caller":"traceutil/trace.go:171","msg":"trace[2062057112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"987.62409ms","start":"2026-04-27T20:56:38.874021Z","end":"2026-04-27T20:56:39.861646Z","steps":["trace[2062057112] 'agreement among raft nodes before linearized reading' (duration: 985.38253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:39.861766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:38.874006Z","time spent":"987.745854ms","remote":"127.0.0.1:60350","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":"info","ts":"2026-04-27T20:56:40.401555Z","caller":"traceutil/trace.go:171","msg":"trace[1729855549] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"116.594278ms","start":"2026-04-27T20:56:40.284934Z","end":"2026-04-27T20:56:40.401528Z","steps":["trace[1729855549] 'process raft request' (duration: 115.937502ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:40.697201Z","caller":"traceutil/trace.go:171","msg":"trace[957913293] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"216.272068ms","start":"2026-04-27T20:56:40.480901Z","end":"2026-04-27T20:56:40.697173Z","steps":["trace[957913293] 'read index received' (duration: 216.051729ms)","trace[957913293] 'applied index is now lower than readState.Index' (duration: 219.569µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:40.697501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.571409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.697577Z","caller":"traceutil/trace.go:171","msg":"trace[913558190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"216.730956ms","start":"2026-04-27T20:56:40.480826Z","end":"2026-04-27T20:56:40.697557Z","steps":["trace[913558190] 'agreement among raft nodes before linearized reading' (duration: 216.559759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.697825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.779208ms","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":"warn","ts":"2026-04-27T20:56:40.697972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.103481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.69801Z","caller":"traceutil/trace.go:171","msg":"trace[1777830776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:583; }","duration":"138.150983ms","start":"2026-04-27T20:56:40.559846Z","end":"2026-04-27T20:56:40.697997Z","steps":["trace[1777830776] 'agreement among raft nodes before linearized reading' (duration: 138.100931ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:40.69796Z","caller":"traceutil/trace.go:171","msg":"trace[2129754960] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"216.950954ms","start":"2026-04-27T20:56:40.480994Z","end":"2026-04-27T20:56:40.697945Z","steps":["trace[2129754960] 'agreement among raft nodes before linearized reading' (duration: 216.765417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.698468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.290002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.698499Z","caller":"traceutil/trace.go:171","msg":"trace[595705292] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"105.360004ms","start":"2026-04-27T20:56:40.593132Z","end":"2026-04-27T20:56:40.698492Z","steps":["trace[595705292] 'agreement among raft nodes before linearized reading' (duration: 105.285651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.698652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.51549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.698682Z","caller":"traceutil/trace.go:171","msg":"trace[1186423835] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"105.594613ms","start":"2026-04-27T20:56:40.593078Z","end":"2026-04-27T20:56:40.698673Z","steps":["trace[1186423835] 'agreement among raft nodes before linearized reading' (duration: 105.53157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.698667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.407246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:40.698786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.374632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.698816Z","caller":"traceutil/trace.go:171","msg":"trace[470097252] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:583; }","duration":"138.487166ms","start":"2026-04-27T20:56:40.560321Z","end":"2026-04-27T20:56:40.698809Z","steps":["trace[470097252] 'agreement among raft nodes before linearized reading' (duration: 138.442155ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:40.69882Z","caller":"traceutil/trace.go:171","msg":"trace[21852443] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"183.691527ms","start":"2026-04-27T20:56:40.515104Z","end":"2026-04-27T20:56:40.698796Z","steps":["trace[21852443] 'agreement among raft nodes before linearized reading' (duration: 183.335143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.698965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.113233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.699079Z","caller":"traceutil/trace.go:171","msg":"trace[1282216321] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"184.580143ms","start":"2026-04-27T20:56:40.514485Z","end":"2026-04-27T20:56:40.699065Z","steps":["trace[1282216321] 'agreement among raft nodes before linearized reading' (duration: 183.978269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.699393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.635764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.699429Z","caller":"traceutil/trace.go:171","msg":"trace[214213509] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"158.721888ms","start":"2026-04-27T20:56:40.540697Z","end":"2026-04-27T20:56:40.699419Z","steps":["trace[214213509] 'agreement among raft nodes before linearized reading' (duration: 158.669435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.699402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.886804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.699616Z","caller":"traceutil/trace.go:171","msg":"trace[356453423] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:583; }","duration":"185.135714ms","start":"2026-04-27T20:56:40.514467Z","end":"2026-04-27T20:56:40.699603Z","steps":["trace[356453423] 'agreement among raft nodes before linearized reading' (duration: 184.902105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.699719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.603562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.699745Z","caller":"traceutil/trace.go:171","msg":"trace[156931481] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"159.672835ms","start":"2026-04-27T20:56:40.540065Z","end":"2026-04-27T20:56:40.699738Z","steps":["trace[156931481] 'agreement among raft nodes before linearized reading' (duration: 159.639464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.699543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.742136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.699886Z","caller":"traceutil/trace.go:171","msg":"trace[290283758] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:583; }","duration":"140.08659ms","start":"2026-04-27T20:56:40.559793Z","end":"2026-04-27T20:56:40.69988Z","steps":["trace[290283758] 'agreement among raft nodes before linearized reading' (duration: 139.730126ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:40.697838Z","caller":"traceutil/trace.go:171","msg":"trace[1102904848] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"220.181472ms","start":"2026-04-27T20:56:40.477643Z","end":"2026-04-27T20:56:40.697824Z","steps":["trace[1102904848] 'process raft request' (duration: 219.389271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:40.69964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.428706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:40.699687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.193554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:40.700153Z","caller":"traceutil/trace.go:171","msg":"trace[1998477689] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:583; }","duration":"218.628851ms","start":"2026-04-27T20:56:40.481486Z","end":"2026-04-27T20:56:40.700115Z","steps":["trace[1998477689] 'agreement among raft nodes before linearized reading' (duration: 218.181683ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:40.700216Z","caller":"traceutil/trace.go:171","msg":"trace[1685284992] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"159.956977ms","start":"2026-04-27T20:56:40.540155Z","end":"2026-04-27T20:56:40.700112Z","steps":["trace[1685284992] 'agreement among raft nodes before linearized reading' (duration: 159.464287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.444027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t9ggp\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-27T20:56:41.749365Z","caller":"traceutil/trace.go:171","msg":"trace[287518385] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t9ggp; range_end:; response_count:1; response_revision:583; }","duration":"873.602643ms","start":"2026-04-27T20:56:40.875741Z","end":"2026-04-27T20:56:41.749343Z","steps":["trace[287518385] 'range keys from in-memory index tree' (duration: 873.242119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.875716Z","time spent":"873.699267ms","remote":"127.0.0.1:60276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16979,"request content":"key:\"/registry/pods/kube-system/cilium-t9ggp\" "} {"level":"warn","ts":"2026-04-27T20:56:41.749654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.615156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.749696Z","caller":"traceutil/trace.go:171","msg":"trace[1238574614] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:583; }","duration":"672.679208ms","start":"2026-04-27T20:56:41.077006Z","end":"2026-04-27T20:56:41.749685Z","steps":["trace[1238574614] 'count revisions from in-memory index tree' (duration: 672.510122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.076988Z","time spent":"672.73003ms","remote":"127.0.0.1:43684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T20:56:41.749712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.580365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.7498Z","caller":"traceutil/trace.go:171","msg":"trace[1233574272] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:583; }","duration":"672.705139ms","start":"2026-04-27T20:56:41.077077Z","end":"2026-04-27T20:56:41.749782Z","steps":["trace[1233574272] 'range keys from in-memory index tree' (duration: 672.539813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.077073Z","time spent":"672.762921ms","remote":"127.0.0.1:43684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T20:56:41.74992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.016522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.749894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.136036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.749955Z","caller":"traceutil/trace.go:171","msg":"trace[396855016] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:583; }","duration":"672.066714ms","start":"2026-04-27T20:56:41.077879Z","end":"2026-04-27T20:56:41.749946Z","steps":["trace[396855016] 'range keys from in-memory index tree' (duration: 671.989351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.728612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.749999Z","caller":"traceutil/trace.go:171","msg":"trace[635348631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"815.298244ms","start":"2026-04-27T20:56:40.93467Z","end":"2026-04-27T20:56:41.749968Z","steps":["trace[635348631] 'range keys from in-memory index tree' (duration: 814.96234ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:41.750032Z","caller":"traceutil/trace.go:171","msg":"trace[513028097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"693.837966ms","start":"2026-04-27T20:56:41.056172Z","end":"2026-04-27T20:56:41.75001Z","steps":["trace[513028097] 'range keys from in-memory index tree' (duration: 693.694321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.749539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.585981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.056136Z","time spent":"693.936421ms","remote":"127.0.0.1:43670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-27T20:56:41.750147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.077874Z","time spent":"672.259602ms","remote":"127.0.0.1:43684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-27T20:56:41.750158Z","caller":"traceutil/trace.go:171","msg":"trace[577942428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"713.261627ms","start":"2026-04-27T20:56:41.036868Z","end":"2026-04-27T20:56:41.750129Z","steps":["trace[577942428] 'range keys from in-memory index tree' (duration: 712.478356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.036854Z","time spent":"713.33557ms","remote":"127.0.0.1:43670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T20:56:41.750247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.410067ms","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-04-27T20:56:41.750291Z","caller":"traceutil/trace.go:171","msg":"trace[1470800371] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"815.449799ms","start":"2026-04-27T20:56:40.934823Z","end":"2026-04-27T20:56:41.750272Z","steps":["trace[1470800371] 'range keys from in-memory index tree' (duration: 815.373946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.347701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.934648Z","time spent":"815.393327ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-27T20:56:41.750333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.934819Z","time spent":"815.503251ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-27T20:56:41.750321Z","caller":"traceutil/trace.go:171","msg":"trace[1425402267] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"713.384232ms","start":"2026-04-27T20:56:41.036931Z","end":"2026-04-27T20:56:41.750315Z","steps":["trace[1425402267] 'count revisions from in-memory index tree' (duration: 713.31782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.036927Z","time spent":"713.444804ms","remote":"127.0.0.1:43670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-27T20:56:41.750371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.435101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.610807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.708845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.750459Z","caller":"traceutil/trace.go:171","msg":"trace[180690143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"694.649518ms","start":"2026-04-27T20:56:41.055798Z","end":"2026-04-27T20:56:41.750447Z","steps":["trace[180690143] 'range keys from in-memory index tree' (duration: 694.497342ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:41.75045Z","caller":"traceutil/trace.go:171","msg":"trace[532069066] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"835.520444ms","start":"2026-04-27T20:56:40.914904Z","end":"2026-04-27T20:56:41.750425Z","steps":["trace[532069066] 'range keys from in-memory index tree' (duration: 835.280294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.75046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.949664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.690805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.75048Z","caller":"traceutil/trace.go:171","msg":"trace[1221172597] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"737.070639ms","start":"2026-04-27T20:56:41.013391Z","end":"2026-04-27T20:56:41.750461Z","steps":["trace[1221172597] 'range keys from in-memory index tree' (duration: 736.534898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.914858Z","time spent":"835.629939ms","remote":"127.0.0.1:43638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-27T20:56:41.750517Z","caller":"traceutil/trace.go:171","msg":"trace[1886861716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"737.018637ms","start":"2026-04-27T20:56:41.013481Z","end":"2026-04-27T20:56:41.7505Z","steps":["trace[1886861716] 'count revisions from in-memory index tree' (duration: 736.910973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.72292ms","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":"warn","ts":"2026-04-27T20:56:41.750546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.013371Z","time spent":"737.156282ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T20:56:41.750566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.013477Z","time spent":"737.073279ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T20:56:41.750397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.500823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.750573Z","caller":"traceutil/trace.go:171","msg":"trace[220365061] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"815.795143ms","start":"2026-04-27T20:56:40.934762Z","end":"2026-04-27T20:56:41.750557Z","steps":["trace[220365061] 'count revisions from in-memory index tree' (duration: 815.687749ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:41.750603Z","caller":"traceutil/trace.go:171","msg":"trace[1943302697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:583; }","duration":"694.718111ms","start":"2026-04-27T20:56:41.055878Z","end":"2026-04-27T20:56:41.750596Z","steps":["trace[1943302697] 'count revisions from in-memory index tree' (duration: 694.469182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.055874Z","time spent":"694.743722ms","remote":"127.0.0.1:43678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-27T20:56:41.750387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.379069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T20:56:41.750628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.934758Z","time spent":"815.855865ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-27T20:56:41.750651Z","caller":"traceutil/trace.go:171","msg":"trace[282157172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:583; }","duration":"835.67793ms","start":"2026-04-27T20:56:40.914966Z","end":"2026-04-27T20:56:41.750644Z","steps":["trace[282157172] 'count revisions from in-memory index tree' (duration: 835.332517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:40.914961Z","time spent":"835.704682ms","remote":"127.0.0.1:43638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T20:56:41.750519Z","caller":"traceutil/trace.go:171","msg":"trace[693568090] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"736.735026ms","start":"2026-04-27T20:56:41.013777Z","end":"2026-04-27T20:56:41.750512Z","steps":["trace[693568090] 'range keys from in-memory index tree' (duration: 736.664713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.750479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.055779Z","time spent":"694.69414ms","remote":"127.0.0.1:43678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T20:56:41.750912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.013772Z","time spent":"737.133701ms","remote":"127.0.0.1:43658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-27T20:56:41.921007Z","caller":"traceutil/trace.go:171","msg":"trace[2051679938] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"810.981173ms","start":"2026-04-27T20:56:41.109993Z","end":"2026-04-27T20:56:41.920975Z","steps":["trace[2051679938] 'process raft request' (duration: 809.952003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.921305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:41.109963Z","time spent":"811.14793ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T20:56:41.98897Z","caller":"traceutil/trace.go:171","msg":"trace[1661171015] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"196.098788ms","start":"2026-04-27T20:56:41.792826Z","end":"2026-04-27T20:56:41.988925Z","steps":["trace[1661171015] 'read index received' (duration: 126.904709ms)","trace[1661171015] 'applied index is now lower than readState.Index' (duration: 69.192849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:41.989098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.267705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:41.989126Z","caller":"traceutil/trace.go:171","msg":"trace[1196381728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"196.375929ms","start":"2026-04-27T20:56:41.79274Z","end":"2026-04-27T20:56:41.989116Z","steps":["trace[1196381728] 'agreement among raft nodes before linearized reading' (duration: 196.306767ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:41.989103Z","caller":"traceutil/trace.go:171","msg":"trace[238629527] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"223.240041ms","start":"2026-04-27T20:56:41.765799Z","end":"2026-04-27T20:56:41.989039Z","steps":["trace[238629527] 'process raft request' (duration: 213.827583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.992585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.026925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T20:56:41.992653Z","caller":"traceutil/trace.go:171","msg":"trace[1584507933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"113.113789ms","start":"2026-04-27T20:56:41.879519Z","end":"2026-04-27T20:56:41.992633Z","steps":["trace[1584507933] 'agreement among raft nodes before linearized reading' (duration: 112.943652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.992879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.157369ms","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-27T20:56:41.992961Z","caller":"traceutil/trace.go:171","msg":"trace[1864219295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"114.258113ms","start":"2026-04-27T20:56:41.878693Z","end":"2026-04-27T20:56:41.992951Z","steps":["trace[1864219295] 'agreement among raft nodes before linearized reading' (duration: 114.138409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.993198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.126995ms","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-27T20:56:41.993232Z","caller":"traceutil/trace.go:171","msg":"trace[922604754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"118.278031ms","start":"2026-04-27T20:56:41.874945Z","end":"2026-04-27T20:56:41.993223Z","steps":["trace[922604754] 'agreement among raft nodes before linearized reading' (duration: 118.198738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:41.993415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.344193ms","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-27T20:56:41.993445Z","caller":"traceutil/trace.go:171","msg":"trace[101365854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"118.50925ms","start":"2026-04-27T20:56:41.874928Z","end":"2026-04-27T20:56:41.993438Z","steps":["trace[101365854] 'agreement among raft nodes before linearized reading' (duration: 118.435778ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:43.352482Z","caller":"traceutil/trace.go:171","msg":"trace[1218937514] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"300.521536ms","start":"2026-04-27T20:56:43.051932Z","end":"2026-04-27T20:56:43.352453Z","steps":["trace[1218937514] 'read index received' (duration: 288.194024ms)","trace[1218937514] 'applied index is now lower than readState.Index' (duration: 12.325942ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T20:56:43.352532Z","caller":"traceutil/trace.go:171","msg":"trace[1111503027] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"357.105223ms","start":"2026-04-27T20:56:42.995407Z","end":"2026-04-27T20:56:43.352512Z","steps":["trace[1111503027] 'process raft request' (duration: 344.827833ms)","trace[1111503027] 'compare' (duration: 11.904276ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:43.352631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:42.99538Z","time spent":"357.192086ms","remote":"127.0.0.1:60164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":856,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T20:56:43.352724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.775296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-27T20:56:43.352765Z","caller":"traceutil/trace.go:171","msg":"trace[689245663] range","detail":"{range_begin:/registry/masterleases/199.19.213.3; range_end:; response_count:1; response_revision:600; }","duration":"300.840018ms","start":"2026-04-27T20:56:43.051914Z","end":"2026-04-27T20:56:43.352754Z","steps":["trace[689245663] 'agreement among raft nodes before linearized reading' (duration: 300.63603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:43.3528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:43.051847Z","time spent":"300.943442ms","remote":"127.0.0.1:60118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":153,"request content":"key:\"/registry/masterleases/199.19.213.3\" "} {"level":"info","ts":"2026-04-27T20:56:56.183079Z","caller":"traceutil/trace.go:171","msg":"trace[61383038] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"105.161304ms","start":"2026-04-27T20:56:56.077862Z","end":"2026-04-27T20:56:56.183023Z","steps":["trace[61383038] 'process raft request' (duration: 104.910515ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:56.191667Z","caller":"traceutil/trace.go:171","msg":"trace[1310765357] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"111.72055ms","start":"2026-04-27T20:56:56.079912Z","end":"2026-04-27T20:56:56.191633Z","steps":["trace[1310765357] 'process raft request' (duration: 111.41394ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:56.19219Z","caller":"traceutil/trace.go:171","msg":"trace[394950516] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"111.414511ms","start":"2026-04-27T20:56:56.080746Z","end":"2026-04-27T20:56:56.19216Z","steps":["trace[394950516] 'process raft request' (duration: 110.739968ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:56.192313Z","caller":"traceutil/trace.go:171","msg":"trace[947445271] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:766; }","duration":"111.942868ms","start":"2026-04-27T20:56:56.080354Z","end":"2026-04-27T20:56:56.192297Z","steps":["trace[947445271] 'read index received' (duration: 102.358061ms)","trace[947445271] 'applied index is now lower than readState.Index' (duration: 9.583457ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:56.192486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.123134ms","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-27T20:56:56.192519Z","caller":"traceutil/trace.go:171","msg":"trace[1435230191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:740; }","duration":"112.217867ms","start":"2026-04-27T20:56:56.080293Z","end":"2026-04-27T20:56:56.192511Z","steps":["trace[1435230191] 'agreement among raft nodes before linearized reading' (duration: 112.062572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:59.295409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371602590225245276,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T20:56:59.772572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.119297ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-27T20:56:59.775724Z","caller":"traceutil/trace.go:171","msg":"trace[1722687585] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:785; }","duration":"981.127052ms","start":"2026-04-27T20:56:58.794575Z","end":"2026-04-27T20:56:59.775702Z","steps":["trace[1722687585] 'read index received' (duration: 788.888765ms)","trace[1722687585] 'applied index is now lower than readState.Index' (duration: 192.237367ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T20:56:59.775862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.273416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T20:56:59.775895Z","caller":"traceutil/trace.go:171","msg":"trace[193963485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"981.343159ms","start":"2026-04-27T20:56:58.794541Z","end":"2026-04-27T20:56:59.775884Z","steps":["trace[193963485] 'agreement among raft nodes before linearized reading' (duration: 981.278787ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T20:56:59.775845Z","caller":"traceutil/trace.go:171","msg":"trace[538084769] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"772.561151ms","start":"2026-04-27T20:56:59.003239Z","end":"2026-04-27T20:56:59.7758Z","steps":["trace[538084769] 'process raft request' (duration: 772.269942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:59.775946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:58.794521Z","time spent":"981.417191ms","remote":"127.0.0.1:60106","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-04-27T20:56:59.775961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.532187ms","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-27T20:56:59.775989Z","caller":"traceutil/trace.go:171","msg":"trace[317551466] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"137.61529ms","start":"2026-04-27T20:56:59.638366Z","end":"2026-04-27T20:56:59.775981Z","steps":["trace[317551466] 'agreement among raft nodes before linearized reading' (duration: 137.513877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T20:56:59.776091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T20:56:59.003209Z","time spent":"772.759857ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T20:57:09.990362Z","caller":"traceutil/trace.go:171","msg":"trace[419059978] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"142.614014ms","start":"2026-04-27T20:57:09.847731Z","end":"2026-04-27T20:57:09.990345Z","steps":["trace[419059978] 'process raft request' (duration: 142.1302ms)"],"step_count":1}