{"level":"warn","ts":"2026-04-27T16:00:54.635906Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T16:00:54.635992Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T16:00:54.636048Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T16:00:54.636057Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-27T16:00:54.636073Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T16:00:54.636681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-04-27T16:00:54.636777Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T16:00:54.6417Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.738001ms"} {"level":"info","ts":"2026-04-27T16:00:54.651337Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-04-27T16:00:54.651414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T16:00:54.651436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-04-27T16:00:54.651448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T16:00:54.651457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-04-27T16:00:54.651505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-04-27T16:00:54.663732Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T16:00:54.665356Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T16:00:54.667091Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T16:00:54.670754Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T16:00:54.671066Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T16:00:54.67111Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T16:00:54.671396Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T16:00:54.671464Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T16:00:54.672378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-04-27T16:00:54.672611Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-27T16:00:54.675107Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T16:00:54.675287Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T16:00:54.675326Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T16:00:54.67531Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-27T16:00:54.675953Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-27T16:00:55.25206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T16:00:55.252151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T16:00:55.2522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-04-27T16:00:55.25222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-04-27T16:00:55.252231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-27T16:00:55.252247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-04-27T16:00:55.252261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-27T16:00:55.25347Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T16:00:55.253475Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:00:55.25363Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:00:55.254012Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T16:00:55.254039Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T16:00:55.257283Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-04-27T16:00:55.257591Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T16:00:55.267013Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:00:55.273443Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:00:55.27357Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:00:55.273619Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:00:57.161806Z","caller":"traceutil/trace.go:171","msg":"trace[1653006552] linearizableReadLoop","detail":"{readStateIndex:103; appliedIndex:102; }","duration":"303.239101ms","start":"2026-04-27T16:00:56.858528Z","end":"2026-04-27T16:00:57.161767Z","steps":["trace[1653006552] 'read index received' (duration: 292.588379ms)","trace[1653006552] 'applied index is now lower than readState.Index' (duration: 10.649382ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:00:57.161959Z","caller":"traceutil/trace.go:171","msg":"trace[1679623890] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"346.631344ms","start":"2026-04-27T16:00:56.815287Z","end":"2026-04-27T16:00:57.161918Z","steps":["trace[1679623890] 'process raft request' (duration: 335.806697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:00:57.162029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.468438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T16:00:57.162418Z","caller":"traceutil/trace.go:171","msg":"trace[1467558861] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:97; }","duration":"303.88802ms","start":"2026-04-27T16:00:56.858488Z","end":"2026-04-27T16:00:57.162375Z","steps":["trace[1467558861] 'agreement among raft nodes before linearized reading' (duration: 303.435807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:00:57.16256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:00:56.858462Z","time spent":"304.080244ms","remote":"127.0.0.1:46472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-27T16:00:57.162626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:00:56.815265Z","time spent":"346.799178ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":749,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:01.514884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695212111s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:01:01.515016Z","caller":"traceutil/trace.go:171","msg":"trace[1226407300] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:248; }","duration":"2.186708891s","start":"2026-04-27T16:00:59.328289Z","end":"2026-04-27T16:01:01.514998Z","steps":["trace[1226407300] 'read index received' (duration: 490.970075ms)","trace[1226407300] 'applied index is now lower than readState.Index' (duration: 1.695735596s)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:01.515095Z","caller":"traceutil/trace.go:171","msg":"trace[1221648862] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"2.187520643s","start":"2026-04-27T16:00:59.327518Z","end":"2026-04-27T16:01:01.515039Z","steps":["trace[1221648862] 'process raft request' (duration: 491.905841ms)","trace[1221648862] 'compare' (duration: 1.694586314s)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:01.515143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.510303456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:01.515182Z","caller":"traceutil/trace.go:171","msg":"trace[1411211448] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:242; }","duration":"1.510408579s","start":"2026-04-27T16:01:00.004762Z","end":"2026-04-27T16:01:01.51517Z","steps":["trace[1411211448] 'agreement among raft nodes before linearized reading' (duration: 1.510331857s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:01.515185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.488533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:01.515217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:00.004737Z","time spent":"1.510469971s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T16:01:01.515235Z","caller":"traceutil/trace.go:171","msg":"trace[1272730517] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:242; }","duration":"886.570765ms","start":"2026-04-27T16:01:00.628649Z","end":"2026-04-27T16:01:01.51522Z","steps":["trace[1272730517] 'agreement among raft nodes before linearized reading' (duration: 886.501354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:01.515263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:00.628627Z","time spent":"886.629517ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:01:01.515251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:00:59.32749Z","time spent":"2.187689278s","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:01.515145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.186847165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-5u9gxq\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:01.515528Z","caller":"traceutil/trace.go:171","msg":"trace[427007408] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-5u9gxq; range_end:; response_count:0; response_revision:242; }","duration":"2.187275226s","start":"2026-04-27T16:00:59.328238Z","end":"2026-04-27T16:01:01.515513Z","steps":["trace[427007408] 'agreement among raft nodes before linearized reading' (duration: 2.186823264s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:01.51559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:00:59.32822Z","time spent":"2.187357839s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-5u9gxq\" "} {"level":"warn","ts":"2026-04-27T16:01:02.919368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.639624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:01:02.919681Z","caller":"traceutil/trace.go:171","msg":"trace[66162251] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"1.21377254s","start":"2026-04-27T16:01:01.70589Z","end":"2026-04-27T16:01:02.919662Z","steps":["trace[66162251] 'process raft request' (duration: 1.213711449s)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:02.919677Z","caller":"traceutil/trace.go:171","msg":"trace[2032247868] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"1.400437899s","start":"2026-04-27T16:01:01.519167Z","end":"2026-04-27T16:01:02.919605Z","steps":["trace[2032247868] 'process raft request' (duration: 896.476216ms)","trace[2032247868] 'compare' (duration: 503.467709ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:02.91972Z","caller":"traceutil/trace.go:171","msg":"trace[1466688390] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"1.400495391s","start":"2026-04-27T16:01:01.519188Z","end":"2026-04-27T16:01:02.919684Z","steps":["trace[1466688390] 'process raft request' (duration: 1.400372688s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:02.919829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:01.705858Z","time spent":"1.213899734s","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:02.919854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:01.519135Z","time spent":"1.400646545s","remote":"127.0.0.1:46322","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-04-27T16:01:02.919956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:01.519171Z","time spent":"1.400672885s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:01:02.919742Z","caller":"traceutil/trace.go:171","msg":"trace[568316420] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"1.400542102s","start":"2026-04-27T16:01:01.519179Z","end":"2026-04-27T16:01:02.919721Z","steps":["trace[568316420] 'process raft request' (duration: 1.400318706s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:02.920217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:01.519158Z","time spent":"1.401031946s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:01:02.92201Z","caller":"traceutil/trace.go:171","msg":"trace[374007870] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"475.681607ms","start":"2026-04-27T16:01:02.446298Z","end":"2026-04-27T16:01:02.921979Z","steps":["trace[374007870] 'process raft request' (duration: 475.526173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:02.922199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:02.446269Z","time spent":"475.855322ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:01:11.200794Z","caller":"traceutil/trace.go:171","msg":"trace[836638422] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:415; }","duration":"221.728796ms","start":"2026-04-27T16:01:10.979034Z","end":"2026-04-27T16:01:11.200763Z","steps":["trace[836638422] 'read index received' (duration: 87.996083ms)","trace[836638422] 'applied index is now lower than readState.Index' (duration: 133.731523ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:11.20109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.030515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:01:11.201269Z","caller":"traceutil/trace.go:171","msg":"trace[208268213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:404; }","duration":"222.24541ms","start":"2026-04-27T16:01:10.979006Z","end":"2026-04-27T16:01:11.201252Z","steps":["trace[208268213] 'agreement among raft nodes before linearized reading' (duration: 221.985253ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:11.200975Z","caller":"traceutil/trace.go:171","msg":"trace[2003505596] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"224.990295ms","start":"2026-04-27T16:01:10.975954Z","end":"2026-04-27T16:01:11.200944Z","steps":["trace[2003505596] 'process raft request' (duration: 180.792867ms)","trace[2003505596] 'compare' (duration: 43.863579ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:13.437663Z","caller":"traceutil/trace.go:171","msg":"trace[1252736721] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"225.313329ms","start":"2026-04-27T16:01:13.212324Z","end":"2026-04-27T16:01:13.437637Z","steps":["trace[1252736721] 'process raft request' (duration: 225.038441ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:14.18415Z","caller":"traceutil/trace.go:171","msg":"trace[1900908261] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"196.896572ms","start":"2026-04-27T16:01:13.987223Z","end":"2026-04-27T16:01:14.184119Z","steps":["trace[1900908261] 'process raft request' (duration: 123.328435ms)","trace[1900908261] 'compare' (duration: 73.418743ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:14.191973Z","caller":"traceutil/trace.go:171","msg":"trace[1860009743] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"182.92039ms","start":"2026-04-27T16:01:14.009012Z","end":"2026-04-27T16:01:14.191933Z","steps":["trace[1860009743] 'process raft request' (duration: 182.722984ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:28.680877Z","caller":"traceutil/trace.go:171","msg":"trace[1696161183] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"131.830771ms","start":"2026-04-27T16:01:28.549004Z","end":"2026-04-27T16:01:28.680835Z","steps":["trace[1696161183] 'process raft request' (duration: 124.472761ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:28.681787Z","caller":"traceutil/trace.go:171","msg":"trace[42478082] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"131.348728ms","start":"2026-04-27T16:01:28.550409Z","end":"2026-04-27T16:01:28.681758Z","steps":["trace[42478082] 'process raft request' (duration: 130.729131ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:28.682119Z","caller":"traceutil/trace.go:171","msg":"trace[1465345268] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"125.975362ms","start":"2026-04-27T16:01:28.556107Z","end":"2026-04-27T16:01:28.682082Z","steps":["trace[1465345268] 'process raft request' (duration: 125.587011ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.465199Z","caller":"traceutil/trace.go:171","msg":"trace[1848380734] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"284.174333ms","start":"2026-04-27T16:01:30.181Z","end":"2026-04-27T16:01:30.465174Z","steps":["trace[1848380734] 'process raft request' (duration: 284.04327ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.473623Z","caller":"traceutil/trace.go:171","msg":"trace[1603602178] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"278.49995ms","start":"2026-04-27T16:01:30.195095Z","end":"2026-04-27T16:01:30.473595Z","steps":["trace[1603602178] 'process raft request' (duration: 277.950695ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.473662Z","caller":"traceutil/trace.go:171","msg":"trace[688935713] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"272.473366ms","start":"2026-04-27T16:01:30.201156Z","end":"2026-04-27T16:01:30.473629Z","steps":["trace[688935713] 'process raft request' (duration: 271.999303ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.473913Z","caller":"traceutil/trace.go:171","msg":"trace[1724486618] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"276.796883ms","start":"2026-04-27T16:01:30.197104Z","end":"2026-04-27T16:01:30.473901Z","steps":["trace[1724486618] 'process raft request' (duration: 275.981791ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.473954Z","caller":"traceutil/trace.go:171","msg":"trace[1458488446] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"286.591959ms","start":"2026-04-27T16:01:30.187354Z","end":"2026-04-27T16:01:30.473946Z","steps":["trace[1458488446] 'process raft request' (duration: 285.53173ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474015Z","caller":"traceutil/trace.go:171","msg":"trace[144349449] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"286.594259ms","start":"2026-04-27T16:01:30.187415Z","end":"2026-04-27T16:01:30.474009Z","steps":["trace[144349449] 'process raft request' (duration: 285.554471ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.473994Z","caller":"traceutil/trace.go:171","msg":"trace[1741255861] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"117.866629ms","start":"2026-04-27T16:01:30.356103Z","end":"2026-04-27T16:01:30.473969Z","steps":["trace[1741255861] 'process raft request' (duration: 117.727755ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474028Z","caller":"traceutil/trace.go:171","msg":"trace[2102709198] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"264.483639ms","start":"2026-04-27T16:01:30.209523Z","end":"2026-04-27T16:01:30.474007Z","steps":["trace[2102709198] 'process raft request' (duration: 263.77731ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474064Z","caller":"traceutil/trace.go:171","msg":"trace[1280050174] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"279.039214ms","start":"2026-04-27T16:01:30.195019Z","end":"2026-04-27T16:01:30.474058Z","steps":["trace[1280050174] 'process raft request' (duration: 277.987066ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474133Z","caller":"traceutil/trace.go:171","msg":"trace[2843444] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"263.211684ms","start":"2026-04-27T16:01:30.210913Z","end":"2026-04-27T16:01:30.474124Z","steps":["trace[2843444] 'process raft request' (duration: 262.496945ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474141Z","caller":"traceutil/trace.go:171","msg":"trace[1004015514] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"229.880849ms","start":"2026-04-27T16:01:30.244252Z","end":"2026-04-27T16:01:30.474133Z","steps":["trace[1004015514] 'process raft request' (duration: 229.313014ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:30.474142Z","caller":"traceutil/trace.go:171","msg":"trace[1678172153] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"269.544836ms","start":"2026-04-27T16:01:30.204587Z","end":"2026-04-27T16:01:30.474132Z","steps":["trace[1678172153] 'process raft request' (duration: 268.628411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.089874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:34.463873Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.085958001s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T16:01:34.464284Z","caller":"traceutil/trace.go:171","msg":"trace[1197400270] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.086445195s","start":"2026-04-27T16:01:33.37781Z","end":"2026-04-27T16:01:34.464255Z","steps":["trace[1197400270] 'process raft request' (duration: 1.086293751s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.464816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:33.377788Z","time spent":"1.086670211s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:01:34.623015Z","caller":"traceutil/trace.go:171","msg":"trace[991067338] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.143959044s","start":"2026-04-27T16:01:33.479012Z","end":"2026-04-27T16:01:34.622971Z","steps":["trace[991067338] 'process raft request' (duration: 1.143258395s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.623213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:33.47898Z","time spent":"1.1441473s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:01:34.631613Z","caller":"traceutil/trace.go:171","msg":"trace[1284155279] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:621; }","duration":"1.042696838s","start":"2026-04-27T16:01:33.588889Z","end":"2026-04-27T16:01:34.631586Z","steps":["trace[1284155279] 'read index received' (duration: 875.321818ms)","trace[1284155279] 'applied index is now lower than readState.Index' (duration: 167.37407ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:34.631905Z","caller":"traceutil/trace.go:171","msg":"trace[158978392] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"226.219815ms","start":"2026-04-27T16:01:34.405674Z","end":"2026-04-27T16:01:34.631894Z","steps":["trace[158978392] 'process raft request' (duration: 225.739942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.63216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043271793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:01:34.632192Z","caller":"traceutil/trace.go:171","msg":"trace[485087215] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"1.043372176s","start":"2026-04-27T16:01:33.58881Z","end":"2026-04-27T16:01:34.632182Z","steps":["trace[485087215] 'agreement among raft nodes before linearized reading' (duration: 1.043250413s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.632216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:33.588764Z","time spent":"1.043445628s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:01:34.632272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.097165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:34.632318Z","caller":"traceutil/trace.go:171","msg":"trace[1872781513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"520.205198ms","start":"2026-04-27T16:01:34.112101Z","end":"2026-04-27T16:01:34.632306Z","steps":["trace[1872781513] 'agreement among raft nodes before linearized reading' (duration: 520.117015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:34.632354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:34.112074Z","time spent":"520.27397ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T16:01:38.471932Z","caller":"traceutil/trace.go:171","msg":"trace[52325319] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"178.347951ms","start":"2026-04-27T16:01:38.293559Z","end":"2026-04-27T16:01:38.471907Z","steps":["trace[52325319] 'read index received' (duration: 177.55951ms)","trace[52325319] 'applied index is now lower than readState.Index' (duration: 787.551µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:38.472689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.090421ms","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":"info","ts":"2026-04-27T16:01:38.472772Z","caller":"traceutil/trace.go:171","msg":"trace[1040950922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"179.246685ms","start":"2026-04-27T16:01:38.293507Z","end":"2026-04-27T16:01:38.472753Z","steps":["trace[1040950922] 'agreement among raft nodes before linearized reading' (duration: 179.083981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:38.472815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.147413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:38.472884Z","caller":"traceutil/trace.go:171","msg":"trace[161941936] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"179.255435ms","start":"2026-04-27T16:01:38.29361Z","end":"2026-04-27T16:01:38.472866Z","steps":["trace[161941936] 'agreement among raft nodes before linearized reading' (duration: 179.108321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:38.473084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.252965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-27T16:01:38.473106Z","caller":"traceutil/trace.go:171","msg":"trace[938338484] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:628; }","duration":"179.332557ms","start":"2026-04-27T16:01:38.293766Z","end":"2026-04-27T16:01:38.473099Z","steps":["trace[938338484] 'agreement among raft nodes before linearized reading' (duration: 179.280176ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:38.472663Z","caller":"traceutil/trace.go:171","msg":"trace[706124378] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"331.759217ms","start":"2026-04-27T16:01:38.140877Z","end":"2026-04-27T16:01:38.472636Z","steps":["trace[706124378] 'process raft request' (duration: 330.549924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:38.474284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.140849Z","time spent":"333.33821ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:01:39.015973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.612596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:01:39.016106Z","caller":"traceutil/trace.go:171","msg":"trace[567054891] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"487.773793ms","start":"2026-04-27T16:01:38.528315Z","end":"2026-04-27T16:01:39.016089Z","steps":["trace[567054891] 'read index received' (duration: 376.879069ms)","trace[567054891] 'applied index is now lower than readState.Index' (duration: 110.893324ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:39.016414Z","caller":"traceutil/trace.go:171","msg":"trace[308482987] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"517.636582ms","start":"2026-04-27T16:01:38.498763Z","end":"2026-04-27T16:01:39.016399Z","steps":["trace[308482987] 'process raft request' (duration: 406.46872ms)","trace[308482987] 'compare' (duration: 110.159154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:39.016494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.498729Z","time spent":"517.727474ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:01:39.01665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.306137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-27T16:01:39.016819Z","caller":"traceutil/trace.go:171","msg":"trace[891620927] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:630; }","duration":"488.548754ms","start":"2026-04-27T16:01:38.528246Z","end":"2026-04-27T16:01:39.016794Z","steps":["trace[891620927] 'agreement among raft nodes before linearized reading' (duration: 488.167204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.016928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.528227Z","time spent":"488.682257ms","remote":"127.0.0.1:46212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-04-27T16:01:39.197758Z","caller":"traceutil/trace.go:171","msg":"trace[1638144] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"181.578658ms","start":"2026-04-27T16:01:39.016136Z","end":"2026-04-27T16:01:39.197715Z","steps":["trace[1638144] 'read index received' (duration: 181.30611ms)","trace[1638144] 'applied index is now lower than readState.Index' (duration: 270.698µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:39.19787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.616916ms","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-04-27T16:01:39.197948Z","caller":"traceutil/trace.go:171","msg":"trace[1662369533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"539.714028ms","start":"2026-04-27T16:01:38.658215Z","end":"2026-04-27T16:01:39.197929Z","steps":["trace[1662369533] 'agreement among raft nodes before linearized reading' (duration: 539.541964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.65821Z","time spent":"539.78105ms","remote":"127.0.0.1:53700","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-04-27T16:01:39.19802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.983936ms","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-04-27T16:01:39.198078Z","caller":"traceutil/trace.go:171","msg":"trace[157134205] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"540.101019ms","start":"2026-04-27T16:01:38.657956Z","end":"2026-04-27T16:01:39.198057Z","steps":["trace[157134205] 'agreement among raft nodes before linearized reading' (duration: 539.959935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.193105ms","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":"warn","ts":"2026-04-27T16:01:39.198146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.657949Z","time spent":"540.183201ms","remote":"127.0.0.1:53700","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":"info","ts":"2026-04-27T16:01:39.198201Z","caller":"traceutil/trace.go:171","msg":"trace[304523726] 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:631; }","duration":"491.424391ms","start":"2026-04-27T16:01:38.706742Z","end":"2026-04-27T16:01:39.198167Z","steps":["trace[304523726] 'agreement among raft nodes before linearized reading' (duration: 490.996509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.197914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.068632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.198277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.706727Z","time spent":"491.533014ms","remote":"127.0.0.1:53714","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-04-27T16:01:39.198341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.518841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:39.198375Z","caller":"traceutil/trace.go:171","msg":"trace[664386324] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:631; }","duration":"508.515094ms","start":"2026-04-27T16:01:38.689802Z","end":"2026-04-27T16:01:39.198317Z","steps":["trace[664386324] 'agreement among raft nodes before linearized reading' (duration: 508.051781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.328389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.198489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.689792Z","time spent":"508.677329ms","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:01:39.198609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.982391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T16:01:39.198672Z","caller":"traceutil/trace.go:171","msg":"trace[928118285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"446.075583ms","start":"2026-04-27T16:01:38.752586Z","end":"2026-04-27T16:01:39.198661Z","steps":["trace[928118285] 'agreement among raft nodes before linearized reading' (duration: 445.870378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.132125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.198708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.752563Z","time spent":"446.137594ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:01:39.198717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.583225ms","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":"info","ts":"2026-04-27T16:01:39.198627Z","caller":"traceutil/trace.go:171","msg":"trace[1331727056] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:631; }","duration":"508.803732ms","start":"2026-04-27T16:01:38.689741Z","end":"2026-04-27T16:01:39.198545Z","steps":["trace[1331727056] 'agreement among raft nodes before linearized reading' (duration: 508.061612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.058528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:39.198886Z","caller":"traceutil/trace.go:171","msg":"trace[922125930] 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:631; }","duration":"492.12518ms","start":"2026-04-27T16:01:38.706753Z","end":"2026-04-27T16:01:39.198878Z","steps":["trace[922125930] 'agreement among raft nodes before linearized reading' (duration: 492.059338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.706734Z","time spent":"492.176842ms","remote":"127.0.0.1:53714","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-04-27T16:01:39.198997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.61315ms","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-04-27T16:01:39.19903Z","caller":"traceutil/trace.go:171","msg":"trace[1320030152] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"565.650631ms","start":"2026-04-27T16:01:38.633369Z","end":"2026-04-27T16:01:39.19902Z","steps":["trace[1320030152] 'agreement among raft nodes before linearized reading' (duration: 565.60722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.199072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.633366Z","time spent":"565.693012ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:01:39.198954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.47721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-27T16:01:39.199119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.3324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:39.19916Z","caller":"traceutil/trace.go:171","msg":"trace[2080005752] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"456.388222ms","start":"2026-04-27T16:01:38.742756Z","end":"2026-04-27T16:01:39.199144Z","steps":["trace[2080005752] 'agreement among raft nodes before linearized reading' (duration: 456.328961ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:39.19916Z","caller":"traceutil/trace.go:171","msg":"trace[1794602640] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:631; }","duration":"179.736327ms","start":"2026-04-27T16:01:39.019396Z","end":"2026-04-27T16:01:39.199133Z","steps":["trace[1794602640] 'agreement among raft nodes before linearized reading' (duration: 179.439959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.199193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.742748Z","time spent":"456.438303ms","remote":"127.0.0.1:53724","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-04-27T16:01:39.199256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.887897ms","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-04-27T16:01:39.199306Z","caller":"traceutil/trace.go:171","msg":"trace[1079018501] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"565.943689ms","start":"2026-04-27T16:01:38.633349Z","end":"2026-04-27T16:01:39.199292Z","steps":["trace[1079018501] 'agreement among raft nodes before linearized reading' (duration: 565.877568ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:39.198418Z","caller":"traceutil/trace.go:171","msg":"trace[1005602485] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:631; }","duration":"509.622534ms","start":"2026-04-27T16:01:38.688774Z","end":"2026-04-27T16:01:39.198396Z","steps":["trace[1005602485] 'agreement among raft nodes before linearized reading' (duration: 509.518031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.19861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.077193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-27T16:01:39.199348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.633343Z","time spent":"565.995661ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:01:39.199376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.688752Z","time spent":"510.611621ms","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-04-27T16:01:39.199375Z","caller":"traceutil/trace.go:171","msg":"trace[1999438097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"446.876984ms","start":"2026-04-27T16:01:38.752487Z","end":"2026-04-27T16:01:39.199364Z","steps":["trace[1999438097] 'agreement among raft nodes before linearized reading' (duration: 446.012121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.199413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.752464Z","time spent":"446.937506ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T16:01:39.198711Z","caller":"traceutil/trace.go:171","msg":"trace[1242695674] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"473.208927ms","start":"2026-04-27T16:01:38.725491Z","end":"2026-04-27T16:01:39.1987Z","steps":["trace[1242695674] 'agreement among raft nodes before linearized reading' (duration: 473.158986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.199436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.976209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.199519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.72547Z","time spent":"474.0362ms","remote":"127.0.0.1:53724","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-04-27T16:01:39.198465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.948145ms","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-04-27T16:01:39.199572Z","caller":"traceutil/trace.go:171","msg":"trace[1895790365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"541.064534ms","start":"2026-04-27T16:01:38.65849Z","end":"2026-04-27T16:01:39.199555Z","steps":["trace[1895790365] 'agreement among raft nodes before linearized reading' (duration: 539.951514ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:39.199595Z","caller":"traceutil/trace.go:171","msg":"trace[250145285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"580.118033ms","start":"2026-04-27T16:01:38.619408Z","end":"2026-04-27T16:01:39.199527Z","steps":["trace[250145285] 'agreement among raft nodes before linearized reading' (duration: 579.949398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.830417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:01:39.19842Z","caller":"traceutil/trace.go:171","msg":"trace[1739535738] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"651.936988ms","start":"2026-04-27T16:01:38.546457Z","end":"2026-04-27T16:01:39.198394Z","steps":["trace[1739535738] 'process raft request' (duration: 651.042304ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:39.19967Z","caller":"traceutil/trace.go:171","msg":"trace[531668757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"545.778172ms","start":"2026-04-27T16:01:38.653881Z","end":"2026-04-27T16:01:39.199659Z","steps":["trace[531668757] 'agreement among raft nodes before linearized reading' (duration: 544.722494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.198305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.750265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.199709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.653862Z","time spent":"545.836734ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:01:39.198754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.29751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:01:39.199766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.619387Z","time spent":"580.240706ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T16:01:39.199828Z","caller":"traceutil/trace.go:171","msg":"trace[1475405079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"457.393479ms","start":"2026-04-27T16:01:38.742415Z","end":"2026-04-27T16:01:39.199808Z","steps":["trace[1475405079] 'agreement among raft nodes before linearized reading' (duration: 456.31543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.199572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.689715Z","time spent":"509.542212ms","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-04-27T16:01:39.198773Z","caller":"traceutil/trace.go:171","msg":"trace[1475042136] 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:631; }","duration":"491.650178ms","start":"2026-04-27T16:01:38.7071Z","end":"2026-04-27T16:01:39.19875Z","steps":["trace[1475042136] 'agreement among raft nodes before linearized reading' (duration: 491.579776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.200205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.70709Z","time spent":"493.094856ms","remote":"127.0.0.1:53714","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-04-27T16:01:39.200265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.742399Z","time spent":"457.644016ms","remote":"127.0.0.1:53728","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":"info","ts":"2026-04-27T16:01:39.19974Z","caller":"traceutil/trace.go:171","msg":"trace[1448890364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"457.312547ms","start":"2026-04-27T16:01:38.742414Z","end":"2026-04-27T16:01:39.199726Z","steps":["trace[1448890364] 'agreement among raft nodes before linearized reading' (duration: 455.684993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.200359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.742394Z","time spent":"457.948105ms","remote":"127.0.0.1:53728","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-04-27T16:01:39.199634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.658475Z","time spent":"541.140507ms","remote":"127.0.0.1:53700","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-04-27T16:01:39.199751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.546442Z","time spent":"653.233444ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:39.198829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.128887ms","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":"info","ts":"2026-04-27T16:01:39.200655Z","caller":"traceutil/trace.go:171","msg":"trace[2092426663] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"566.980607ms","start":"2026-04-27T16:01:38.63366Z","end":"2026-04-27T16:01:39.200641Z","steps":["trace[2092426663] 'agreement among raft nodes before linearized reading' (duration: 565.129527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.200704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.633643Z","time spent":"567.048749ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:01:39.198793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.218688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:39.200874Z","caller":"traceutil/trace.go:171","msg":"trace[1801850049] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:631; }","duration":"475.309105ms","start":"2026-04-27T16:01:38.725553Z","end":"2026-04-27T16:01:39.200862Z","steps":["trace[1801850049] 'agreement among raft nodes before linearized reading' (duration: 473.219838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:39.200918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:38.725547Z","time spent":"475.358586ms","remote":"127.0.0.1:53724","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-04-27T16:01:40.613641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:41.114066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:41.61461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:41.640529Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.388170873s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T16:01:41.640909Z","caller":"traceutil/trace.go:171","msg":"trace[1395180125] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.388693077s","start":"2026-04-27T16:01:39.252201Z","end":"2026-04-27T16:01:41.640894Z","steps":["trace[1395180125] 'process raft request' (duration: 2.388549073s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:41.64099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:39.252174Z","time spent":"2.388765329s","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:41.64118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528199053s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:41.641248Z","caller":"traceutil/trace.go:171","msg":"trace[1228032526] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"1.527873945s","start":"2026-04-27T16:01:40.112985Z","end":"2026-04-27T16:01:41.640859Z","steps":["trace[1228032526] 'read index received' (duration: 1.527656199s)","trace[1228032526] 'applied index is now lower than readState.Index' (duration: 217.066µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:41.641332Z","caller":"traceutil/trace.go:171","msg":"trace[2137125270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.528327447s","start":"2026-04-27T16:01:40.112932Z","end":"2026-04-27T16:01:41.641259Z","steps":["trace[2137125270] 'agreement among raft nodes before linearized reading' (duration: 1.52807776s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:41.641403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:40.112911Z","time spent":"1.528483992s","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T16:01:41.641447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.129761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:01:41.641469Z","caller":"traceutil/trace.go:171","msg":"trace[328978199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"397.170831ms","start":"2026-04-27T16:01:41.244291Z","end":"2026-04-27T16:01:41.641462Z","steps":["trace[328978199] 'agreement among raft nodes before linearized reading' (duration: 397.1105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:41.641491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.24428Z","time spent":"397.205593ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T16:01:41.641541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.858571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T16:01:41.641532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.685749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-27T16:01:41.641735Z","caller":"traceutil/trace.go:171","msg":"trace[1223368179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"396.913354ms","start":"2026-04-27T16:01:41.244802Z","end":"2026-04-27T16:01:41.641716Z","steps":["trace[1223368179] 'agreement among raft nodes before linearized reading' (duration: 396.581485ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:41.641587Z","caller":"traceutil/trace.go:171","msg":"trace[184783617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"417.935503ms","start":"2026-04-27T16:01:41.223637Z","end":"2026-04-27T16:01:41.641573Z","steps":["trace[184783617] 'agreement among raft nodes before linearized reading' (duration: 417.846211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:41.641791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.244791Z","time spent":"396.987537ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:01:41.641825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.223611Z","time spent":"418.205191ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:01:41.641685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.767621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:01:41.642013Z","caller":"traceutil/trace.go:171","msg":"trace[697183389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"622.100721ms","start":"2026-04-27T16:01:41.019886Z","end":"2026-04-27T16:01:41.641987Z","steps":["trace[697183389] 'agreement among raft nodes before linearized reading' (duration: 621.425662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:41.642123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.019859Z","time spent":"622.230634ms","remote":"127.0.0.1:46322","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":"warn","ts":"2026-04-27T16:01:42.063457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.053015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:01:42.063613Z","caller":"traceutil/trace.go:171","msg":"trace[866876847] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"418.920739ms","start":"2026-04-27T16:01:41.644675Z","end":"2026-04-27T16:01:42.063596Z","steps":["trace[866876847] 'process raft request' (duration: 126.662228ms)","trace[866876847] 'compare' (duration: 291.955453ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:01:42.063741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.644664Z","time spent":"419.044163ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:01:42.064034Z","caller":"traceutil/trace.go:171","msg":"trace[704965620] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"419.164706ms","start":"2026-04-27T16:01:41.644841Z","end":"2026-04-27T16:01:42.064005Z","steps":["trace[704965620] 'process raft request' (duration: 418.894149ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:42.064204Z","caller":"traceutil/trace.go:171","msg":"trace[2013213107] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"418.648912ms","start":"2026-04-27T16:01:41.645526Z","end":"2026-04-27T16:01:42.064175Z","steps":["trace[2013213107] 'process raft request' (duration: 418.402165ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:01:42.064253Z","caller":"traceutil/trace.go:171","msg":"trace[636285973] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"418.639352ms","start":"2026-04-27T16:01:41.645595Z","end":"2026-04-27T16:01:42.064234Z","steps":["trace[636285973] 'process raft request' (duration: 418.480648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.064342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.645517Z","time spent":"418.747225ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T16:01:42.064354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.645566Z","time spent":"418.738904ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:01:42.064573Z","caller":"traceutil/trace.go:171","msg":"trace[2026213011] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"418.497418ms","start":"2026-04-27T16:01:41.646066Z","end":"2026-04-27T16:01:42.064563Z","steps":["trace[2026213011] 'process raft request' (duration: 418.102307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.06468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.646057Z","time spent":"418.59743ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:01:42.064713Z","caller":"traceutil/trace.go:171","msg":"trace[290828072] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"418.497908ms","start":"2026-04-27T16:01:41.646199Z","end":"2026-04-27T16:01:42.064696Z","steps":["trace[290828072] 'process raft request' (duration: 418.272492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.064891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.646192Z","time spent":"418.673052ms","remote":"127.0.0.1:46292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:01:42.065046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.644833Z","time spent":"419.287489ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:01:42.065349Z","caller":"traceutil/trace.go:171","msg":"trace[683242064] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"417.403239ms","start":"2026-04-27T16:01:41.647921Z","end":"2026-04-27T16:01:42.065324Z","steps":["trace[683242064] 'process raft request' (duration: 416.738701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.06543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.647905Z","time spent":"417.48727ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T16:01:42.065953Z","caller":"traceutil/trace.go:171","msg":"trace[2014554729] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:659; }","duration":"414.453618ms","start":"2026-04-27T16:01:41.651481Z","end":"2026-04-27T16:01:42.065935Z","steps":["trace[2014554729] 'read index received' (duration: 119.854024ms)","trace[2014554729] 'applied index is now lower than readState.Index' (duration: 294.598494ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:42.066131Z","caller":"traceutil/trace.go:171","msg":"trace[1663438535] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"416.618077ms","start":"2026-04-27T16:01:41.649496Z","end":"2026-04-27T16:01:42.066114Z","steps":["trace[1663438535] 'process raft request' (duration: 415.333192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.066287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.649483Z","time spent":"416.772251ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T16:01:42.066052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.558661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:42.066567Z","caller":"traceutil/trace.go:171","msg":"trace[510963762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"415.101006ms","start":"2026-04-27T16:01:41.651454Z","end":"2026-04-27T16:01:42.066555Z","steps":["trace[510963762] 'agreement among raft nodes before linearized reading' (duration: 414.556611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:42.066682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:41.651441Z","time spent":"415.230989ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T16:01:47.35328Z","caller":"traceutil/trace.go:171","msg":"trace[1967784953] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"150.521509ms","start":"2026-04-27T16:01:47.202737Z","end":"2026-04-27T16:01:47.353258Z","steps":["trace[1967784953] 'process raft request' (duration: 150.375285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:58.612624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100885,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:59.113468Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958100885,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:01:59.417369Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.351354691s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T16:01:59.417764Z","caller":"traceutil/trace.go:171","msg":"trace[1085531322] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"1.306133982s","start":"2026-04-27T16:01:58.111602Z","end":"2026-04-27T16:01:59.417736Z","steps":["trace[1085531322] 'read index received' (duration: 1.305924136s)","trace[1085531322] 'applied index is now lower than readState.Index' (duration: 208.986µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:01:59.417887Z","caller":"traceutil/trace.go:171","msg":"trace[746439740] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.351946107s","start":"2026-04-27T16:01:58.065906Z","end":"2026-04-27T16:01:59.417852Z","steps":["trace[746439740] 'process raft request' (duration: 1.35168773s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.417966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.306335817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:01:59.418013Z","caller":"traceutil/trace.go:171","msg":"trace[381461972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"1.30644901s","start":"2026-04-27T16:01:58.111551Z","end":"2026-04-27T16:01:59.418Z","steps":["trace[381461972] 'agreement among raft nodes before linearized reading' (duration: 1.306312476s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.111534Z","time spent":"1.306496472s","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T16:01:59.418027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.241333193s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-27T16:01:59.418095Z","caller":"traceutil/trace.go:171","msg":"trace[1531498950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"1.241430906s","start":"2026-04-27T16:01:58.176646Z","end":"2026-04-27T16:01:59.418077Z","steps":["trace[1531498950] 'agreement among raft nodes before linearized reading' (duration: 1.241258871s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.176637Z","time spent":"1.241492947s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:01:59.418139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.24197368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-27T16:01:59.418189Z","caller":"traceutil/trace.go:171","msg":"trace[433994199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"1.242053962s","start":"2026-04-27T16:01:58.17612Z","end":"2026-04-27T16:01:59.418174Z","steps":["trace[433994199] 'agreement among raft nodes before linearized reading' (duration: 1.241944679s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124071471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-27T16:01:59.41822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.176098Z","time spent":"1.242114424s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-27T16:01:59.418239Z","caller":"traceutil/trace.go:171","msg":"trace[405596957] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:796; }","duration":"1.124156553s","start":"2026-04-27T16:01:58.294071Z","end":"2026-04-27T16:01:59.418228Z","steps":["trace[405596957] 'agreement among raft nodes before linearized reading' (duration: 1.123968368s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.294046Z","time spent":"1.124216294s","remote":"127.0.0.1:46040","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.74\" "} {"level":"warn","ts":"2026-04-27T16:01:59.41824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.246585765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T16:01:59.418315Z","caller":"traceutil/trace.go:171","msg":"trace[1122338243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"1.246729599s","start":"2026-04-27T16:01:58.171569Z","end":"2026-04-27T16:01:59.418299Z","steps":["trace[1122338243] 'agreement among raft nodes before linearized reading' (duration: 1.246479522s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.171543Z","time spent":"1.246802551s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T16:01:59.418385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252380001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T16:01:59.418412Z","caller":"traceutil/trace.go:171","msg":"trace[201872929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"1.252449324s","start":"2026-04-27T16:01:58.165955Z","end":"2026-04-27T16:01:59.418405Z","steps":["trace[201872929] 'agreement among raft nodes before linearized reading' (duration: 1.252360161s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.165936Z","time spent":"1.252491824s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T16:01:59.418025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269895923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-krn8b\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-27T16:01:59.418554Z","caller":"traceutil/trace.go:171","msg":"trace[1188924178] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-krn8b; range_end:; response_count:1; response_revision:796; }","duration":"1.27050048s","start":"2026-04-27T16:01:58.14804Z","end":"2026-04-27T16:01:59.41854Z","steps":["trace[1188924178] 'agreement among raft nodes before linearized reading' (duration: 1.269830252s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:01:59.418599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.148Z","time spent":"1.270586373s","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-krn8b\" "} {"level":"warn","ts":"2026-04-27T16:01:59.418612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:01:58.065883Z","time spent":"1.352118262s","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:35.758452Z","caller":"traceutil/trace.go:171","msg":"trace[720494418] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"110.024283ms","start":"2026-04-27T16:02:35.648407Z","end":"2026-04-27T16:02:35.758431Z","steps":["trace[720494418] 'process raft request' (duration: 109.741236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:47.17794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.895646ms","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:7"} {"level":"info","ts":"2026-04-27T16:03:47.178032Z","caller":"traceutil/trace.go:171","msg":"trace[237452720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1313; }","duration":"156.04685ms","start":"2026-04-27T16:03:47.02197Z","end":"2026-04-27T16:03:47.178016Z","steps":["trace[237452720] 'count revisions from in-memory index tree' (duration: 155.807614ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:50.73304Z","caller":"traceutil/trace.go:171","msg":"trace[648464908] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"137.338031ms","start":"2026-04-27T16:03:50.595663Z","end":"2026-04-27T16:03:50.733001Z","steps":["trace[648464908] 'process raft request' (duration: 137.027332ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:50.929673Z","caller":"traceutil/trace.go:171","msg":"trace[505795295] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"191.336953ms","start":"2026-04-27T16:03:50.738304Z","end":"2026-04-27T16:03:50.929641Z","steps":["trace[505795295] 'process raft request' (duration: 95.158653ms)","trace[505795295] 'compare' (duration: 95.967245ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:50.929923Z","caller":"traceutil/trace.go:171","msg":"trace[640909896] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"167.174097ms","start":"2026-04-27T16:03:50.762696Z","end":"2026-04-27T16:03:50.92987Z","steps":["trace[640909896] 'process raft request' (duration: 166.9082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:56.965183Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392974958102214,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T16:03:57.192822Z","caller":"traceutil/trace.go:171","msg":"trace[156276208] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"795.966995ms","start":"2026-04-27T16:03:56.39682Z","end":"2026-04-27T16:03:57.192787Z","steps":["trace[156276208] 'process raft request' (duration: 795.654447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.193023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.396782Z","time spent":"796.13911ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:57.235707Z","caller":"traceutil/trace.go:171","msg":"trace[742880498] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1401; }","duration":"770.750622ms","start":"2026-04-27T16:03:56.464929Z","end":"2026-04-27T16:03:57.23568Z","steps":["trace[742880498] 'read index received' (duration: 727.592739ms)","trace[742880498] 'applied index is now lower than readState.Index' (duration: 43.156333ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:57.235785Z","caller":"traceutil/trace.go:171","msg":"trace[37319878] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"288.008005ms","start":"2026-04-27T16:03:56.947733Z","end":"2026-04-27T16:03:57.235741Z","steps":["trace[37319878] 'process raft request' (duration: 287.791769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.236041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.685383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-27T16:03:57.236043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.340208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:03:57.236158Z","caller":"traceutil/trace.go:171","msg":"trace[1016158796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1348; }","duration":"122.510673ms","start":"2026-04-27T16:03:57.113631Z","end":"2026-04-27T16:03:57.236141Z","steps":["trace[1016158796] 'agreement among raft nodes before linearized reading' (duration: 122.339068ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:57.236124Z","caller":"traceutil/trace.go:171","msg":"trace[974845428] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1348; }","duration":"233.827857ms","start":"2026-04-27T16:03:57.002283Z","end":"2026-04-27T16:03:57.236111Z","steps":["trace[974845428] 'agreement among raft nodes before linearized reading' (duration: 233.703553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.236329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.221124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T16:03:57.236486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.653286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T16:03:57.236518Z","caller":"traceutil/trace.go:171","msg":"trace[1257113908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1348; }","duration":"771.525723ms","start":"2026-04-27T16:03:56.464855Z","end":"2026-04-27T16:03:57.23638Z","steps":["trace[1257113908] 'agreement among raft nodes before linearized reading' (duration: 770.974088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.236505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.003297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-04-27T16:03:57.23668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.232975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:03:57.236756Z","caller":"traceutil/trace.go:171","msg":"trace[1063192768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"768.347558ms","start":"2026-04-27T16:03:56.468398Z","end":"2026-04-27T16:03:57.236745Z","steps":["trace[1063192768] 'agreement among raft nodes before linearized reading' (duration: 768.141862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.236808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.468374Z","time spent":"768.42296ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T16:03:57.236675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.464811Z","time spent":"771.846811ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:03:57.236604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.966656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:14945"} {"level":"info","ts":"2026-04-27T16:03:57.23702Z","caller":"traceutil/trace.go:171","msg":"trace[1013539730] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1348; }","duration":"732.401798ms","start":"2026-04-27T16:03:56.504606Z","end":"2026-04-27T16:03:57.237008Z","steps":["trace[1013539730] 'agreement among raft nodes before linearized reading' (duration: 731.911725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.237083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.504595Z","time spent":"732.47829ms","remote":"127.0.0.1:46072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":14968,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-04-27T16:03:57.236575Z","caller":"traceutil/trace.go:171","msg":"trace[402303542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1348; }","duration":"768.78277ms","start":"2026-04-27T16:03:56.467772Z","end":"2026-04-27T16:03:57.236555Z","steps":["trace[402303542] 'agreement among raft nodes before linearized reading' (duration: 768.094131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.237303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.467756Z","time spent":"769.535019ms","remote":"127.0.0.1:46322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T16:03:57.23763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.274122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:03:57.237708Z","caller":"traceutil/trace.go:171","msg":"trace[187709450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"285.392515ms","start":"2026-04-27T16:03:56.952302Z","end":"2026-04-27T16:03:57.237695Z","steps":["trace[187709450] 'agreement among raft nodes before linearized reading' (duration: 285.228841ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:57.236702Z","caller":"traceutil/trace.go:171","msg":"trace[1771889538] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1348; }","duration":"732.245474ms","start":"2026-04-27T16:03:56.504418Z","end":"2026-04-27T16:03:57.236663Z","steps":["trace[1771889538] 'agreement among raft nodes before linearized reading' (duration: 731.983627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:57.239179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:56.504406Z","time spent":"734.759941ms","remote":"127.0.0.1:46080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-04-27T16:04:03.512521Z","caller":"traceutil/trace.go:171","msg":"trace[1043479468] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"249.890525ms","start":"2026-04-27T16:04:03.262599Z","end":"2026-04-27T16:04:03.51249Z","steps":["trace[1043479468] 'process raft request' (duration: 249.679489ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:03.526337Z","caller":"traceutil/trace.go:171","msg":"trace[1883439259] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"186.360668ms","start":"2026-04-27T16:04:03.339941Z","end":"2026-04-27T16:04:03.526302Z","steps":["trace[1883439259] 'process raft request' (duration: 174.658185ms)","trace[1883439259] 'compare' (duration: 11.388765ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:04:03.621076Z","caller":"traceutil/trace.go:171","msg":"trace[1900152312] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1428; }","duration":"223.783928ms","start":"2026-04-27T16:04:03.397255Z","end":"2026-04-27T16:04:03.621039Z","steps":["trace[1900152312] 'read index received' (duration: 115.065763ms)","trace[1900152312] 'applied index is now lower than readState.Index' (duration: 108.712274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:04:03.621482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.191769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T16:04:03.621559Z","caller":"traceutil/trace.go:171","msg":"trace[331916915] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1373; }","duration":"224.346083ms","start":"2026-04-27T16:04:03.397191Z","end":"2026-04-27T16:04:03.621537Z","steps":["trace[331916915] 'agreement among raft nodes before linearized reading' (duration: 224.039285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:03.621585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.683202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T16:04:03.621629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.543098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-27T16:04:03.621623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.097398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T16:04:03.621689Z","caller":"traceutil/trace.go:171","msg":"trace[304328351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1373; }","duration":"218.818495ms","start":"2026-04-27T16:04:03.402841Z","end":"2026-04-27T16:04:03.62166Z","steps":["trace[304328351] 'agreement among raft nodes before linearized reading' (duration: 218.448895ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:03.621723Z","caller":"traceutil/trace.go:171","msg":"trace[89990824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1373; }","duration":"218.787654ms","start":"2026-04-27T16:04:03.402914Z","end":"2026-04-27T16:04:03.621701Z","steps":["trace[89990824] 'agreement among raft nodes before linearized reading' (duration: 218.493066ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:03.621745Z","caller":"traceutil/trace.go:171","msg":"trace[1066373643] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1373; }","duration":"193.291053ms","start":"2026-04-27T16:04:03.428429Z","end":"2026-04-27T16:04:03.62172Z","steps":["trace[1066373643] 'agreement among raft nodes before linearized reading' (duration: 192.887162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:03.900659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.71173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:04:03.900979Z","caller":"traceutil/trace.go:171","msg":"trace[25355664] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1432; }","duration":"168.767358ms","start":"2026-04-27T16:04:03.732185Z","end":"2026-04-27T16:04:03.900953Z","steps":["trace[25355664] 'read index received' (duration: 64.539614ms)","trace[25355664] 'applied index is now lower than readState.Index' (duration: 104.226124ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:04:03.901122Z","caller":"traceutil/trace.go:171","msg":"trace[314062947] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"272.235791ms","start":"2026-04-27T16:04:03.628869Z","end":"2026-04-27T16:04:03.901105Z","steps":["trace[314062947] 'process raft request' (duration: 167.898814ms)","trace[314062947] 'compare' (duration: 103.513455ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:04:03.901595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.046593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:3548"} {"level":"info","ts":"2026-04-27T16:04:03.901647Z","caller":"traceutil/trace.go:171","msg":"trace[1464521699] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:1377; }","duration":"124.160286ms","start":"2026-04-27T16:04:03.777474Z","end":"2026-04-27T16:04:03.901634Z","steps":["trace[1464521699] 'agreement among raft nodes before linearized reading' (duration: 124.057054ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:03.901715Z","caller":"traceutil/trace.go:171","msg":"trace[2115630340] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"272.025036ms","start":"2026-04-27T16:04:03.629667Z","end":"2026-04-27T16:04:03.901692Z","steps":["trace[2115630340] 'process raft request' (duration: 271.137742ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:03.901839Z","caller":"traceutil/trace.go:171","msg":"trace[1726444715] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"270.540767ms","start":"2026-04-27T16:04:03.631286Z","end":"2026-04-27T16:04:03.901827Z","steps":["trace[1726444715] 'process raft request' (duration: 269.597731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:03.901835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.612631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:500 ","response":"range_response_count:54 size:39220"} {"level":"info","ts":"2026-04-27T16:04:03.90192Z","caller":"traceutil/trace.go:171","msg":"trace[1527226498] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:54; response_revision:1377; }","duration":"169.758715ms","start":"2026-04-27T16:04:03.73214Z","end":"2026-04-27T16:04:03.901898Z","steps":["trace[1527226498] 'agreement among raft nodes before linearized reading' (duration: 169.187489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:04:03.902207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.809279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5547"} {"level":"info","ts":"2026-04-27T16:04:03.902249Z","caller":"traceutil/trace.go:171","msg":"trace[505572723] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1377; }","duration":"165.891071ms","start":"2026-04-27T16:04:03.736346Z","end":"2026-04-27T16:04:03.902237Z","steps":["trace[505572723] 'agreement among raft nodes before linearized reading' (duration: 165.044348ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:27.826111Z","caller":"traceutil/trace.go:171","msg":"trace[1808202264] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"118.965746ms","start":"2026-04-27T16:04:27.707109Z","end":"2026-04-27T16:04:27.826075Z","steps":["trace[1808202264] 'process raft request' (duration: 118.72476ms)"],"step_count":1}