{"level":"warn","ts":"2026-05-07T02:01:52.132452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T02:01:52.132547Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-05-07T02:01:52.132619Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T02:01:52.132632Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-05-07T02:01:52.13266Z","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-05-07T02:01:52.13343Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-05-07T02:01:52.133515Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-05-07T02:01:52.137533Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.784811ms"} {"level":"info","ts":"2026-05-07T02:01:52.147038Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-05-07T02:01:52.147145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T02:01:52.147176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-05-07T02:01:52.147188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T02:01:52.1472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-05-07T02:01:52.147243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-05-07T02:01:52.155287Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T02:01:52.158921Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T02:01:52.162106Z","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-05-07T02:01:52.165316Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T02:01:52.16549Z","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-05-07T02:01:52.165577Z","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-05-07T02:01:52.165593Z","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-05-07T02:01:52.165843Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T02:01:52.166357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-05-07T02:01:52.167014Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-05-07T02:01:52.171974Z","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-05-07T02:01:52.172101Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-05-07T02:01:52.172151Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-05-07T02:01:52.172292Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T02:01:52.172353Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T02:01:52.548012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T02:01:52.548082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T02:01:52.548134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-05-07T02:01:52.548159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-05-07T02:01:52.548175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-05-07T02:01:52.548203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-05-07T02:01:52.548217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-05-07T02:01:52.549045Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T02:01:52.549932Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T02:01:52.550006Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T02:01:52.550055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T02:01:52.550307Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T02:01:52.550282Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T02:01:52.550364Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T02:01:52.550445Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T02:01:52.550485Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T02:01:52.553025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T02:01:52.553559Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-05-07T02:02:02.369472Z","caller":"traceutil/trace.go:171","msg":"trace[1463312733] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"157.582744ms","start":"2026-05-07T02:02:02.211866Z","end":"2026-05-07T02:02:02.369449Z","steps":["trace[1463312733] 'read index received' (duration: 68.52245ms)","trace[1463312733] 'applied index is now lower than readState.Index' (duration: 89.058884ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:02.36974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.388967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-07T02:02:02.369741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.8832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-07T02:02:02.369611Z","caller":"traceutil/trace.go:171","msg":"trace[1874991101] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"180.446313ms","start":"2026-05-07T02:02:02.189116Z","end":"2026-05-07T02:02:02.369562Z","steps":["trace[1874991101] 'process raft request' (duration: 91.277217ms)","trace[1874991101] 'compare' (duration: 88.928401ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:02.369811Z","caller":"traceutil/trace.go:171","msg":"trace[676903650] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:353; }","duration":"158.156997ms","start":"2026-05-07T02:02:02.211643Z","end":"2026-05-07T02:02:02.3698Z","steps":["trace[676903650] 'agreement among raft nodes before linearized reading' (duration: 157.953732ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:02.369813Z","caller":"traceutil/trace.go:171","msg":"trace[832243336] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:353; }","duration":"108.551972ms","start":"2026-05-07T02:02:02.261244Z","end":"2026-05-07T02:02:02.369796Z","steps":["trace[832243336] 'agreement among raft nodes before linearized reading' (duration: 108.376048ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:05.586629Z","caller":"traceutil/trace.go:171","msg":"trace[1926233949] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"187.903866ms","start":"2026-05-07T02:02:05.3987Z","end":"2026-05-07T02:02:05.586604Z","steps":["trace[1926233949] 'read index received' (duration: 187.866705ms)","trace[1926233949] 'applied index is now lower than readState.Index' (duration: 35.391µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:05.586792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.072602ms","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-05-07T02:02:05.586854Z","caller":"traceutil/trace.go:171","msg":"trace[1895747337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:400; }","duration":"188.182304ms","start":"2026-05-07T02:02:05.398657Z","end":"2026-05-07T02:02:05.586839Z","steps":["trace[1895747337] 'agreement among raft nodes before linearized reading' (duration: 188.05581ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:06.324325Z","caller":"traceutil/trace.go:171","msg":"trace[1633783347] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:416; }","duration":"330.159444ms","start":"2026-05-07T02:02:05.994141Z","end":"2026-05-07T02:02:06.324301Z","steps":["trace[1633783347] 'read index received' (duration: 329.898488ms)","trace[1633783347] 'applied index is now lower than readState.Index' (duration: 259.916µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:06.324402Z","caller":"traceutil/trace.go:171","msg":"trace[1209820497] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"387.245614ms","start":"2026-05-07T02:02:05.937122Z","end":"2026-05-07T02:02:06.324367Z","steps":["trace[1209820497] 'process raft request' (duration: 387.027038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:06.324511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.289797ms","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-05-07T02:02:06.324564Z","caller":"traceutil/trace.go:171","msg":"trace[1360119182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"330.39438ms","start":"2026-05-07T02:02:05.994146Z","end":"2026-05-07T02:02:06.324541Z","steps":["trace[1360119182] 'agreement among raft nodes before linearized reading' (duration: 330.298908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:06.324496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.337919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-07T02:02:06.324607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:05.994116Z","time spent":"330.482062ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-07T02:02:06.32474Z","caller":"traceutil/trace.go:171","msg":"trace[1091184267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"330.631286ms","start":"2026-05-07T02:02:05.994085Z","end":"2026-05-07T02:02:06.324716Z","steps":["trace[1091184267] 'agreement among raft nodes before linearized reading' (duration: 330.316698ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:06.324822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:05.994058Z","time spent":"330.743958ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T02:02:06.325454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:05.937104Z","time spent":"387.381406ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:02:12.491157Z","caller":"traceutil/trace.go:171","msg":"trace[1099921615] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"121.803025ms","start":"2026-05-07T02:02:12.369326Z","end":"2026-05-07T02:02:12.491129Z","steps":["trace[1099921615] 'process raft request' (duration: 121.756584ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:12.491772Z","caller":"traceutil/trace.go:171","msg":"trace[1305991868] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"123.264481ms","start":"2026-05-07T02:02:12.368493Z","end":"2026-05-07T02:02:12.491757Z","steps":["trace[1305991868] 'process raft request' (duration: 91.927704ms)","trace[1305991868] 'compare' (duration: 30.522668ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:22.494912Z","caller":"traceutil/trace.go:171","msg":"trace[954406974] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"100.854072ms","start":"2026-05-07T02:02:22.393999Z","end":"2026-05-07T02:02:22.494853Z","steps":["trace[954406974] 'process raft request' (duration: 60.724479ms)","trace[954406974] 'compare' (duration: 39.873707ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:22.494923Z","caller":"traceutil/trace.go:171","msg":"trace[956654484] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"100.640167ms","start":"2026-05-07T02:02:22.394242Z","end":"2026-05-07T02:02:22.494883Z","steps":["trace[956654484] 'process raft request' (duration: 100.532824ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:22.609616Z","caller":"traceutil/trace.go:171","msg":"trace[8475192] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"107.804492ms","start":"2026-05-07T02:02:22.501786Z","end":"2026-05-07T02:02:22.609591Z","steps":["trace[8475192] 'process raft request' (duration: 97.050358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:24.887913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.987547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:02:24.888036Z","caller":"traceutil/trace.go:171","msg":"trace[187452168] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"356.996371ms","start":"2026-05-07T02:02:24.53102Z","end":"2026-05-07T02:02:24.888016Z","steps":["trace[187452168] 'process raft request' (duration: 62.568443ms)","trace[187452168] 'compare' (duration: 293.564267ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:24.888197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.520695Z","time spent":"367.373736ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T02:02:25.10156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.610162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:02:25.10198Z","caller":"traceutil/trace.go:171","msg":"trace[1159873416] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"546.878946ms","start":"2026-05-07T02:02:24.555076Z","end":"2026-05-07T02:02:25.101955Z","steps":["trace[1159873416] 'process raft request' (duration: 546.726123ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.10197Z","caller":"traceutil/trace.go:171","msg":"trace[996915948] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"549.291756ms","start":"2026-05-07T02:02:24.552622Z","end":"2026-05-07T02:02:25.101913Z","steps":["trace[996915948] 'process raft request' (duration: 549.075551ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.102102Z","caller":"traceutil/trace.go:171","msg":"trace[631647136] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"547.072702ms","start":"2026-05-07T02:02:24.554974Z","end":"2026-05-07T02:02:25.102047Z","steps":["trace[631647136] 'process raft request' (duration: 546.795215ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.102247Z","caller":"traceutil/trace.go:171","msg":"trace[1935026537] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"524.863227ms","start":"2026-05-07T02:02:24.577369Z","end":"2026-05-07T02:02:25.102232Z","steps":["trace[1935026537] 'process raft request' (duration: 524.625631ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.102183Z","caller":"traceutil/trace.go:171","msg":"trace[517708785] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"542.023189ms","start":"2026-05-07T02:02:24.560102Z","end":"2026-05-07T02:02:25.102125Z","steps":["trace[517708785] 'process raft request' (duration: 541.737382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.102308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.577348Z","time spent":"524.923698ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:02:25.10244Z","caller":"traceutil/trace.go:171","msg":"trace[1342327290] transaction","detail":"{read_only:false; number_of_response:1; response_revision:529; }","duration":"537.715573ms","start":"2026-05-07T02:02:24.564713Z","end":"2026-05-07T02:02:25.102429Z","steps":["trace[1342327290] 'process raft request' (duration: 537.215411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.102486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.564706Z","time spent":"537.755834ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:02:25.102475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.56005Z","time spent":"542.262914ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:02:25.102438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.552611Z","time spent":"549.581323ms","remote":"127.0.0.1:56376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:02:25.102601Z","caller":"traceutil/trace.go:171","msg":"trace[1992623257] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"508.452824ms","start":"2026-05-07T02:02:24.594142Z","end":"2026-05-07T02:02:25.102595Z","steps":["trace[1992623257] 'process raft request' (duration: 508.010793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.102646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.594125Z","time spent":"508.496826ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T02:02:25.102375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.55494Z","time spent":"547.337788ms","remote":"127.0.0.1:56376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:02:25.102682Z","caller":"traceutil/trace.go:171","msg":"trace[370617005] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:542; }","duration":"556.116223ms","start":"2026-05-07T02:02:24.546548Z","end":"2026-05-07T02:02:25.102664Z","steps":["trace[370617005] 'read index received' (duration: 47.061073ms)","trace[370617005] 'applied index is now lower than readState.Index' (duration: 509.05318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:25.102115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.555068Z","time spent":"546.980549ms","remote":"127.0.0.1:56376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T02:02:25.102903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.346958ms","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-05-07T02:02:25.102979Z","caller":"traceutil/trace.go:171","msg":"trace[400248749] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"556.446191ms","start":"2026-05-07T02:02:24.546518Z","end":"2026-05-07T02:02:25.102965Z","steps":["trace[400248749] 'agreement among raft nodes before linearized reading' (duration: 556.267187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.103027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.546506Z","time spent":"556.509172ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-07T02:02:25.102565Z","caller":"traceutil/trace.go:171","msg":"trace[1862140802] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"518.631944ms","start":"2026-05-07T02:02:24.583926Z","end":"2026-05-07T02:02:25.102558Z","steps":["trace[1862140802] 'process raft request' (duration: 518.157873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.103088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.583905Z","time spent":"519.161017ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:02:25.10286Z","caller":"traceutil/trace.go:171","msg":"trace[974485157] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"422.632061ms","start":"2026-05-07T02:02:24.680219Z","end":"2026-05-07T02:02:25.102851Z","steps":["trace[974485157] 'process raft request' (duration: 422.308993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.103172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.680205Z","time spent":"422.947808ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:02:25.102861Z","caller":"traceutil/trace.go:171","msg":"trace[650665601] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"409.573541ms","start":"2026-05-07T02:02:24.693266Z","end":"2026-05-07T02:02:25.102839Z","steps":["trace[650665601] 'process raft request' (duration: 409.410427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.103249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.693252Z","time spent":"409.98307ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:02:25.103478Z","caller":"traceutil/trace.go:171","msg":"trace[529798173] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"208.243605ms","start":"2026-05-07T02:02:24.895224Z","end":"2026-05-07T02:02:25.103468Z","steps":["trace[529798173] 'process raft request' (duration: 207.563639ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.103022Z","caller":"traceutil/trace.go:171","msg":"trace[755571237] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"558.680267ms","start":"2026-05-07T02:02:24.543093Z","end":"2026-05-07T02:02:25.101774Z","steps":["trace[755571237] 'process raft request' (duration: 447.625664ms)","trace[755571237] 'compare' (duration: 110.345265ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:25.103583Z","caller":"traceutil/trace.go:171","msg":"trace[118142584] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"208.325317ms","start":"2026-05-07T02:02:24.895242Z","end":"2026-05-07T02:02:25.103567Z","steps":["trace[118142584] 'process raft request' (duration: 208.125752ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.10383Z","caller":"traceutil/trace.go:171","msg":"trace[878032676] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"205.326084ms","start":"2026-05-07T02:02:24.898496Z","end":"2026-05-07T02:02:25.103822Z","steps":["trace[878032676] 'process raft request' (duration: 204.931724ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.103933Z","caller":"traceutil/trace.go:171","msg":"trace[1992507186] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"189.929686ms","start":"2026-05-07T02:02:24.913997Z","end":"2026-05-07T02:02:25.103927Z","steps":["trace[1992507186] 'process raft request' (duration: 189.72862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.103992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.319146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-07T02:02:25.10402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.748015ms","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-05-07T02:02:25.104043Z","caller":"traceutil/trace.go:171","msg":"trace[1174777667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"480.417149ms","start":"2026-05-07T02:02:24.623615Z","end":"2026-05-07T02:02:25.104032Z","steps":["trace[1174777667] 'agreement among raft nodes before linearized reading' (duration: 480.310756ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:25.104046Z","caller":"traceutil/trace.go:171","msg":"trace[1192011069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"473.788156ms","start":"2026-05-07T02:02:24.63025Z","end":"2026-05-07T02:02:25.104038Z","steps":["trace[1192011069] 'agreement among raft nodes before linearized reading' (duration: 473.733185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:25.10407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.623601Z","time spent":"480.46342ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T02:02:25.104074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.630243Z","time spent":"473.825187ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T02:02:25.104358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:24.543076Z","time spent":"560.544782ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:02:26.437249Z","caller":"traceutil/trace.go:171","msg":"trace[1877655162] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"497.764283ms","start":"2026-05-07T02:02:25.939449Z","end":"2026-05-07T02:02:26.437213Z","steps":["trace[1877655162] 'process raft request' (duration: 497.461545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:26.437477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:25.939429Z","time spent":"497.915946ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:02:26.457963Z","caller":"traceutil/trace.go:171","msg":"trace[333492912] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"423.244586ms","start":"2026-05-07T02:02:26.034646Z","end":"2026-05-07T02:02:26.457891Z","steps":["trace[333492912] 'process raft request' (duration: 420.447817ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:26.458431Z","caller":"traceutil/trace.go:171","msg":"trace[1075719338] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:611; }","duration":"138.058985ms","start":"2026-05-07T02:02:26.319731Z","end":"2026-05-07T02:02:26.45779Z","steps":["trace[1075719338] 'read index received' (duration: 117.246614ms)","trace[1075719338] 'applied index is now lower than readState.Index' (duration: 20.811461ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:26.458473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:26.034598Z","time spent":"423.466231ms","remote":"127.0.0.1:55860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:02:26.458594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.837913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:26.458679Z","caller":"traceutil/trace.go:171","msg":"trace[1821981718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"138.991338ms","start":"2026-05-07T02:02:26.319665Z","end":"2026-05-07T02:02:26.458657Z","steps":["trace[1821981718] 'agreement among raft nodes before linearized reading' (duration: 138.297281ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.149346Z","caller":"traceutil/trace.go:171","msg":"trace[1341666646] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"134.018595ms","start":"2026-05-07T02:02:32.015304Z","end":"2026-05-07T02:02:32.149323Z","steps":["trace[1341666646] 'read index received' (duration: 132.952949ms)","trace[1341666646] 'applied index is now lower than readState.Index' (duration: 1.064506ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:32.14963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.227241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:32.149688Z","caller":"traceutil/trace.go:171","msg":"trace[2121115942] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"134.378654ms","start":"2026-05-07T02:02:32.015288Z","end":"2026-05-07T02:02:32.149667Z","steps":["trace[2121115942] 'agreement among raft nodes before linearized reading' (duration: 134.171529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.149685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.320973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T02:02:32.149785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.617946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:32.149809Z","caller":"traceutil/trace.go:171","msg":"trace[1821438213] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"134.538138ms","start":"2026-05-07T02:02:32.015248Z","end":"2026-05-07T02:02:32.149786Z","steps":["trace[1821438213] 'agreement among raft nodes before linearized reading' (duration: 134.152329ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.149736Z","caller":"traceutil/trace.go:171","msg":"trace[1084237297] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"175.257647ms","start":"2026-05-07T02:02:31.974151Z","end":"2026-05-07T02:02:32.149409Z","steps":["trace[1084237297] 'process raft request' (duration: 174.459017ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.149897Z","caller":"traceutil/trace.go:171","msg":"trace[1573884882] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"133.79095ms","start":"2026-05-07T02:02:32.016077Z","end":"2026-05-07T02:02:32.149868Z","steps":["trace[1573884882] 'agreement among raft nodes before linearized reading' (duration: 133.589525ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.44388Z","caller":"traceutil/trace.go:171","msg":"trace[712516829] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"207.751694ms","start":"2026-05-07T02:02:32.236105Z","end":"2026-05-07T02:02:32.443857Z","steps":["trace[712516829] 'read index received' (duration: 109.152205ms)","trace[712516829] 'applied index is now lower than readState.Index' (duration: 98.598008ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:32.444001Z","caller":"traceutil/trace.go:171","msg":"trace[1974450876] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"232.08326ms","start":"2026-05-07T02:02:32.211908Z","end":"2026-05-07T02:02:32.443992Z","steps":["trace[1974450876] 'process raft request' (duration: 133.41292ms)","trace[1974450876] 'compare' (duration: 98.341742ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:32.444413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.715001ms","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-05-07T02:02:32.444455Z","caller":"traceutil/trace.go:171","msg":"trace[154771839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"158.786243ms","start":"2026-05-07T02:02:32.285658Z","end":"2026-05-07T02:02:32.444444Z","steps":["trace[154771839] 'agreement among raft nodes before linearized reading' (duration: 158.626799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.444441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.073011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T02:02:32.444483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.053093ms","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":"warn","ts":"2026-05-07T02:02:32.444621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.08748ms","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":"warn","ts":"2026-05-07T02:02:32.444499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.054584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:32.444662Z","caller":"traceutil/trace.go:171","msg":"trace[1412941075] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"159.178562ms","start":"2026-05-07T02:02:32.285475Z","end":"2026-05-07T02:02:32.444654Z","steps":["trace[1412941075] 'agreement among raft nodes before linearized reading' (duration: 159.0861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.444699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.580583ms","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-05-07T02:02:32.444743Z","caller":"traceutil/trace.go:171","msg":"trace[1909145084] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"208.633715ms","start":"2026-05-07T02:02:32.236098Z","end":"2026-05-07T02:02:32.444732Z","steps":["trace[1909145084] 'agreement among raft nodes before linearized reading' (duration: 208.560573ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.444757Z","caller":"traceutil/trace.go:171","msg":"trace[1155705221] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"131.35536ms","start":"2026-05-07T02:02:32.313308Z","end":"2026-05-07T02:02:32.444664Z","steps":["trace[1155705221] 'agreement among raft nodes before linearized reading' (duration: 131.028342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.444847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.697409ms","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-05-07T02:02:32.444865Z","caller":"traceutil/trace.go:171","msg":"trace[706389007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"191.73593ms","start":"2026-05-07T02:02:32.253123Z","end":"2026-05-07T02:02:32.444859Z","steps":["trace[706389007] 'agreement among raft nodes before linearized reading' (duration: 191.713489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.445045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.251122ms","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":"warn","ts":"2026-05-07T02:02:32.44507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.079239ms","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-05-07T02:02:32.445082Z","caller":"traceutil/trace.go:171","msg":"trace[1622130892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"132.336834ms","start":"2026-05-07T02:02:32.312737Z","end":"2026-05-07T02:02:32.445074Z","steps":["trace[1622130892] 'agreement among raft nodes before linearized reading' (duration: 132.276773ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.445089Z","caller":"traceutil/trace.go:171","msg":"trace[1734960561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"192.1141ms","start":"2026-05-07T02:02:32.25297Z","end":"2026-05-07T02:02:32.445084Z","steps":["trace[1734960561] 'agreement among raft nodes before linearized reading' (duration: 192.075119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.445165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.088551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:32.445183Z","caller":"traceutil/trace.go:171","msg":"trace[526106230] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"208.107392ms","start":"2026-05-07T02:02:32.237072Z","end":"2026-05-07T02:02:32.445179Z","steps":["trace[526106230] 'agreement among raft nodes before linearized reading' (duration: 208.079281ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.44462Z","caller":"traceutil/trace.go:171","msg":"trace[562697328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"131.280549ms","start":"2026-05-07T02:02:32.313293Z","end":"2026-05-07T02:02:32.444573Z","steps":["trace[562697328] 'agreement among raft nodes before linearized reading' (duration: 131.021673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:32.444825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.135236ms","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-05-07T02:02:32.444539Z","caller":"traceutil/trace.go:171","msg":"trace[635622071] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"208.219715ms","start":"2026-05-07T02:02:32.236297Z","end":"2026-05-07T02:02:32.444517Z","steps":["trace[635622071] 'agreement among raft nodes before linearized reading' (duration: 207.966008ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:32.445625Z","caller":"traceutil/trace.go:171","msg":"trace[1372868165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"191.827052ms","start":"2026-05-07T02:02:32.253639Z","end":"2026-05-07T02:02:32.445466Z","steps":["trace[1372868165] 'agreement among raft nodes before linearized reading' (duration: 191.137896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.123124Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954535756339235,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T02:02:33.304449Z","caller":"traceutil/trace.go:171","msg":"trace[1945222294] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"765.170979ms","start":"2026-05-07T02:02:32.539222Z","end":"2026-05-07T02:02:33.304393Z","steps":["trace[1945222294] 'process raft request' (duration: 711.558355ms)","trace[1945222294] 'compare' (duration: 53.404039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:02:33.30468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.53919Z","time spent":"765.355033ms","remote":"127.0.0.1:56016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:02:33.365646Z","caller":"traceutil/trace.go:171","msg":"trace[664412062] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"742.77688ms","start":"2026-05-07T02:02:32.622836Z","end":"2026-05-07T02:02:33.365613Z","steps":["trace[664412062] 'read index received' (duration: 628.038677ms)","trace[664412062] 'applied index is now lower than readState.Index' (duration: 114.737083ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:02:33.365782Z","caller":"traceutil/trace.go:171","msg":"trace[1439888672] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"516.413571ms","start":"2026-05-07T02:02:32.849288Z","end":"2026-05-07T02:02:33.365701Z","steps":["trace[1439888672] 'process raft request' (duration: 515.675202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.849259Z","time spent":"516.630406ms","remote":"127.0.0.1:55902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:02:33.366165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.21211ms","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-05-07T02:02:33.36618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.761093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.36626Z","caller":"traceutil/trace.go:171","msg":"trace[1850243741] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"517.874466ms","start":"2026-05-07T02:02:32.848362Z","end":"2026-05-07T02:02:33.366237Z","steps":["trace[1850243741] 'agreement among raft nodes before linearized reading' (duration: 517.689312ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:33.366221Z","caller":"traceutil/trace.go:171","msg":"trace[351565520] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"743.400315ms","start":"2026-05-07T02:02:32.622806Z","end":"2026-05-07T02:02:33.366206Z","steps":["trace[351565520] 'agreement among raft nodes before linearized reading' (duration: 743.221191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.848339Z","time spent":"517.970709ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.366284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.27037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.366463Z","caller":"traceutil/trace.go:171","msg":"trace[2018009833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"428.473874ms","start":"2026-05-07T02:02:32.937937Z","end":"2026-05-07T02:02:33.36641Z","steps":["trace[2018009833] 'agreement among raft nodes before linearized reading' (duration: 428.167917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.441668ms","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-05-07T02:02:33.366554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.289037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T02:02:33.366586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.385715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.366598Z","caller":"traceutil/trace.go:171","msg":"trace[1542342635] 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:626; }","duration":"409.524009ms","start":"2026-05-07T02:02:32.957058Z","end":"2026-05-07T02:02:33.366582Z","steps":["trace[1542342635] 'agreement among raft nodes before linearized reading' (duration: 409.413407ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:33.366615Z","caller":"traceutil/trace.go:171","msg":"trace[1278554637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"442.422206ms","start":"2026-05-07T02:02:32.924184Z","end":"2026-05-07T02:02:33.366606Z","steps":["trace[1278554637] 'agreement among raft nodes before linearized reading' (duration: 442.371515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.957048Z","time spent":"409.578241ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.366681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.528189ms","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-05-07T02:02:33.366604Z","caller":"traceutil/trace.go:171","msg":"trace[1235489408] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"518.365038ms","start":"2026-05-07T02:02:32.84823Z","end":"2026-05-07T02:02:33.366595Z","steps":["trace[1235489408] 'agreement among raft nodes before linearized reading' (duration: 518.270786ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:02:33.366712Z","caller":"traceutil/trace.go:171","msg":"trace[1282631609] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"442.558999ms","start":"2026-05-07T02:02:32.924145Z","end":"2026-05-07T02:02:33.366704Z","steps":["trace[1282631609] 'agreement among raft nodes before linearized reading' (duration: 442.517038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.848218Z","time spent":"518.498632ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.366804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.489782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.366831Z","caller":"traceutil/trace.go:171","msg":"trace[1833671990] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"465.548373ms","start":"2026-05-07T02:02:32.901276Z","end":"2026-05-07T02:02:33.366824Z","steps":["trace[1833671990] 'agreement among raft nodes before linearized reading' (duration: 465.506372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.366851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.901252Z","time spent":"465.592664ms","remote":"127.0.0.1:56346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.366988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.732087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.367016Z","caller":"traceutil/trace.go:171","msg":"trace[1777748558] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"465.795499ms","start":"2026-05-07T02:02:32.901213Z","end":"2026-05-07T02:02:33.367008Z","steps":["trace[1777748558] 'agreement among raft nodes before linearized reading' (duration: 465.753378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.367039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.901189Z","time spent":"465.84279ms","remote":"127.0.0.1:56346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.366645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.92417Z","time spent":"442.468367ms","remote":"127.0.0.1:56354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.367142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.14051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T02:02:33.366618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.937927Z","time spent":"428.653058ms","remote":"127.0.0.1:56368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-07T02:02:33.367172Z","caller":"traceutil/trace.go:171","msg":"trace[767757883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"491.209101ms","start":"2026-05-07T02:02:32.875952Z","end":"2026-05-07T02:02:33.367161Z","steps":["trace[767757883] 'agreement among raft nodes before linearized reading' (duration: 491.16614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.367211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.875927Z","time spent":"491.275983ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.366765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.109033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.367273Z","caller":"traceutil/trace.go:171","msg":"trace[326248603] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"465.624145ms","start":"2026-05-07T02:02:32.901633Z","end":"2026-05-07T02:02:33.367258Z","steps":["trace[326248603] 'agreement among raft nodes before linearized reading' (duration: 465.114212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.367337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.000411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T02:02:33.367348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.901624Z","time spent":"465.688396ms","remote":"127.0.0.1:56346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-05-07T02:02:33.367364Z","caller":"traceutil/trace.go:171","msg":"trace[2040648640] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"492.074923ms","start":"2026-05-07T02:02:32.875281Z","end":"2026-05-07T02:02:33.367356Z","steps":["trace[2040648640] 'agreement among raft nodes before linearized reading' (duration: 492.027062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.367387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.875275Z","time spent":"492.105704ms","remote":"127.0.0.1:56340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.367515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.252397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.367541Z","caller":"traceutil/trace.go:171","msg":"trace[2138586910] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"492.280337ms","start":"2026-05-07T02:02:32.875253Z","end":"2026-05-07T02:02:33.367534Z","steps":["trace[2138586910] 'agreement among raft nodes before linearized reading' (duration: 492.241276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.367562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.875224Z","time spent":"492.331879ms","remote":"127.0.0.1:56340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.367585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.653927ms","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-05-07T02:02:33.367622Z","caller":"traceutil/trace.go:171","msg":"trace[1989163585] 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:626; }","duration":"410.733668ms","start":"2026-05-07T02:02:32.956878Z","end":"2026-05-07T02:02:33.367612Z","steps":["trace[1989163585] 'agreement among raft nodes before linearized reading' (duration: 410.666577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.369078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.956872Z","time spent":"412.191215ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.366735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.924108Z","time spent":"442.620661ms","remote":"127.0.0.1:56354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.319488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.369579Z","caller":"traceutil/trace.go:171","msg":"trace[1271425589] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"661.893226ms","start":"2026-05-07T02:02:32.707672Z","end":"2026-05-07T02:02:33.369565Z","steps":["trace[1271425589] 'agreement among raft nodes before linearized reading' (duration: 660.329939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.369611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.707651Z","time spent":"661.947947ms","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.001628ms","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-05-07T02:02:33.370051Z","caller":"traceutil/trace.go:171","msg":"trace[554954185] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"554.961965ms","start":"2026-05-07T02:02:32.815046Z","end":"2026-05-07T02:02:33.370008Z","steps":["trace[554954185] 'agreement among raft nodes before linearized reading' (duration: 553.001668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.370101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.815042Z","time spent":"555.041937ms","remote":"127.0.0.1:56330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.061039ms","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":"info","ts":"2026-05-07T02:02:33.370256Z","caller":"traceutil/trace.go:171","msg":"trace[515379424] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"555.259472ms","start":"2026-05-07T02:02:32.814988Z","end":"2026-05-07T02:02:33.370248Z","steps":["trace[515379424] 'agreement among raft nodes before linearized reading' (duration: 553.09155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.370281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.814963Z","time spent":"555.309743ms","remote":"127.0.0.1:56330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.001625ms","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":"info","ts":"2026-05-07T02:02:33.370392Z","caller":"traceutil/trace.go:171","msg":"trace[688547294] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"581.28926ms","start":"2026-05-07T02:02:32.789092Z","end":"2026-05-07T02:02:33.370381Z","steps":["trace[688547294] 'agreement among raft nodes before linearized reading' (duration: 579.018685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.370433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.789081Z","time spent":"581.343971ms","remote":"127.0.0.1:56326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.491946ms","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-05-07T02:02:33.370576Z","caller":"traceutil/trace.go:171","msg":"trace[253859295] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"583.935775ms","start":"2026-05-07T02:02:32.786632Z","end":"2026-05-07T02:02:33.370567Z","steps":["trace[253859295] 'agreement among raft nodes before linearized reading' (duration: 581.513127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.3706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.786621Z","time spent":"583.971896ms","remote":"127.0.0.1:56326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.547187ms","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-05-07T02:02:33.370759Z","caller":"traceutil/trace.go:171","msg":"trace[2050703054] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"584.13335ms","start":"2026-05-07T02:02:32.786618Z","end":"2026-05-07T02:02:33.370751Z","steps":["trace[2050703054] 'agreement among raft nodes before linearized reading' (duration: 581.552548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.370785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.786604Z","time spent":"584.17211ms","remote":"127.0.0.1:56326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.685265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.370929Z","caller":"traceutil/trace.go:171","msg":"trace[209250397] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"616.410821ms","start":"2026-05-07T02:02:32.754508Z","end":"2026-05-07T02:02:33.370919Z","steps":["trace[209250397] 'agreement among raft nodes before linearized reading' (duration: 613.694614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.370956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.754487Z","time spent":"616.457583ms","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.652283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.37108Z","caller":"traceutil/trace.go:171","msg":"trace[1127177284] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"620.492473ms","start":"2026-05-07T02:02:32.75058Z","end":"2026-05-07T02:02:33.371072Z","steps":["trace[1127177284] 'agreement among raft nodes before linearized reading' (duration: 617.656543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.371104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.750573Z","time spent":"620.522783ms","remote":"127.0.0.1:56322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.446598ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.371249Z","caller":"traceutil/trace.go:171","msg":"trace[985632139] 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:626; }","duration":"733.484042ms","start":"2026-05-07T02:02:32.637753Z","end":"2026-05-07T02:02:33.371237Z","steps":["trace[985632139] 'agreement among raft nodes before linearized reading' (duration: 730.424487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.371279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.637742Z","time spent":"733.523972ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.766535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.371405Z","caller":"traceutil/trace.go:171","msg":"trace[1792936537] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"620.905272ms","start":"2026-05-07T02:02:32.750491Z","end":"2026-05-07T02:02:33.371396Z","steps":["trace[1792936537] 'agreement among raft nodes before linearized reading' (duration: 617.778796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.37143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.750457Z","time spent":"620.965364ms","remote":"127.0.0.1:56322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.654756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.37153Z","caller":"traceutil/trace.go:171","msg":"trace[2112708342] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"663.901396ms","start":"2026-05-07T02:02:32.707619Z","end":"2026-05-07T02:02:33.371521Z","steps":["trace[2112708342] 'agreement among raft nodes before linearized reading' (duration: 660.676937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.371559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.707588Z","time spent":"663.963337ms","remote":"127.0.0.1:56312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.224811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.371685Z","caller":"traceutil/trace.go:171","msg":"trace[1217889133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"748.9161ms","start":"2026-05-07T02:02:32.622756Z","end":"2026-05-07T02:02:33.371672Z","steps":["trace[1217889133] 'agreement among raft nodes before linearized reading' (duration: 743.210541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.371711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.622736Z","time spent":"748.966092ms","remote":"127.0.0.1:56284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.36647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.622775Z","time spent":"743.547279ms","remote":"127.0.0.1:56284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.179296ms","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-05-07T02:02:33.371934Z","caller":"traceutil/trace.go:171","msg":"trace[1999416818] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"433.761863ms","start":"2026-05-07T02:02:32.938162Z","end":"2026-05-07T02:02:33.371924Z","steps":["trace[1999416818] 'agreement among raft nodes before linearized reading' (duration: 430.178166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.371976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.938153Z","time spent":"433.805245ms","remote":"127.0.0.1:56368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.569034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.372102Z","caller":"traceutil/trace.go:171","msg":"trace[1976555038] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"704.315626ms","start":"2026-05-07T02:02:32.667777Z","end":"2026-05-07T02:02:33.372093Z","steps":["trace[1976555038] 'agreement among raft nodes before linearized reading' (duration: 700.568385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.372126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.667768Z","time spent":"704.350147ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.367013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.755663ms","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-05-07T02:02:33.372277Z","caller":"traceutil/trace.go:171","msg":"trace[1602241997] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"554.050503ms","start":"2026-05-07T02:02:32.818218Z","end":"2026-05-07T02:02:33.372269Z","steps":["trace[1602241997] 'agreement among raft nodes before linearized reading' (duration: 548.768323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.372305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.818195Z","time spent":"554.100874ms","remote":"127.0.0.1:56330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.536269ms","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-05-07T02:02:33.372445Z","caller":"traceutil/trace.go:171","msg":"trace[1734959563] 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:626; }","duration":"415.622869ms","start":"2026-05-07T02:02:32.956814Z","end":"2026-05-07T02:02:33.372437Z","steps":["trace[1734959563] 'agreement among raft nodes before linearized reading' (duration: 411.5581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.372479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.956784Z","time spent":"415.67965ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.948034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.372623Z","caller":"traceutil/trace.go:171","msg":"trace[1735499423] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"705.173678ms","start":"2026-05-07T02:02:32.667441Z","end":"2026-05-07T02:02:33.372614Z","steps":["trace[1735499423] 'agreement among raft nodes before linearized reading' (duration: 700.946815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.37265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.667435Z","time spent":"705.206649ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.612826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.372772Z","caller":"traceutil/trace.go:171","msg":"trace[555820711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"704.988313ms","start":"2026-05-07T02:02:32.667775Z","end":"2026-05-07T02:02:33.372764Z","steps":["trace[555820711] 'agreement among raft nodes before linearized reading' (duration: 700.583015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.372796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.667718Z","time spent":"705.069914ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:02:33.368463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.315855ms","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-05-07T02:02:33.37292Z","caller":"traceutil/trace.go:171","msg":"trace[874923858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"433.792525ms","start":"2026-05-07T02:02:32.939108Z","end":"2026-05-07T02:02:33.372901Z","steps":["trace[874923858] 'agreement among raft nodes before linearized reading' (duration: 429.304196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.372948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.9391Z","time spent":"433.838886ms","remote":"127.0.0.1:56354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-07T02:02:33.368514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.787476ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:02:33.373079Z","caller":"traceutil/trace.go:171","msg":"trace[673518321] 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:626; }","duration":"735.402188ms","start":"2026-05-07T02:02:32.637666Z","end":"2026-05-07T02:02:33.373068Z","steps":["trace[673518321] 'agreement among raft nodes before linearized reading' (duration: 730.781665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.373112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.637657Z","time spent":"735.446999ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T02:02:33.368742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.010941ms","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-05-07T02:02:33.373239Z","caller":"traceutil/trace.go:171","msg":"trace[1461814184] 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:626; }","duration":"735.532741ms","start":"2026-05-07T02:02:32.6377Z","end":"2026-05-07T02:02:33.373232Z","steps":["trace[1461814184] 'agreement among raft nodes before linearized reading' (duration: 730.696933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:02:33.373263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:02:32.63769Z","time spent":"735.565822ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T02:03:23.367706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.456876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:03:23.367869Z","caller":"traceutil/trace.go:171","msg":"trace[1758609260] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"351.785107ms","start":"2026-05-07T02:03:23.016061Z","end":"2026-05-07T02:03:23.367846Z","steps":["trace[1758609260] 'process raft request' (duration: 172.072774ms)","trace[1758609260] 'compare' (duration: 179.130749ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:03:23.367933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:23.016037Z","time spent":"351.868059ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:03:37.56243Z","caller":"traceutil/trace.go:171","msg":"trace[468858786] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"112.993787ms","start":"2026-05-07T02:03:37.449389Z","end":"2026-05-07T02:03:37.562382Z","steps":["trace[468858786] 'process raft request' (duration: 112.883774ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:38.143332Z","caller":"traceutil/trace.go:171","msg":"trace[1854086881] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"199.92127ms","start":"2026-05-07T02:03:37.943388Z","end":"2026-05-07T02:03:38.143309Z","steps":["trace[1854086881] 'read index received' (duration: 199.830568ms)","trace[1854086881] 'applied index is now lower than readState.Index' (duration: 89.792µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:38.143412Z","caller":"traceutil/trace.go:171","msg":"trace[1052347029] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"201.961941ms","start":"2026-05-07T02:03:37.941404Z","end":"2026-05-07T02:03:38.143366Z","steps":["trace[1052347029] 'process raft request' (duration: 201.767576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:38.143533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.129835ms","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-05-07T02:03:38.143583Z","caller":"traceutil/trace.go:171","msg":"trace[1742297533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1054; }","duration":"200.198707ms","start":"2026-05-07T02:03:37.943373Z","end":"2026-05-07T02:03:38.143572Z","steps":["trace[1742297533] 'agreement among raft nodes before linearized reading' (duration: 200.023372ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:38.153386Z","caller":"traceutil/trace.go:171","msg":"trace[1219322408] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"209.515317ms","start":"2026-05-07T02:03:37.943832Z","end":"2026-05-07T02:03:38.153347Z","steps":["trace[1219322408] 'process raft request' (duration: 209.120668ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:44.338161Z","caller":"traceutil/trace.go:171","msg":"trace[1116826217] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"159.283359ms","start":"2026-05-07T02:03:44.178854Z","end":"2026-05-07T02:03:44.338138Z","steps":["trace[1116826217] 'read index received' (duration: 159.225456ms)","trace[1116826217] 'applied index is now lower than readState.Index' (duration: 56.633µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:44.338301Z","caller":"traceutil/trace.go:171","msg":"trace[1944783867] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"159.923056ms","start":"2026-05-07T02:03:44.178328Z","end":"2026-05-07T02:03:44.338252Z","steps":["trace[1944783867] 'process raft request' (duration: 159.666298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:44.338658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.775641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-07T02:03:44.338823Z","caller":"traceutil/trace.go:171","msg":"trace[169795986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1073; }","duration":"159.971076ms","start":"2026-05-07T02:03:44.178827Z","end":"2026-05-07T02:03:44.338798Z","steps":["trace[169795986] 'agreement among raft nodes before linearized reading' (duration: 159.537095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:44.82123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.275497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:03:44.821598Z","caller":"traceutil/trace.go:171","msg":"trace[740938791] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"483.339471ms","start":"2026-05-07T02:03:44.338229Z","end":"2026-05-07T02:03:44.821569Z","steps":["trace[740938791] 'read index received' (duration: 36.613673ms)","trace[740938791] 'applied index is now lower than readState.Index' (duration: 446.722818ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:44.821638Z","caller":"traceutil/trace.go:171","msg":"trace[905434938] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"641.876202ms","start":"2026-05-07T02:03:44.179708Z","end":"2026-05-07T02:03:44.821584Z","steps":["trace[905434938] 'process raft request' (duration: 195.105223ms)","trace[905434938] 'compare' (duration: 446.082542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:03:44.821731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.75736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:03:44.821994Z","caller":"traceutil/trace.go:171","msg":"trace[1886675608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"503.033307ms","start":"2026-05-07T02:03:44.318916Z","end":"2026-05-07T02:03:44.821949Z","steps":["trace[1886675608] 'agreement among raft nodes before linearized reading' (duration: 502.75954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:44.822034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:44.318894Z","time spent":"503.132249ms","remote":"127.0.0.1:55786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T02:03:44.821895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:44.179664Z","time spent":"642.167489ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:03:44.822594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.021348ms","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-05-07T02:03:44.822636Z","caller":"traceutil/trace.go:171","msg":"trace[970270617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1074; }","duration":"497.10134ms","start":"2026-05-07T02:03:44.325522Z","end":"2026-05-07T02:03:44.822623Z","steps":["trace[970270617] 'agreement among raft nodes before linearized reading' (duration: 496.130897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:44.822673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:44.325504Z","time spent":"497.161141ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-07T02:03:44.834949Z","caller":"traceutil/trace.go:171","msg":"trace[1707875161] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"491.385961ms","start":"2026-05-07T02:03:44.343532Z","end":"2026-05-07T02:03:44.834918Z","steps":["trace[1707875161] 'process raft request' (duration: 491.149856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:44.835116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:44.343513Z","time spent":"491.497644ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:03:45.225871Z","caller":"traceutil/trace.go:171","msg":"trace[1978302171] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"236.197346ms","start":"2026-05-07T02:03:44.989638Z","end":"2026-05-07T02:03:45.225835Z","steps":["trace[1978302171] 'read index received' (duration: 236.064223ms)","trace[1978302171] 'applied index is now lower than readState.Index' (duration: 131.453µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:45.225997Z","caller":"traceutil/trace.go:171","msg":"trace[181118333] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"398.94618ms","start":"2026-05-07T02:03:44.827005Z","end":"2026-05-07T02:03:45.225951Z","steps":["trace[181118333] 'process raft request' (duration: 398.615962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:45.226079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.39214ms","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-05-07T02:03:45.226125Z","caller":"traceutil/trace.go:171","msg":"trace[1250052275] 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:1076; }","duration":"236.550334ms","start":"2026-05-07T02:03:44.98956Z","end":"2026-05-07T02:03:45.22611Z","steps":["trace[1250052275] 'agreement among raft nodes before linearized reading' (duration: 236.413241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:45.226233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:44.826978Z","time spent":"399.117314ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:03:45.739868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.461225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:03:45.740015Z","caller":"traceutil/trace.go:171","msg":"trace[1054117571] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"367.088644ms","start":"2026-05-07T02:03:45.372903Z","end":"2026-05-07T02:03:45.739992Z","steps":["trace[1054117571] 'read index received' (duration: 226.297122ms)","trace[1054117571] 'applied index is now lower than readState.Index' (duration: 140.789122ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:45.740127Z","caller":"traceutil/trace.go:171","msg":"trace[1489228138] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"588.158777ms","start":"2026-05-07T02:03:45.151897Z","end":"2026-05-07T02:03:45.740056Z","steps":["trace[1489228138] 'process raft request' (duration: 447.386555ms)","trace[1489228138] 'compare' (duration: 140.28471ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:03:45.74026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.343661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-07T02:03:45.740326Z","caller":"traceutil/trace.go:171","msg":"trace[1955180739] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1077; }","duration":"367.427563ms","start":"2026-05-07T02:03:45.372881Z","end":"2026-05-07T02:03:45.740309Z","steps":["trace[1955180739] 'agreement among raft nodes before linearized reading' (duration: 367.213337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:45.740371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:45.372807Z","time spent":"367.551536ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.23\" "} {"level":"warn","ts":"2026-05-07T02:03:45.740385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:45.151873Z","time spent":"588.373462ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:03:45.741355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.265178ms","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-05-07T02:03:45.74146Z","caller":"traceutil/trace.go:171","msg":"trace[1162814204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"144.444372ms","start":"2026-05-07T02:03:45.596991Z","end":"2026-05-07T02:03:45.741435Z","steps":["trace[1162814204] 'agreement among raft nodes before linearized reading' (duration: 143.14383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:46.132619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.129164ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-07T02:03:46.132938Z","caller":"traceutil/trace.go:171","msg":"trace[1435940777] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1120; }","duration":"195.459731ms","start":"2026-05-07T02:03:45.937453Z","end":"2026-05-07T02:03:46.132913Z","steps":["trace[1435940777] 'read index received' (duration: 145.945541ms)","trace[1435940777] 'applied index is now lower than readState.Index' (duration: 49.51239ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:03:46.133121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:45.742041Z","time spent":"391.067955ms","remote":"127.0.0.1:55844","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-07T02:03:46.133179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.703797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T02:03:46.133236Z","caller":"traceutil/trace.go:171","msg":"trace[1874988216] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1078; }","duration":"195.82048ms","start":"2026-05-07T02:03:45.937401Z","end":"2026-05-07T02:03:46.133221Z","steps":["trace[1874988216] 'agreement among raft nodes before linearized reading' (duration: 195.577284ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:46.133215Z","caller":"traceutil/trace.go:171","msg":"trace[1250289403] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"381.951671ms","start":"2026-05-07T02:03:45.751218Z","end":"2026-05-07T02:03:46.13317Z","steps":["trace[1250289403] 'process raft request' (duration: 381.53345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:46.133577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:45.751173Z","time spent":"382.220817ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:03:47.138431Z","caller":"traceutil/trace.go:171","msg":"trace[247410954] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"298.266246ms","start":"2026-05-07T02:03:46.840106Z","end":"2026-05-07T02:03:47.138372Z","steps":["trace[247410954] 'read index received' (duration: 298.080952ms)","trace[247410954] 'applied index is now lower than readState.Index' (duration: 184.214µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:03:47.138535Z","caller":"traceutil/trace.go:171","msg":"trace[345624929] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"306.011707ms","start":"2026-05-07T02:03:46.832472Z","end":"2026-05-07T02:03:47.138484Z","steps":["trace[345624929] 'process raft request' (duration: 305.72324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:47.13867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.508402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:03:47.138718Z","caller":"traceutil/trace.go:171","msg":"trace[796734409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1082; }","duration":"135.667286ms","start":"2026-05-07T02:03:47.00303Z","end":"2026-05-07T02:03:47.138698Z","steps":["trace[796734409] 'agreement among raft nodes before linearized reading' (duration: 135.557483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:47.138734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:46.832439Z","time spent":"306.185441ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:03:47.138806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.664176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-07T02:03:47.138899Z","caller":"traceutil/trace.go:171","msg":"trace[1111061376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1082; }","duration":"298.825849ms","start":"2026-05-07T02:03:46.840052Z","end":"2026-05-07T02:03:47.138878Z","steps":["trace[1111061376] 'agreement among raft nodes before linearized reading' (duration: 298.529502ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:51.120354Z","caller":"traceutil/trace.go:171","msg":"trace[689002547] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"702.115018ms","start":"2026-05-07T02:03:50.418199Z","end":"2026-05-07T02:03:51.120314Z","steps":["trace[689002547] 'process raft request' (duration: 701.869171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:51.120575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:50.41818Z","time spent":"702.277742ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:03:51.58726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.638236ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-07T02:03:51.587434Z","caller":"traceutil/trace.go:171","msg":"trace[130943270] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"421.182628ms","start":"2026-05-07T02:03:51.166182Z","end":"2026-05-07T02:03:51.587365Z","steps":["trace[130943270] 'read index received' (duration: 122.43742ms)","trace[130943270] 'applied index is now lower than readState.Index' (duration: 298.743558ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:03:51.587747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.338914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-07T02:03:51.587768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.254285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-07T02:03:51.587791Z","caller":"traceutil/trace.go:171","msg":"trace[274226470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"417.437686ms","start":"2026-05-07T02:03:51.170342Z","end":"2026-05-07T02:03:51.58778Z","steps":["trace[274226470] 'agreement among raft nodes before linearized reading' (duration: 417.218131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:51.587878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:51.170321Z","time spent":"417.545089ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T02:03:51.587722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.517326ms","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-05-07T02:03:51.587956Z","caller":"traceutil/trace.go:171","msg":"trace[1041695854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"421.824323ms","start":"2026-05-07T02:03:51.16612Z","end":"2026-05-07T02:03:51.587944Z","steps":["trace[1041695854] 'agreement among raft nodes before linearized reading' (duration: 421.367222ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:51.587948Z","caller":"traceutil/trace.go:171","msg":"trace[1533416548] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1094; }","duration":"317.349128ms","start":"2026-05-07T02:03:51.270455Z","end":"2026-05-07T02:03:51.587804Z","steps":["trace[1533416548] 'agreement among raft nodes before linearized reading' (duration: 317.193444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:03:51.588005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:51.166091Z","time spent":"421.900795ms","remote":"127.0.0.1:56108","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-05-07T02:03:51.588005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:03:51.270427Z","time spent":"317.564872ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-07T02:03:51.697619Z","caller":"traceutil/trace.go:171","msg":"trace[1669342995] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"103.589675ms","start":"2026-05-07T02:03:51.593997Z","end":"2026-05-07T02:03:51.697587Z","steps":["trace[1669342995] 'process raft request' (duration: 102.934988ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:03:51.697848Z","caller":"traceutil/trace.go:171","msg":"trace[439609735] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"103.715207ms","start":"2026-05-07T02:03:51.594122Z","end":"2026-05-07T02:03:51.697837Z","steps":["trace[439609735] 'process raft request' (duration: 102.974888ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:04.048377Z","caller":"traceutil/trace.go:171","msg":"trace[732067995] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"294.103874ms","start":"2026-05-07T02:04:03.754243Z","end":"2026-05-07T02:04:04.048347Z","steps":["trace[732067995] 'read index received' (duration: 293.963391ms)","trace[732067995] 'applied index is now lower than readState.Index' (duration: 139.263µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:04.048801Z","caller":"traceutil/trace.go:171","msg":"trace[1060942846] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"332.231325ms","start":"2026-05-07T02:04:03.716548Z","end":"2026-05-07T02:04:04.048779Z","steps":["trace[1060942846] 'process raft request' (duration: 331.635339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.048951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:03.716533Z","time spent":"332.318097ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:04:04.049256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.022287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-07T02:04:04.0493Z","caller":"traceutil/trace.go:171","msg":"trace[1528147876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1184; }","duration":"295.12463ms","start":"2026-05-07T02:04:03.754164Z","end":"2026-05-07T02:04:04.049288Z","steps":["trace[1528147876] 'agreement among raft nodes before linearized reading' (duration: 294.980127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.548996Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954535756340452,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T02:04:04.750505Z","caller":"traceutil/trace.go:171","msg":"trace[264625276] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"871.869815ms","start":"2026-05-07T02:04:03.878617Z","end":"2026-05-07T02:04:04.750487Z","steps":["trace[264625276] 'process raft request' (duration: 871.733091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.75065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:03.878558Z","time spent":"872.007198ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:04:04.751787Z","caller":"traceutil/trace.go:171","msg":"trace[1970116623] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1233; }","duration":"703.298718ms","start":"2026-05-07T02:04:04.04846Z","end":"2026-05-07T02:04:04.751759Z","steps":["trace[1970116623] 'read index received' (duration: 701.894543ms)","trace[1970116623] 'applied index is now lower than readState.Index' (duration: 1.403205ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:04.751995Z","caller":"traceutil/trace.go:171","msg":"trace[359387888] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"694.416998ms","start":"2026-05-07T02:04:04.057567Z","end":"2026-05-07T02:04:04.751984Z","steps":["trace[359387888] 'process raft request' (duration: 693.990437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.75213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:04.057537Z","time spent":"694.49804ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:04:04.752415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.565964ms","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-05-07T02:04:04.752447Z","caller":"traceutil/trace.go:171","msg":"trace[1084201277] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1186; }","duration":"997.640787ms","start":"2026-05-07T02:04:03.754798Z","end":"2026-05-07T02:04:04.752439Z","steps":["trace[1084201277] 'agreement among raft nodes before linearized reading' (duration: 997.514604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.752469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:03.754777Z","time spent":"997.687198ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T02:04:04.753635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.629327ms","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-05-07T02:04:04.753748Z","caller":"traceutil/trace.go:171","msg":"trace[1475141700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1186; }","duration":"457.973846ms","start":"2026-05-07T02:04:04.295754Z","end":"2026-05-07T02:04:04.753728Z","steps":["trace[1475141700] 'agreement among raft nodes before linearized reading' (duration: 457.527915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.7538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:04.295732Z","time spent":"458.059138ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-07T02:04:04.753927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.582739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:04:04.755561Z","caller":"traceutil/trace.go:171","msg":"trace[1982241870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1186; }","duration":"438.25115ms","start":"2026-05-07T02:04:04.317297Z","end":"2026-05-07T02:04:04.755548Z","steps":["trace[1982241870] 'agreement among raft nodes before linearized reading' (duration: 436.586968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:04.755595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:04.317272Z","time spent":"438.313582ms","remote":"127.0.0.1:55786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T02:04:19.391878Z","caller":"traceutil/trace.go:171","msg":"trace[413692614] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"138.868276ms","start":"2026-05-07T02:04:19.252978Z","end":"2026-05-07T02:04:19.391847Z","steps":["trace[413692614] 'process raft request' (duration: 138.412384ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:20.311176Z","caller":"traceutil/trace.go:171","msg":"trace[69208657] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"180.510843ms","start":"2026-05-07T02:04:20.130619Z","end":"2026-05-07T02:04:20.31113Z","steps":["trace[69208657] 'process raft request' (duration: 180.294038ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:21.138629Z","caller":"traceutil/trace.go:171","msg":"trace[394703159] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1292; }","duration":"312.370663ms","start":"2026-05-07T02:04:20.826231Z","end":"2026-05-07T02:04:21.138601Z","steps":["trace[394703159] 'read index received' (duration: 243.195027ms)","trace[394703159] 'applied index is now lower than readState.Index' (duration: 69.173586ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:21.138682Z","caller":"traceutil/trace.go:171","msg":"trace[926667078] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"315.970803ms","start":"2026-05-07T02:04:20.82267Z","end":"2026-05-07T02:04:21.138641Z","steps":["trace[926667078] 'process raft request' (duration: 246.787557ms)","trace[926667078] 'compare' (duration: 68.820997ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:04:21.138911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.120409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-07T02:04:21.138914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:20.822641Z","time spent":"316.131067ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:04:21.138955Z","caller":"traceutil/trace.go:171","msg":"trace[906020643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1240; }","duration":"308.192631ms","start":"2026-05-07T02:04:20.830752Z","end":"2026-05-07T02:04:21.138944Z","steps":["trace[906020643] 'agreement among raft nodes before linearized reading' (duration: 307.996676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:21.138991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:20.830746Z","time spent":"308.237352ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T02:04:21.139273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.03912ms","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-05-07T02:04:21.139329Z","caller":"traceutil/trace.go:171","msg":"trace[199090214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1240; }","duration":"313.120312ms","start":"2026-05-07T02:04:20.826196Z","end":"2026-05-07T02:04:21.139316Z","steps":["trace[199090214] 'agreement among raft nodes before linearized reading' (duration: 312.523157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:21.139379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:20.826184Z","time spent":"313.187733ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T02:04:26.725043Z","caller":"traceutil/trace.go:171","msg":"trace[1397290982] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"378.528796ms","start":"2026-05-07T02:04:26.346493Z","end":"2026-05-07T02:04:26.725022Z","steps":["trace[1397290982] 'process raft request' (duration: 378.380382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:26.725172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:26.346477Z","time spent":"378.631319ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:04:27.217531Z","caller":"traceutil/trace.go:171","msg":"trace[765276035] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"114.575606ms","start":"2026-05-07T02:04:27.102913Z","end":"2026-05-07T02:04:27.217488Z","steps":["trace[765276035] 'process raft request' (duration: 114.261918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:27.591252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.606437ms","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-05-07T02:04:27.591315Z","caller":"traceutil/trace.go:171","msg":"trace[2112724045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1297; }","duration":"170.71817ms","start":"2026-05-07T02:04:27.420584Z","end":"2026-05-07T02:04:27.591302Z","steps":["trace[2112724045] 'range keys from in-memory index tree' (duration: 170.450284ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:28.639794Z","caller":"traceutil/trace.go:171","msg":"trace[1780421207] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"271.145288ms","start":"2026-05-07T02:04:28.368625Z","end":"2026-05-07T02:04:28.639771Z","steps":["trace[1780421207] 'process raft request' (duration: 271.031035ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:28.821619Z","caller":"traceutil/trace.go:171","msg":"trace[717400617] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"436.823934ms","start":"2026-05-07T02:04:28.384773Z","end":"2026-05-07T02:04:28.821597Z","steps":["trace[717400617] 'process raft request' (duration: 394.50811ms)","trace[717400617] 'compare' (duration: 42.16089ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:28.821792Z","caller":"traceutil/trace.go:171","msg":"trace[1190987543] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"172.540086ms","start":"2026-05-07T02:04:28.649223Z","end":"2026-05-07T02:04:28.821763Z","steps":["trace[1190987543] 'read index received' (duration: 129.982006ms)","trace[1190987543] 'applied index is now lower than readState.Index' (duration: 42.55685ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:04:28.821876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:28.384756Z","time spent":"436.931097ms","remote":"127.0.0.1:55880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":837,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T02:04:28.821861Z","caller":"traceutil/trace.go:171","msg":"trace[598038034] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"436.811974ms","start":"2026-05-07T02:04:28.384992Z","end":"2026-05-07T02:04:28.821804Z","steps":["trace[598038034] 'process raft request' (duration: 436.596929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:28.822011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.765822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T02:04:28.822071Z","caller":"traceutil/trace.go:171","msg":"trace[626979798] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1304; }","duration":"172.886855ms","start":"2026-05-07T02:04:28.649169Z","end":"2026-05-07T02:04:28.822056Z","steps":["trace[626979798] 'agreement among raft nodes before linearized reading' (duration: 172.740921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:28.822318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.42264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:04:28.822479Z","caller":"traceutil/trace.go:171","msg":"trace[1260694420] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1304; }","duration":"167.647935ms","start":"2026-05-07T02:04:28.654804Z","end":"2026-05-07T02:04:28.822452Z","steps":["trace[1260694420] 'agreement among raft nodes before linearized reading' (duration: 167.352637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:28.822686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:28.384951Z","time spent":"437.014849ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:04:29.19153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.832114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:04:29.19188Z","caller":"traceutil/trace.go:171","msg":"trace[2032538630] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1358; }","duration":"174.643078ms","start":"2026-05-07T02:04:29.017215Z","end":"2026-05-07T02:04:29.191858Z","steps":["trace[2032538630] 'read index received' (duration: 140.022054ms)","trace[2032538630] 'applied index is now lower than readState.Index' (duration: 34.619984ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:29.192049Z","caller":"traceutil/trace.go:171","msg":"trace[1367261222] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"364.264335ms","start":"2026-05-07T02:04:28.827749Z","end":"2026-05-07T02:04:29.192014Z","steps":["trace[1367261222] 'process raft request' (duration: 177.831316ms)","trace[1367261222] 'compare' (duration: 185.421145ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:29.192029Z","caller":"traceutil/trace.go:171","msg":"trace[1219345020] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"293.205852ms","start":"2026-05-07T02:04:28.898774Z","end":"2026-05-07T02:04:29.191979Z","steps":["trace[1219345020] 'process raft request' (duration: 292.982257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:29.192085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.873895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-05-07T02:04:29.192243Z","caller":"traceutil/trace.go:171","msg":"trace[670950704] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1306; }","duration":"175.081739ms","start":"2026-05-07T02:04:29.017148Z","end":"2026-05-07T02:04:29.19223Z","steps":["trace[670950704] 'agreement among raft nodes before linearized reading' (duration: 174.806413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:29.19217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:28.827731Z","time spent":"364.384368ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T02:04:29.31025Z","caller":"traceutil/trace.go:171","msg":"trace[860161867] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"113.519189ms","start":"2026-05-07T02:04:29.196698Z","end":"2026-05-07T02:04:29.310217Z","steps":["trace[860161867] 'process raft request' (duration: 106.662831ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:29.452553Z","caller":"traceutil/trace.go:171","msg":"trace[1070384262] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1361; }","duration":"133.423012ms","start":"2026-05-07T02:04:29.319106Z","end":"2026-05-07T02:04:29.452529Z","steps":["trace[1070384262] 'read index received' (duration: 8.445689ms)","trace[1070384262] 'applied index is now lower than readState.Index' (duration: 124.976093ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:04:29.452669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.549174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:04:29.452716Z","caller":"traceutil/trace.go:171","msg":"trace[1102728007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"133.637366ms","start":"2026-05-07T02:04:29.319069Z","end":"2026-05-07T02:04:29.452706Z","steps":["trace[1102728007] 'agreement among raft nodes before linearized reading' (duration: 133.553114ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:29.452732Z","caller":"traceutil/trace.go:171","msg":"trace[505045578] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"136.959728ms","start":"2026-05-07T02:04:29.315752Z","end":"2026-05-07T02:04:29.452712Z","steps":["trace[505045578] 'process raft request' (duration: 104.445586ms)","trace[505045578] 'compare' (duration: 32.160913ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:29.452962Z","caller":"traceutil/trace.go:171","msg":"trace[1558678572] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"137.145633ms","start":"2026-05-07T02:04:29.315805Z","end":"2026-05-07T02:04:29.452951Z","steps":["trace[1558678572] 'process raft request' (duration: 136.668991ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:35.004263Z","caller":"traceutil/trace.go:171","msg":"trace[220197555] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"327.883087ms","start":"2026-05-07T02:04:34.676351Z","end":"2026-05-07T02:04:35.004234Z","steps":["trace[220197555] 'process raft request' (duration: 327.709263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:35.004543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:34.676327Z","time spent":"328.053561ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:04:35.716636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954535756340799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T02:04:36.217386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954535756340799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T02:04:36.316155Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.103137389s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-07T02:04:36.5332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34124152s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-07T02:04:36.533287Z","caller":"traceutil/trace.go:171","msg":"trace[1262692661] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1349; }","duration":"1.341414475s","start":"2026-05-07T02:04:35.19185Z","end":"2026-05-07T02:04:36.533265Z","steps":["trace[1262692661] 'range keys from in-memory index tree' (duration: 1.340670206s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.533329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.191826Z","time spent":"1.341493517s","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-07T02:04:36.533503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.92906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:04:36.53366Z","caller":"traceutil/trace.go:171","msg":"trace[2135939743] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1404; }","duration":"1.31723334s","start":"2026-05-07T02:04:35.216407Z","end":"2026-05-07T02:04:36.53364Z","steps":["trace[2135939743] 'read index received' (duration: 1.09993323s)","trace[2135939743] 'applied index is now lower than readState.Index' (duration: 217.29786ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:04:36.533936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.317507187s","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-05-07T02:04:36.534006Z","caller":"traceutil/trace.go:171","msg":"trace[219316378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1350; }","duration":"1.317613359s","start":"2026-05-07T02:04:35.216378Z","end":"2026-05-07T02:04:36.533991Z","steps":["trace[219316378] 'agreement among raft nodes before linearized reading' (duration: 1.317421685s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.534037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.216338Z","time spent":"1.317694061s","remote":"127.0.0.1:56108","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":"info","ts":"2026-05-07T02:04:36.53414Z","caller":"traceutil/trace.go:171","msg":"trace[1280693708] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"1.321246799s","start":"2026-05-07T02:04:35.212876Z","end":"2026-05-07T02:04:36.534123Z","steps":["trace[1280693708] 'process raft request' (duration: 1.103574599s)","trace[1280693708] 'compare' (duration: 216.279555ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:04:36.534134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058374155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-07T02:04:36.534273Z","caller":"traceutil/trace.go:171","msg":"trace[1442879528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1350; }","duration":"1.0585607s","start":"2026-05-07T02:04:35.475691Z","end":"2026-05-07T02:04:36.534252Z","steps":["trace[1442879528] 'agreement among raft nodes before linearized reading' (duration: 1.05818014s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.534444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158383922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-07T02:04:36.534475Z","caller":"traceutil/trace.go:171","msg":"trace[722547706] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1350; }","duration":"1.158443043s","start":"2026-05-07T02:04:35.376026Z","end":"2026-05-07T02:04:36.534469Z","steps":["trace[722547706] 'agreement among raft nodes before linearized reading' (duration: 1.158343881s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.534478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.700036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-07T02:04:36.534495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.376015Z","time spent":"1.158475883s","remote":"127.0.0.1:55844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.23\" "} {"level":"info","ts":"2026-05-07T02:04:36.534537Z","caller":"traceutil/trace.go:171","msg":"trace[1665130527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1350; }","duration":"870.809358ms","start":"2026-05-07T02:04:35.663713Z","end":"2026-05-07T02:04:36.534523Z","steps":["trace[1665130527] 'agreement among raft nodes before linearized reading' (duration: 870.603173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.534605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.663687Z","time spent":"870.909641ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T02:04:36.534619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180226169s","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-05-07T02:04:36.534697Z","caller":"traceutil/trace.go:171","msg":"trace[403415863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1350; }","duration":"1.180353613s","start":"2026-05-07T02:04:35.35432Z","end":"2026-05-07T02:04:36.534674Z","steps":["trace[403415863] 'agreement among raft nodes before linearized reading' (duration: 1.180166488s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.53475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.354287Z","time spent":"1.180452925s","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T02:04:36.53483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.413943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-05-07T02:04:36.534863Z","caller":"traceutil/trace.go:171","msg":"trace[1951894863] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1350; }","duration":"993.513225ms","start":"2026-05-07T02:04:35.54134Z","end":"2026-05-07T02:04:36.534853Z","steps":["trace[1951894863] 'agreement among raft nodes before linearized reading' (duration: 993.439063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.534883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.541295Z","time spent":"993.584067ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-07T02:04:36.534942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214360381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:04:36.535053Z","caller":"traceutil/trace.go:171","msg":"trace[1707872402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1350; }","duration":"1.214514845s","start":"2026-05-07T02:04:35.320527Z","end":"2026-05-07T02:04:36.535042Z","steps":["trace[1707872402] 'agreement among raft nodes before linearized reading' (duration: 1.213331836s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.535119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.320501Z","time spent":"1.214608758s","remote":"127.0.0.1:55786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T02:04:36.534386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.475667Z","time spent":"1.058706863s","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T02:04:36.534218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.212843Z","time spent":"1.32131925s","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:04:36.535816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061770148s","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-05-07T02:04:36.535872Z","caller":"traceutil/trace.go:171","msg":"trace[1151587289] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1350; }","duration":"1.061876161s","start":"2026-05-07T02:04:35.473982Z","end":"2026-05-07T02:04:36.535858Z","steps":["trace[1151587289] 'agreement among raft nodes before linearized reading' (duration: 1.060509057s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.535907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:04:35.47395Z","time spent":"1.061949713s","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T02:04:36.692052Z","caller":"traceutil/trace.go:171","msg":"trace[2139081926] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"150.850441ms","start":"2026-05-07T02:04:36.541179Z","end":"2026-05-07T02:04:36.692029Z","steps":["trace[2139081926] 'process raft request' (duration: 130.966991ms)","trace[2139081926] 'compare' (duration: 19.721176ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:36.692513Z","caller":"traceutil/trace.go:171","msg":"trace[1049476479] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"151.259551ms","start":"2026-05-07T02:04:36.541217Z","end":"2026-05-07T02:04:36.692477Z","steps":["trace[1049476479] 'process raft request' (duration: 150.769659ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.693193Z","caller":"traceutil/trace.go:171","msg":"trace[993433789] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"151.882617ms","start":"2026-05-07T02:04:36.541285Z","end":"2026-05-07T02:04:36.693168Z","steps":["trace[993433789] 'process raft request' (duration: 150.924742ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.693408Z","caller":"traceutil/trace.go:171","msg":"trace[2023186439] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1406; }","duration":"105.464432ms","start":"2026-05-07T02:04:36.587926Z","end":"2026-05-07T02:04:36.69339Z","steps":["trace[2023186439] 'read index received' (duration: 84.239738ms)","trace[2023186439] 'applied index is now lower than readState.Index' (duration: 21.223674ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:04:36.693484Z","caller":"traceutil/trace.go:171","msg":"trace[2058477187] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"151.732573ms","start":"2026-05-07T02:04:36.541741Z","end":"2026-05-07T02:04:36.693473Z","steps":["trace[2058477187] 'process raft request' (duration: 151.421606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:04:36.693559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.622616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:04:36.693601Z","caller":"traceutil/trace.go:171","msg":"trace[740958291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1358; }","duration":"105.752529ms","start":"2026-05-07T02:04:36.587838Z","end":"2026-05-07T02:04:36.693591Z","steps":["trace[740958291] 'agreement among raft nodes before linearized reading' (duration: 105.629276ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.693689Z","caller":"traceutil/trace.go:171","msg":"trace[1611630585] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"152.371399ms","start":"2026-05-07T02:04:36.541307Z","end":"2026-05-07T02:04:36.693678Z","steps":["trace[1611630585] 'process raft request' (duration: 151.519767ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.693787Z","caller":"traceutil/trace.go:171","msg":"trace[1364302010] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"115.334535ms","start":"2026-05-07T02:04:36.578442Z","end":"2026-05-07T02:04:36.693776Z","steps":["trace[1364302010] 'process raft request' (duration: 114.897384ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.693781Z","caller":"traceutil/trace.go:171","msg":"trace[374129988] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"151.617229ms","start":"2026-05-07T02:04:36.542146Z","end":"2026-05-07T02:04:36.693764Z","steps":["trace[374129988] 'process raft request' (duration: 151.071576ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:04:36.694089Z","caller":"traceutil/trace.go:171","msg":"trace[874012309] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"151.22416ms","start":"2026-05-07T02:04:36.542453Z","end":"2026-05-07T02:04:36.693678Z","steps":["trace[874012309] 'process raft request' (duration: 150.82491ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:23.060715Z","caller":"traceutil/trace.go:171","msg":"trace[1341510054] linearizableReadLoop","detail":"{readStateIndex:1631; appliedIndex:1630; }","duration":"113.906731ms","start":"2026-05-07T02:05:22.946783Z","end":"2026-05-07T02:05:23.06069Z","steps":["trace[1341510054] 'read index received' (duration: 113.728847ms)","trace[1341510054] 'applied index is now lower than readState.Index' (duration: 176.504µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:23.060839Z","caller":"traceutil/trace.go:171","msg":"trace[838334994] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"116.563534ms","start":"2026-05-07T02:05:22.944264Z","end":"2026-05-07T02:05:23.060827Z","steps":["trace[838334994] 'process raft request' (duration: 116.269227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:23.061096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.30522ms","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-05-07T02:05:23.061142Z","caller":"traceutil/trace.go:171","msg":"trace[1349065551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1566; }","duration":"114.454103ms","start":"2026-05-07T02:05:22.946676Z","end":"2026-05-07T02:05:23.06113Z","steps":["trace[1349065551] 'agreement among raft nodes before linearized reading' (duration: 114.30749ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:23.066233Z","caller":"traceutil/trace.go:171","msg":"trace[961940652] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"119.061173ms","start":"2026-05-07T02:05:22.947151Z","end":"2026-05-07T02:05:23.066212Z","steps":["trace[961940652] 'process raft request' (duration: 118.91137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:23.066425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.082493ms","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-05-07T02:05:23.066499Z","caller":"traceutil/trace.go:171","msg":"trace[280233777] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1567; }","duration":"111.175464ms","start":"2026-05-07T02:05:22.955291Z","end":"2026-05-07T02:05:23.066467Z","steps":["trace[280233777] 'agreement among raft nodes before linearized reading' (duration: 110.96979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:23.066786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.007772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-07T02:05:23.067058Z","caller":"traceutil/trace.go:171","msg":"trace[2072663019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1567; }","duration":"114.595166ms","start":"2026-05-07T02:05:22.952424Z","end":"2026-05-07T02:05:23.06702Z","steps":["trace[2072663019] 'agreement among raft nodes before linearized reading' (duration: 113.757817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:23.340496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.700074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T02:05:23.340989Z","caller":"traceutil/trace.go:171","msg":"trace[1065693979] transaction","detail":"{read_only:false; response_revision:1568; number_of_response:1; }","duration":"275.626673ms","start":"2026-05-07T02:05:23.065302Z","end":"2026-05-07T02:05:23.340928Z","steps":["trace[1065693979] 'process raft request' (duration: 110.390456ms)","trace[1065693979] 'compare' (duration: 164.465949ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:23.341891Z","caller":"traceutil/trace.go:171","msg":"trace[1895553322] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"270.926081ms","start":"2026-05-07T02:05:23.070948Z","end":"2026-05-07T02:05:23.341874Z","steps":["trace[1895553322] 'process raft request' (duration: 269.673081ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:23.342201Z","caller":"traceutil/trace.go:171","msg":"trace[400846286] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"270.446029ms","start":"2026-05-07T02:05:23.071734Z","end":"2026-05-07T02:05:23.34218Z","steps":["trace[400846286] 'process raft request' (duration: 270.023519ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:25.500086Z","caller":"traceutil/trace.go:171","msg":"trace[1653128594] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"148.18927ms","start":"2026-05-07T02:05:25.351864Z","end":"2026-05-07T02:05:25.500053Z","steps":["trace[1653128594] 'process raft request' (duration: 147.941354ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:25.50511Z","caller":"traceutil/trace.go:171","msg":"trace[710068707] linearizableReadLoop","detail":"{readStateIndex:1644; appliedIndex:1641; }","duration":"150.202318ms","start":"2026-05-07T02:05:25.354879Z","end":"2026-05-07T02:05:25.505081Z","steps":["trace[710068707] 'read index received' (duration: 144.936832ms)","trace[710068707] 'applied index is now lower than readState.Index' (duration: 5.263826ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:25.505538Z","caller":"traceutil/trace.go:171","msg":"trace[1443464266] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"153.571288ms","start":"2026-05-07T02:05:25.351919Z","end":"2026-05-07T02:05:25.50549Z","steps":["trace[1443464266] 'process raft request' (duration: 152.969784ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:25.505578Z","caller":"traceutil/trace.go:171","msg":"trace[2002991625] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"153.035725ms","start":"2026-05-07T02:05:25.352505Z","end":"2026-05-07T02:05:25.505541Z","steps":["trace[2002991625] 'process raft request' (duration: 152.517543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:25.505747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.834453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-07T02:05:25.505884Z","caller":"traceutil/trace.go:171","msg":"trace[254423652] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1579; }","duration":"151.026818ms","start":"2026-05-07T02:05:25.354835Z","end":"2026-05-07T02:05:25.505862Z","steps":["trace[254423652] 'agreement among raft nodes before linearized reading' (duration: 150.542566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:25.506164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.88311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-07T02:05:25.506214Z","caller":"traceutil/trace.go:171","msg":"trace[260115741] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:1579; }","duration":"126.976023ms","start":"2026-05-07T02:05:25.379225Z","end":"2026-05-07T02:05:25.506201Z","steps":["trace[260115741] 'agreement among raft nodes before linearized reading' (duration: 126.261966ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:37.705177Z","caller":"traceutil/trace.go:171","msg":"trace[546101220] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"133.720034ms","start":"2026-05-07T02:05:37.571246Z","end":"2026-05-07T02:05:37.704966Z","steps":["trace[546101220] 'process raft request' (duration: 133.488449ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:05:37.793302Z","caller":"traceutil/trace.go:171","msg":"trace[2103695253] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"221.253184ms","start":"2026-05-07T02:05:37.572009Z","end":"2026-05-07T02:05:37.793262Z","steps":["trace[2103695253] 'process raft request' (duration: 175.274177ms)","trace[2103695253] 'compare' (duration: 45.747722ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:37.793644Z","caller":"traceutil/trace.go:171","msg":"trace[552443864] linearizableReadLoop","detail":"{readStateIndex:1703; appliedIndex:1700; }","duration":"182.96926ms","start":"2026-05-07T02:05:37.610639Z","end":"2026-05-07T02:05:37.793609Z","steps":["trace[552443864] 'read index received' (duration: 94.021326ms)","trace[552443864] 'applied index is now lower than readState.Index' (duration: 88.944884ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T02:05:37.793833Z","caller":"traceutil/trace.go:171","msg":"trace[426024011] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"221.222903ms","start":"2026-05-07T02:05:37.572584Z","end":"2026-05-07T02:05:37.793807Z","steps":["trace[426024011] 'process raft request' (duration: 220.617119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:05:37.793894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.221035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-07T02:05:37.793935Z","caller":"traceutil/trace.go:171","msg":"trace[701898371] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1635; }","duration":"183.287078ms","start":"2026-05-07T02:05:37.610636Z","end":"2026-05-07T02:05:37.793923Z","steps":["trace[701898371] 'agreement among raft nodes before linearized reading' (duration: 183.065172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:39.81836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954535756342183,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T02:06:40.202971Z","caller":"traceutil/trace.go:171","msg":"trace[1667825023] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"884.891271ms","start":"2026-05-07T02:06:39.318059Z","end":"2026-05-07T02:06:40.202951Z","steps":["trace[1667825023] 'read index received' (duration: 884.671795ms)","trace[1667825023] 'applied index is now lower than readState.Index' (duration: 218.395µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T02:06:40.203163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.094676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:06:40.203157Z","caller":"traceutil/trace.go:171","msg":"trace[144280235] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"919.780861ms","start":"2026-05-07T02:06:39.28332Z","end":"2026-05-07T02:06:40.2031Z","steps":["trace[144280235] 'process raft request' (duration: 919.491313ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:40.203224Z","caller":"traceutil/trace.go:171","msg":"trace[1862862227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1914; }","duration":"885.166478ms","start":"2026-05-07T02:06:39.318042Z","end":"2026-05-07T02:06:40.203208Z","steps":["trace[1862862227] 'agreement among raft nodes before linearized reading' (duration: 885.029564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:40.203267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.317976Z","time spent":"885.280611ms","remote":"127.0.0.1:55786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T02:06:40.203368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.283293Z","time spent":"919.958215ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T02:06:40.203689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.121988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T02:06:40.203729Z","caller":"traceutil/trace.go:171","msg":"trace[578195916] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1914; }","duration":"542.1885ms","start":"2026-05-07T02:06:39.661527Z","end":"2026-05-07T02:06:40.203716Z","steps":["trace[578195916] 'agreement among raft nodes before linearized reading' (duration: 542.127758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:40.203734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.604561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"warn","ts":"2026-05-07T02:06:40.203752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.661514Z","time spent":"542.23193ms","remote":"127.0.0.1:56366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-07T02:06:40.203788Z","caller":"traceutil/trace.go:171","msg":"trace[1059014586] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1914; }","duration":"562.689782ms","start":"2026-05-07T02:06:39.641084Z","end":"2026-05-07T02:06:40.203773Z","steps":["trace[1059014586] 'agreement among raft nodes before linearized reading' (duration: 562.515768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:40.203996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.641069Z","time spent":"562.918868ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-07T02:06:40.204371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.947186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T02:06:40.204416Z","caller":"traceutil/trace.go:171","msg":"trace[967173598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1914; }","duration":"886.08342ms","start":"2026-05-07T02:06:39.318319Z","end":"2026-05-07T02:06:40.204402Z","steps":["trace[967173598] 'agreement among raft nodes before linearized reading' (duration: 885.986808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:40.204453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.318284Z","time spent":"886.159981ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T02:06:40.204446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.122237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-07T02:06:40.204719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.426803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-07T02:06:40.204805Z","caller":"traceutil/trace.go:171","msg":"trace[1613331559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1914; }","duration":"690.346502ms","start":"2026-05-07T02:06:39.514206Z","end":"2026-05-07T02:06:40.204552Z","steps":["trace[1613331559] 'agreement among raft nodes before linearized reading' (duration: 689.509262ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:40.204827Z","caller":"traceutil/trace.go:171","msg":"trace[535712119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1914; }","duration":"692.583486ms","start":"2026-05-07T02:06:39.512216Z","end":"2026-05-07T02:06:40.2048Z","steps":["trace[535712119] 'agreement among raft nodes before linearized reading' (duration: 691.89373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T02:06:40.204868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.514189Z","time spent":"690.6676ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T02:06:40.204886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T02:06:39.51219Z","time spent":"692.682568ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-07T02:06:54.58785Z","caller":"traceutil/trace.go:171","msg":"trace[370601563] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"162.409156ms","start":"2026-05-07T02:06:54.425408Z","end":"2026-05-07T02:06:54.587817Z","steps":["trace[370601563] 'process raft request' (duration: 161.537095ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:54.587968Z","caller":"traceutil/trace.go:171","msg":"trace[838173471] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"162.462457ms","start":"2026-05-07T02:06:54.425469Z","end":"2026-05-07T02:06:54.587931Z","steps":["trace[838173471] 'process raft request' (duration: 161.523325ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:54.588145Z","caller":"traceutil/trace.go:171","msg":"trace[1209869430] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"162.833197ms","start":"2026-05-07T02:06:54.425296Z","end":"2026-05-07T02:06:54.588129Z","steps":["trace[1209869430] 'process raft request' (duration: 156.837672ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:54.5888Z","caller":"traceutil/trace.go:171","msg":"trace[1787023182] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"161.809881ms","start":"2026-05-07T02:06:54.426972Z","end":"2026-05-07T02:06:54.588782Z","steps":["trace[1787023182] 'process raft request' (duration: 161.75346ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:06:54.58895Z","caller":"traceutil/trace.go:171","msg":"trace[391905563] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"162.906648ms","start":"2026-05-07T02:06:54.426016Z","end":"2026-05-07T02:06:54.588923Z","steps":["trace[391905563] 'process raft request' (duration: 162.511048ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:07:04.308971Z","caller":"traceutil/trace.go:171","msg":"trace[1207439596] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"136.79782ms","start":"2026-05-07T02:07:04.172148Z","end":"2026-05-07T02:07:04.308946Z","steps":["trace[1207439596] 'process raft request' (duration: 136.522313ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T02:07:04.641173Z","caller":"traceutil/trace.go:171","msg":"trace[1426619097] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"148.324268ms","start":"2026-05-07T02:07:04.492817Z","end":"2026-05-07T02:07:04.641142Z","steps":["trace[1426619097] 'process raft request' (duration: 147.498148ms)"],"step_count":1}