{"level":"warn","ts":"2026-04-07T09:38:19.189282Z","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-07T09:38:19.1895Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T09:38:19.189614Z","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-07T09:38:19.189634Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-07T09:38:19.189658Z","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-07T09:38:19.190648Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-07T09:38:19.190763Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T09:38:19.198908Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.871906ms"} {"level":"info","ts":"2026-04-07T09:38:19.212714Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-07T09:38:19.212845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T09:38:19.213099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-07T09:38:19.213126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T09:38:19.213139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-07T09:38:19.213265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-07T09:38:19.2204Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T09:38:19.222996Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T09:38:19.224039Z","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-07T09:38:19.225863Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T09:38:19.225982Z","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-07T09:38:19.226075Z","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-07T09:38:19.226089Z","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-07T09:38:19.228473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-07T09:38:19.226142Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T09:38:19.229635Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-07T09:38:19.231292Z","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-07T09:38:19.231353Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-07T09:38:19.231379Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-07T09:38:19.231583Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T09:38:19.231617Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T09:38:19.414326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T09:38:19.414393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T09:38:19.414416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-07T09:38:19.41444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-07T09:38:19.414452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-07T09:38:19.414476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-07T09:38:19.414491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-07T09:38:19.415797Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:38:19.416681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:38:19.416681Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T09:38:19.417365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:38:19.417459Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:38:19.417485Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:38:19.417497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:38:19.417565Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T09:38:19.417582Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T09:38:19.419237Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-07T09:38:19.420123Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-07T09:38:25.537886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.005163694s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:38:25.538159Z","caller":"traceutil/trace.go:171","msg":"trace[1272272373] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"1.86687261s","start":"2026-04-07T09:38:23.671268Z","end":"2026-04-07T09:38:25.53814Z","steps":["trace[1272272373] 'process raft request' (duration: 1.866800999s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:25.538191Z","caller":"traceutil/trace.go:171","msg":"trace[1622788372] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"2.067244538s","start":"2026-04-07T09:38:23.470891Z","end":"2026-04-07T09:38:25.538136Z","steps":["trace[1622788372] 'process raft request' (duration: 61.076897ms)","trace[1622788372] 'compare' (duration: 2.004783292s)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:25.538237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:23.67119Z","time spent":"1.867017851s","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:25.538285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:23.470871Z","time spent":"2.067365428s","remote":"127.0.0.1:53710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:25.690025Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.262355791s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T09:38:25.69493Z","caller":"traceutil/trace.go:171","msg":"trace[864743666] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"1.753694401s","start":"2026-04-07T09:38:23.941189Z","end":"2026-04-07T09:38:25.694884Z","steps":["trace[864743666] 'process raft request' (duration: 1.74912992s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:25.694938Z","caller":"traceutil/trace.go:171","msg":"trace[1119796778] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"151.372207ms","start":"2026-04-07T09:38:25.543529Z","end":"2026-04-07T09:38:25.694901Z","steps":["trace[1119796778] 'process raft request' (duration: 151.261136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:25.6951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:23.941159Z","time spent":"1.753845122s","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:25.69523Z","caller":"traceutil/trace.go:171","msg":"trace[1690804819] linearizableReadLoop","detail":"{readStateIndex:207; appliedIndex:204; }","duration":"1.597287789s","start":"2026-04-07T09:38:24.09793Z","end":"2026-04-07T09:38:25.695218Z","steps":["trace[1690804819] 'read index received' (duration: 329.698343ms)","trace[1690804819] 'applied index is now lower than readState.Index' (duration: 1.267588236s)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:25.695505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159307424s","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-07T09:38:25.695568Z","caller":"traceutil/trace.go:171","msg":"trace[488954261] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:204; }","duration":"1.159457904s","start":"2026-04-07T09:38:24.536096Z","end":"2026-04-07T09:38:25.695554Z","steps":["trace[488954261] 'agreement among raft nodes before linearized reading' (duration: 1.159322363s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:25.695606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:24.536063Z","time spent":"1.159532985s","remote":"127.0.0.1:53662","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":"warn","ts":"2026-04-07T09:38:25.695545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.519154ms","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-07T09:38:25.695491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59753244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:38:25.696038Z","caller":"traceutil/trace.go:171","msg":"trace[254563497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:204; }","duration":"393.934196ms","start":"2026-04-07T09:38:25.301922Z","end":"2026-04-07T09:38:25.695856Z","steps":["trace[254563497] 'agreement among raft nodes before linearized reading' (duration: 393.503943ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:25.696065Z","caller":"traceutil/trace.go:171","msg":"trace[132264152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:204; }","duration":"1.598179894s","start":"2026-04-07T09:38:24.097852Z","end":"2026-04-07T09:38:25.696032Z","steps":["trace[132264152] 'agreement among raft nodes before linearized reading' (duration: 1.59750352s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:25.696152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:24.097821Z","time spent":"1.598314545s","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:38:25.696155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:25.301891Z","time spent":"394.211088ms","remote":"127.0.0.1:53662","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":"info","ts":"2026-04-07T09:38:27.483128Z","caller":"traceutil/trace.go:171","msg":"trace[1535514804] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"273.792861ms","start":"2026-04-07T09:38:27.209314Z","end":"2026-04-07T09:38:27.483107Z","steps":["trace[1535514804] 'process raft request' (duration: 273.6251ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483103Z","caller":"traceutil/trace.go:171","msg":"trace[646583650] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"312.760079ms","start":"2026-04-07T09:38:27.170291Z","end":"2026-04-07T09:38:27.483051Z","steps":["trace[646583650] 'process raft request' (duration: 302.840864ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483238Z","caller":"traceutil/trace.go:171","msg":"trace[1080429954] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"257.129631ms","start":"2026-04-07T09:38:27.226058Z","end":"2026-04-07T09:38:27.483187Z","steps":["trace[1080429954] 'process raft request' (duration: 256.93432ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483327Z","caller":"traceutil/trace.go:171","msg":"trace[1093675359] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"141.452026ms","start":"2026-04-07T09:38:27.341861Z","end":"2026-04-07T09:38:27.483313Z","steps":["trace[1093675359] 'process raft request' (duration: 141.222784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:27.483329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:27.170262Z","time spent":"312.96872ms","remote":"127.0.0.1:53602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:27.483398Z","caller":"traceutil/trace.go:171","msg":"trace[2084340054] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:297; }","duration":"257.925357ms","start":"2026-04-07T09:38:27.225429Z","end":"2026-04-07T09:38:27.483354Z","steps":["trace[2084340054] 'read index received' (duration: 247.809071ms)","trace[2084340054] 'applied index is now lower than readState.Index' (duration: 10.115146ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:38:27.483515Z","caller":"traceutil/trace.go:171","msg":"trace[314496869] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"141.361355ms","start":"2026-04-07T09:38:27.342146Z","end":"2026-04-07T09:38:27.483508Z","steps":["trace[314496869] 'process raft request' (duration: 141.009503ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483568Z","caller":"traceutil/trace.go:171","msg":"trace[2062332940] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"163.18937ms","start":"2026-04-07T09:38:27.320366Z","end":"2026-04-07T09:38:27.483556Z","steps":["trace[2062332940] 'process raft request' (duration: 162.676906ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483669Z","caller":"traceutil/trace.go:171","msg":"trace[1393015308] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"141.386636ms","start":"2026-04-07T09:38:27.342273Z","end":"2026-04-07T09:38:27.48366Z","steps":["trace[1393015308] 'process raft request' (duration: 140.926122ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483479Z","caller":"traceutil/trace.go:171","msg":"trace[1426279871] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"140.623481ms","start":"2026-04-07T09:38:27.342841Z","end":"2026-04-07T09:38:27.483465Z","steps":["trace[1426279871] 'process raft request' (duration: 140.386179ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483819Z","caller":"traceutil/trace.go:171","msg":"trace[42751723] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"140.712332ms","start":"2026-04-07T09:38:27.343096Z","end":"2026-04-07T09:38:27.483808Z","steps":["trace[42751723] 'process raft request' (duration: 140.177477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:27.483897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.687382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-04-07T09:38:27.483897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.450221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:38:27.483936Z","caller":"traceutil/trace.go:171","msg":"trace[374294559] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:296; }","duration":"255.746993ms","start":"2026-04-07T09:38:27.228176Z","end":"2026-04-07T09:38:27.483923Z","steps":["trace[374294559] 'agreement among raft nodes before linearized reading' (duration: 255.624773ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:27.483938Z","caller":"traceutil/trace.go:171","msg":"trace[673674625] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:296; }","duration":"258.546531ms","start":"2026-04-07T09:38:27.22538Z","end":"2026-04-07T09:38:27.483927Z","steps":["trace[673674625] 'agreement among raft nodes before linearized reading' (duration: 258.461741ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:38.907969Z","caller":"traceutil/trace.go:171","msg":"trace[400787371] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"118.096428ms","start":"2026-04-07T09:38:38.789839Z","end":"2026-04-07T09:38:38.907935Z","steps":["trace[400787371] 'read index received' (duration: 71.680011ms)","trace[400787371] 'applied index is now lower than readState.Index' (duration: 46.415047ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:38:38.908042Z","caller":"traceutil/trace.go:171","msg":"trace[1878426129] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"137.127585ms","start":"2026-04-07T09:38:38.770854Z","end":"2026-04-07T09:38:38.907981Z","steps":["trace[1878426129] 'process raft request' (duration: 90.805269ms)","trace[1878426129] 'compare' (duration: 46.090605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:38.908257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.628691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-04-07T09:38:38.90832Z","caller":"traceutil/trace.go:171","msg":"trace[118880884] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:427; }","duration":"134.758601ms","start":"2026-04-07T09:38:38.77355Z","end":"2026-04-07T09:38:38.908309Z","steps":["trace[118880884] 'agreement among raft nodes before linearized reading' (duration: 134.51721ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:38.910102Z","caller":"traceutil/trace.go:171","msg":"trace[1807330041] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"118.083318ms","start":"2026-04-07T09:38:38.791978Z","end":"2026-04-07T09:38:38.910061Z","steps":["trace[1807330041] 'process raft request' (duration: 117.910277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.377103Z","caller":"traceutil/trace.go:171","msg":"trace[883117589] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"550.580974ms","start":"2026-04-07T09:38:52.826491Z","end":"2026-04-07T09:38:53.377072Z","steps":["trace[883117589] 'process raft request' (duration: 550.407233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.377384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.82646Z","time spent":"550.745335ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.463261Z","caller":"traceutil/trace.go:171","msg":"trace[323148744] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"620.591437ms","start":"2026-04-07T09:38:52.842617Z","end":"2026-04-07T09:38:53.463209Z","steps":["trace[323148744] 'process raft request' (duration: 620.177774ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.46342Z","caller":"traceutil/trace.go:171","msg":"trace[1218915213] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"635.096821ms","start":"2026-04-07T09:38:52.828315Z","end":"2026-04-07T09:38:53.463412Z","steps":["trace[1218915213] 'process raft request' (duration: 634.240785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.463545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.842605Z","time spent":"620.819829ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.463537Z","caller":"traceutil/trace.go:171","msg":"trace[1621761788] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"618.725196ms","start":"2026-04-07T09:38:52.844778Z","end":"2026-04-07T09:38:53.463503Z","steps":["trace[1621761788] 'process raft request' (duration: 618.075862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.463664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.828281Z","time spent":"635.197271ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:53.463686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.84477Z","time spent":"618.848977ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.463803Z","caller":"traceutil/trace.go:171","msg":"trace[1906806758] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"623.875856ms","start":"2026-04-07T09:38:52.839913Z","end":"2026-04-07T09:38:53.463789Z","steps":["trace[1906806758] 'process raft request' (duration: 622.826909ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.463243Z","caller":"traceutil/trace.go:171","msg":"trace[825444044] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"623.342043ms","start":"2026-04-07T09:38:52.839846Z","end":"2026-04-07T09:38:53.463188Z","steps":["trace[825444044] 'process raft request' (duration: 622.767389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.46386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.83991Z","time spent":"623.923586ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:53.463871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.839824Z","time spent":"624.017567ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.463386Z","caller":"traceutil/trace.go:171","msg":"trace[282575958] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"635.720904ms","start":"2026-04-07T09:38:52.827654Z","end":"2026-04-07T09:38:53.463375Z","steps":["trace[282575958] 'process raft request' (duration: 634.748468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.464048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.827647Z","time spent":"636.372398ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.464296Z","caller":"traceutil/trace.go:171","msg":"trace[1589534767] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"615.662228ms","start":"2026-04-07T09:38:52.848618Z","end":"2026-04-07T09:38:53.46428Z","steps":["trace[1589534767] 'process raft request' (duration: 614.34891ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.464367Z","caller":"traceutil/trace.go:171","msg":"trace[415979481] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"613.739497ms","start":"2026-04-07T09:38:52.850614Z","end":"2026-04-07T09:38:53.464354Z","steps":["trace[415979481] 'process raft request' (duration: 613.442465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.464374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.848543Z","time spent":"615.796959ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:53.46442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.850603Z","time spent":"613.794967ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.464537Z","caller":"traceutil/trace.go:171","msg":"trace[762528600] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"610.242006ms","start":"2026-04-07T09:38:52.85428Z","end":"2026-04-07T09:38:53.464522Z","steps":["trace[762528600] 'process raft request' (duration: 609.916595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.464949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.854268Z","time spent":"610.611968ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.465515Z","caller":"traceutil/trace.go:171","msg":"trace[934284781] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:531; }","duration":"291.909231ms","start":"2026-04-07T09:38:53.173591Z","end":"2026-04-07T09:38:53.4655Z","steps":["trace[934284781] 'read index received' (duration: 202.837569ms)","trace[934284781] 'applied index is now lower than readState.Index' (duration: 89.070412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:53.465691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.105002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T09:38:53.465766Z","caller":"traceutil/trace.go:171","msg":"trace[366469382] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:524; }","duration":"292.244322ms","start":"2026-04-07T09:38:53.173511Z","end":"2026-04-07T09:38:53.465755Z","steps":["trace[366469382] 'agreement among raft nodes before linearized reading' (duration: 292.045851ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.465979Z","caller":"traceutil/trace.go:171","msg":"trace[643145335] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"590.181731ms","start":"2026-04-07T09:38:52.87576Z","end":"2026-04-07T09:38:53.465942Z","steps":["trace[643145335] 'process raft request' (duration: 589.355416ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.466019Z","caller":"traceutil/trace.go:171","msg":"trace[631666095] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"445.319323ms","start":"2026-04-07T09:38:53.020663Z","end":"2026-04-07T09:38:53.465982Z","steps":["trace[631666095] 'process raft request' (duration: 444.712049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:53.466221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:52.875745Z","time spent":"590.395392ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:38:53.466303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:53.020616Z","time spent":"445.646575ms","remote":"127.0.0.1:53450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:38:53.576908Z","caller":"traceutil/trace.go:171","msg":"trace[439932318] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"191.728153ms","start":"2026-04-07T09:38:53.385142Z","end":"2026-04-07T09:38:53.57687Z","steps":["trace[439932318] 'process raft request' (duration: 187.159117ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.576989Z","caller":"traceutil/trace.go:171","msg":"trace[1037183654] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"189.140459ms","start":"2026-04-07T09:38:53.387811Z","end":"2026-04-07T09:38:53.576951Z","steps":["trace[1037183654] 'process raft request' (duration: 188.953438ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.577218Z","caller":"traceutil/trace.go:171","msg":"trace[1804896388] transaction","detail":"{read_only:false; number_of_response:1; response_revision:526; }","duration":"188.727566ms","start":"2026-04-07T09:38:53.388453Z","end":"2026-04-07T09:38:53.577181Z","steps":["trace[1804896388] 'process raft request' (duration: 188.552445ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.581458Z","caller":"traceutil/trace.go:171","msg":"trace[1381048945] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"104.490812ms","start":"2026-04-07T09:38:53.476953Z","end":"2026-04-07T09:38:53.581444Z","steps":["trace[1381048945] 'process raft request' (duration: 104.11396ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.581616Z","caller":"traceutil/trace.go:171","msg":"trace[1755150504] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"104.2231ms","start":"2026-04-07T09:38:53.477385Z","end":"2026-04-07T09:38:53.581609Z","steps":["trace[1755150504] 'process raft request' (duration: 103.987809ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.58171Z","caller":"traceutil/trace.go:171","msg":"trace[1341552467] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"104.405611ms","start":"2026-04-07T09:38:53.477298Z","end":"2026-04-07T09:38:53.581703Z","steps":["trace[1341552467] 'process raft request' (duration: 104.048249ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.581877Z","caller":"traceutil/trace.go:171","msg":"trace[1571722846] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"104.36074ms","start":"2026-04-07T09:38:53.477509Z","end":"2026-04-07T09:38:53.58187Z","steps":["trace[1571722846] 'process raft request' (duration: 103.901218ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.582236Z","caller":"traceutil/trace.go:171","msg":"trace[10046142] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"103.164944ms","start":"2026-04-07T09:38:53.479049Z","end":"2026-04-07T09:38:53.582214Z","steps":["trace[10046142] 'process raft request' (duration: 102.552991ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:53.58246Z","caller":"traceutil/trace.go:171","msg":"trace[351252407] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"102.269878ms","start":"2026-04-07T09:38:53.48018Z","end":"2026-04-07T09:38:53.582449Z","steps":["trace[351252407] 'process raft request' (duration: 101.461944ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:59.591305Z","caller":"traceutil/trace.go:171","msg":"trace[385484929] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"171.094394ms","start":"2026-04-07T09:38:59.420179Z","end":"2026-04-07T09:38:59.591274Z","steps":["trace[385484929] 'read index received' (duration: 170.078747ms)","trace[385484929] 'applied index is now lower than readState.Index' (duration: 1.014497ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:59.59148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.27027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:38:59.591567Z","caller":"traceutil/trace.go:171","msg":"trace[967457465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"171.377674ms","start":"2026-04-07T09:38:59.420171Z","end":"2026-04-07T09:38:59.591549Z","steps":["trace[967457465] 'agreement among raft nodes before linearized reading' (duration: 171.214518ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:59.59199Z","caller":"traceutil/trace.go:171","msg":"trace[1680461553] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"905.546012ms","start":"2026-04-07T09:38:58.685796Z","end":"2026-04-07T09:38:59.591342Z","steps":["trace[1680461553] 'process raft request' (duration: 904.797835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:59.592278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:58.685754Z","time spent":"906.267258ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:39:00.04848Z","caller":"traceutil/trace.go:171","msg":"trace[1989371354] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"125.859604ms","start":"2026-04-07T09:38:59.922584Z","end":"2026-04-07T09:39:00.048444Z","steps":["trace[1989371354] 'read index received' (duration: 125.700169ms)","trace[1989371354] 'applied index is now lower than readState.Index' (duration: 157.655µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:39:00.048935Z","caller":"traceutil/trace.go:171","msg":"trace[15952602] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"127.792446ms","start":"2026-04-07T09:38:59.921125Z","end":"2026-04-07T09:39:00.048918Z","steps":["trace[15952602] 'process raft request' (duration: 127.156502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.049344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.729957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:39:00.049399Z","caller":"traceutil/trace.go:171","msg":"trace[2114880248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"126.82609ms","start":"2026-04-07T09:38:59.922556Z","end":"2026-04-07T09:39:00.049382Z","steps":["trace[2114880248] 'agreement among raft nodes before linearized reading' (duration: 126.593582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.049522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.292754ms","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-07T09:39:00.049715Z","caller":"traceutil/trace.go:171","msg":"trace[697720318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"104.551164ms","start":"2026-04-07T09:38:59.945136Z","end":"2026-04-07T09:39:00.049688Z","steps":["trace[697720318] 'agreement among raft nodes before linearized reading' (duration: 104.120978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.259881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.33072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:39:00.260176Z","caller":"traceutil/trace.go:171","msg":"trace[55896530] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"206.684174ms","start":"2026-04-07T09:39:00.053456Z","end":"2026-04-07T09:39:00.26014Z","steps":["trace[55896530] 'process raft request' (duration: 53.728081ms)","trace[55896530] 'compare' (duration: 152.144704ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:39:00.260429Z","caller":"traceutil/trace.go:171","msg":"trace[1915036913] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"205.192309ms","start":"2026-04-07T09:39:00.055139Z","end":"2026-04-07T09:39:00.260331Z","steps":["trace[1915036913] 'process raft request' (duration: 204.890938ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.260202Z","caller":"traceutil/trace.go:171","msg":"trace[1774604232] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"204.777585ms","start":"2026-04-07T09:39:00.055398Z","end":"2026-04-07T09:39:00.260176Z","steps":["trace[1774604232] 'process raft request' (duration: 204.700542ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.285757Z","caller":"traceutil/trace.go:171","msg":"trace[1960092137] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"147.918338ms","start":"2026-04-07T09:39:00.137817Z","end":"2026-04-07T09:39:00.285735Z","steps":["trace[1960092137] 'read index received' (duration: 146.917272ms)","trace[1960092137] 'applied index is now lower than readState.Index' (duration: 1.000066ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:00.286144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.288242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.286235Z","caller":"traceutil/trace.go:171","msg":"trace[594628921] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"179.270678ms","start":"2026-04-07T09:39:00.106921Z","end":"2026-04-07T09:39:00.286192Z","steps":["trace[594628921] 'process raft request' (duration: 178.150307ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.286305Z","caller":"traceutil/trace.go:171","msg":"trace[1506009905] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"148.433577ms","start":"2026-04-07T09:39:00.137762Z","end":"2026-04-07T09:39:00.286195Z","steps":["trace[1506009905] 'agreement among raft nodes before linearized reading' (duration: 148.297782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.286418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.156188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.286564Z","caller":"traceutil/trace.go:171","msg":"trace[120843662] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"148.432677ms","start":"2026-04-07T09:39:00.13811Z","end":"2026-04-07T09:39:00.286543Z","steps":["trace[120843662] 'agreement among raft nodes before linearized reading' (duration: 148.076374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.286662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.071104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.286728Z","caller":"traceutil/trace.go:171","msg":"trace[1392691878] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"148.548881ms","start":"2026-04-07T09:39:00.138165Z","end":"2026-04-07T09:39:00.286714Z","steps":["trace[1392691878] 'agreement among raft nodes before linearized reading' (duration: 148.067904ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.764561Z","caller":"traceutil/trace.go:171","msg":"trace[190389133] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"408.803602ms","start":"2026-04-07T09:39:00.355733Z","end":"2026-04-07T09:39:00.764536Z","steps":["trace[190389133] 'process raft request' (duration: 408.600964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.764935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.355693Z","time spent":"408.954968ms","remote":"127.0.0.1:53722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:39:00.765188Z","caller":"traceutil/trace.go:171","msg":"trace[1854797325] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:650; }","duration":"407.12729ms","start":"2026-04-07T09:39:00.358024Z","end":"2026-04-07T09:39:00.765151Z","steps":["trace[1854797325] 'read index received' (duration: 407.11511ms)","trace[1854797325] 'applied index is now lower than readState.Index' (duration: 10.16µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:00.765471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.39852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.765532Z","caller":"traceutil/trace.go:171","msg":"trace[582110955] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:622; }","duration":"407.511454ms","start":"2026-04-07T09:39:00.358007Z","end":"2026-04-07T09:39:00.765518Z","steps":["trace[582110955] 'agreement among raft nodes before linearized reading' (duration: 407.315206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.765577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.357998Z","time spent":"407.568646ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:39:00.851578Z","caller":"traceutil/trace.go:171","msg":"trace[77935] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"491.05518ms","start":"2026-04-07T09:39:00.360494Z","end":"2026-04-07T09:39:00.851549Z","steps":["trace[77935] 'process raft request' (duration: 490.758929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.851755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.360477Z","time spent":"491.181085ms","remote":"127.0.0.1:53594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:39:00.851902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.077463ms","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-07T09:39:00.851943Z","caller":"traceutil/trace.go:171","msg":"trace[1823145277] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:623; }","duration":"127.166536ms","start":"2026-04-07T09:39:00.724766Z","end":"2026-04-07T09:39:00.851932Z","steps":["trace[1823145277] 'agreement among raft nodes before linearized reading' (duration: 127.100044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.852139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.687069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.852178Z","caller":"traceutil/trace.go:171","msg":"trace[417380316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"465.748861ms","start":"2026-04-07T09:39:00.38642Z","end":"2026-04-07T09:39:00.852169Z","steps":["trace[417380316] 'agreement among raft nodes before linearized reading' (duration: 465.690519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.852209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.386407Z","time spent":"465.793552ms","remote":"127.0.0.1:43396","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:39:00.852279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.378475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:00.852189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.720212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:00.852505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.796597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:00.852534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.33601ms","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":"warn","ts":"2026-04-07T09:39:00.85255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.367341ms","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-07T09:39:00.852603Z","caller":"traceutil/trace.go:171","msg":"trace[1596202518] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:623; }","duration":"128.398912ms","start":"2026-04-07T09:39:00.724163Z","end":"2026-04-07T09:39:00.852561Z","steps":["trace[1596202518] 'agreement among raft nodes before linearized reading' (duration: 128.309599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.852516Z","caller":"traceutil/trace.go:171","msg":"trace[1800133745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"317.126527ms","start":"2026-04-07T09:39:00.535364Z","end":"2026-04-07T09:39:00.85249Z","steps":["trace[1800133745] 'agreement among raft nodes before linearized reading' (duration: 316.599978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.852682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.62999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.852674Z","caller":"traceutil/trace.go:171","msg":"trace[346090952] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"155.563428ms","start":"2026-04-07T09:39:00.697085Z","end":"2026-04-07T09:39:00.852648Z","steps":["trace[346090952] 'agreement among raft nodes before linearized reading' (duration: 155.298729ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.852715Z","caller":"traceutil/trace.go:171","msg":"trace[693926027] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:623; }","duration":"494.691473ms","start":"2026-04-07T09:39:00.358014Z","end":"2026-04-07T09:39:00.852706Z","steps":["trace[693926027] 'agreement among raft nodes before linearized reading' (duration: 494.636231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.852757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.357999Z","time spent":"494.748935ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:39:00.85276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.535344Z","time spent":"317.393397ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:39:00.852666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.178013ms","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-07T09:39:00.852433Z","caller":"traceutil/trace.go:171","msg":"trace[604158956] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"154.581183ms","start":"2026-04-07T09:39:00.697801Z","end":"2026-04-07T09:39:00.852382Z","steps":["trace[604158956] 'agreement among raft nodes before linearized reading' (duration: 154.188309ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.853006Z","caller":"traceutil/trace.go:171","msg":"trace[277862800] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:623; }","duration":"128.694893ms","start":"2026-04-07T09:39:00.72421Z","end":"2026-04-07T09:39:00.852905Z","steps":["trace[277862800] 'agreement among raft nodes before linearized reading' (duration: 128.181034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.852461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.140785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:00.853157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.935471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:00.85315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.619985ms","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-07T09:39:00.853198Z","caller":"traceutil/trace.go:171","msg":"trace[303939013] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"156.013556ms","start":"2026-04-07T09:39:00.697168Z","end":"2026-04-07T09:39:00.853182Z","steps":["trace[303939013] 'agreement among raft nodes before linearized reading' (duration: 155.922012ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:00.853224Z","caller":"traceutil/trace.go:171","msg":"trace[1126795255] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"317.7284ms","start":"2026-04-07T09:39:00.535478Z","end":"2026-04-07T09:39:00.853207Z","steps":["trace[1126795255] 'agreement among raft nodes before linearized reading' (duration: 317.593154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.853272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.535448Z","time spent":"317.812113ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:39:00.853191Z","caller":"traceutil/trace.go:171","msg":"trace[1619951242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"466.913464ms","start":"2026-04-07T09:39:00.386266Z","end":"2026-04-07T09:39:00.85318Z","steps":["trace[1619951242] 'agreement among raft nodes before linearized reading' (duration: 466.171526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.85344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.386248Z","time spent":"467.176314ms","remote":"127.0.0.1:43396","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:39:00.852414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.055923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:00.853512Z","caller":"traceutil/trace.go:171","msg":"trace[1715243471] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"467.151473ms","start":"2026-04-07T09:39:00.386346Z","end":"2026-04-07T09:39:00.853497Z","steps":["trace[1715243471] 'agreement among raft nodes before linearized reading' (duration: 466.037842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.853565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.386329Z","time spent":"467.219805ms","remote":"127.0.0.1:43396","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:39:00.852621Z","caller":"traceutil/trace.go:171","msg":"trace[1096308654] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:623; }","duration":"491.931531ms","start":"2026-04-07T09:39:00.360676Z","end":"2026-04-07T09:39:00.852608Z","steps":["trace[1096308654] 'agreement among raft nodes before linearized reading' (duration: 491.804396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:00.85368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:00.36067Z","time spent":"492.996372ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:39:01.783019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986421687202599505,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T09:39:02.221168Z","caller":"traceutil/trace.go:171","msg":"trace[1542228624] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"939.806598ms","start":"2026-04-07T09:39:01.281324Z","end":"2026-04-07T09:39:02.221131Z","steps":["trace[1542228624] 'process raft request' (duration: 939.222868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.221359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.281285Z","time spent":"939.973094ms","remote":"127.0.0.1:53500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:39:02.221428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.036849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:02.221501Z","caller":"traceutil/trace.go:171","msg":"trace[1473641761] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"939.155273ms","start":"2026-04-07T09:39:01.28233Z","end":"2026-04-07T09:39:02.221486Z","steps":["trace[1473641761] 'agreement among raft nodes before linearized reading' (duration: 938.913694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.221549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.282309Z","time spent":"939.224725ms","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:39:02.221369Z","caller":"traceutil/trace.go:171","msg":"trace[1719792639] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"938.658435ms","start":"2026-04-07T09:39:01.282359Z","end":"2026-04-07T09:39:02.221018Z","steps":["trace[1719792639] 'read index received' (duration: 937.890958ms)","trace[1719792639] 'applied index is now lower than readState.Index' (duration: 766.647µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:02.222685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.20972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:02.222751Z","caller":"traceutil/trace.go:171","msg":"trace[489465424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"940.287993ms","start":"2026-04-07T09:39:01.282445Z","end":"2026-04-07T09:39:02.222733Z","steps":["trace[489465424] 'agreement among raft nodes before linearized reading' (duration: 940.187049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.222799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.28244Z","time spent":"940.343716ms","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:39:02.2228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.959794ms","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-07T09:39:02.222913Z","caller":"traceutil/trace.go:171","msg":"trace[552492428] 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:624; }","duration":"878.114818ms","start":"2026-04-07T09:39:01.344769Z","end":"2026-04-07T09:39:02.222884Z","steps":["trace[552492428] 'agreement among raft nodes before linearized reading' (duration: 877.87063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.222978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.344758Z","time spent":"878.206412ms","remote":"127.0.0.1:43570","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-07T09:39:02.223023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.640658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:02.223089Z","caller":"traceutil/trace.go:171","msg":"trace[1166429924] 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:624; }","duration":"878.721141ms","start":"2026-04-07T09:39:01.344355Z","end":"2026-04-07T09:39:02.223076Z","steps":["trace[1166429924] 'agreement among raft nodes before linearized reading' (duration: 878.627027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.34435Z","time spent":"878.768723ms","remote":"127.0.0.1:43570","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-07T09:39:02.223173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.431514ms","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-07T09:39:02.223275Z","caller":"traceutil/trace.go:171","msg":"trace[16814708] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"896.571318ms","start":"2026-04-07T09:39:01.326678Z","end":"2026-04-07T09:39:02.22325Z","steps":["trace[16814708] 'agreement among raft nodes before linearized reading' (duration: 896.375811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.326672Z","time spent":"896.647541ms","remote":"127.0.0.1:43568","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-07T09:39:02.223374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.739083ms","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-07T09:39:02.223414Z","caller":"traceutil/trace.go:171","msg":"trace[1718718898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"169.818426ms","start":"2026-04-07T09:39:02.053585Z","end":"2026-04-07T09:39:02.223403Z","steps":["trace[1718718898] 'agreement among raft nodes before linearized reading' (duration: 169.65808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.22343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.167358ms","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-07T09:39:02.223512Z","caller":"traceutil/trace.go:171","msg":"trace[235288734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"911.263232ms","start":"2026-04-07T09:39:01.312235Z","end":"2026-04-07T09:39:02.223498Z","steps":["trace[235288734] 'agreement among raft nodes before linearized reading' (duration: 911.166079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.312198Z","time spent":"911.355965ms","remote":"127.0.0.1:43560","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-07T09:39:02.223642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.415326ms","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-07T09:39:02.223691Z","caller":"traceutil/trace.go:171","msg":"trace[1218343161] 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:624; }","duration":"879.464697ms","start":"2026-04-07T09:39:01.344216Z","end":"2026-04-07T09:39:02.22368Z","steps":["trace[1218343161] 'agreement among raft nodes before linearized reading' (duration: 879.391995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.953532ms","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-07T09:39:02.223725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.34421Z","time spent":"879.5039ms","remote":"127.0.0.1:43570","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":"info","ts":"2026-04-07T09:39:02.22376Z","caller":"traceutil/trace.go:171","msg":"trace[1575679488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"897.046705ms","start":"2026-04-07T09:39:01.326701Z","end":"2026-04-07T09:39:02.223748Z","steps":["trace[1575679488] 'agreement among raft nodes before linearized reading' (duration: 896.923261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.23196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:39:02.2238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.326699Z","time spent":"897.091086ms","remote":"127.0.0.1:43568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:39:02.223827Z","caller":"traceutil/trace.go:171","msg":"trace[751846806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"804.336873ms","start":"2026-04-07T09:39:01.419479Z","end":"2026-04-07T09:39:02.223816Z","steps":["trace[751846806] 'agreement among raft nodes before linearized reading' (duration: 804.274651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.223857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.419449Z","time spent":"804.402786ms","remote":"127.0.0.1:53402","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-07T09:39:02.223951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.550377ms","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-07T09:39:02.223988Z","caller":"traceutil/trace.go:171","msg":"trace[1345400392] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"896.593229ms","start":"2026-04-07T09:39:01.327386Z","end":"2026-04-07T09:39:02.22398Z","steps":["trace[1345400392] 'agreement among raft nodes before linearized reading' (duration: 896.537697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.224011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.327383Z","time spent":"896.62064ms","remote":"127.0.0.1:43560","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-07T09:39:02.223371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.966241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:02.224076Z","caller":"traceutil/trace.go:171","msg":"trace[1296245751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"911.704697ms","start":"2026-04-07T09:39:01.312358Z","end":"2026-04-07T09:39:02.224063Z","steps":["trace[1296245751] 'agreement among raft nodes before linearized reading' (duration: 910.956131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.22412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:01.312336Z","time spent":"911.768459ms","remote":"127.0.0.1:43560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:39:02.388599Z","caller":"traceutil/trace.go:171","msg":"trace[277794198] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"157.835347ms","start":"2026-04-07T09:39:02.230718Z","end":"2026-04-07T09:39:02.388554Z","steps":["trace[277794198] 'process raft request' (duration: 82.501737ms)","trace[277794198] 'compare' (duration: 74.976836ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:39:02.388741Z","caller":"traceutil/trace.go:171","msg":"trace[1497281193] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"123.701594ms","start":"2026-04-07T09:39:02.265009Z","end":"2026-04-07T09:39:02.38871Z","steps":["trace[1497281193] 'read index received' (duration: 48.230029ms)","trace[1497281193] 'applied index is now lower than readState.Index' (duration: 75.468574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:02.388996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.957042ms","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-07T09:39:02.389041Z","caller":"traceutil/trace.go:171","msg":"trace[579748753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"124.097378ms","start":"2026-04-07T09:39:02.264933Z","end":"2026-04-07T09:39:02.38903Z","steps":["trace[579748753] 'agreement among raft nodes before linearized reading' (duration: 123.897421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:02.389048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.895624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T09:39:02.389092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.763015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:39:02.389132Z","caller":"traceutil/trace.go:171","msg":"trace[470733827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"123.868158ms","start":"2026-04-07T09:39:02.265253Z","end":"2026-04-07T09:39:02.389121Z","steps":["trace[470733827] 'agreement among raft nodes before linearized reading' (duration: 123.63774ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:02.389131Z","caller":"traceutil/trace.go:171","msg":"trace[2063290363] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"123.008588ms","start":"2026-04-07T09:39:02.266104Z","end":"2026-04-07T09:39:02.389113Z","steps":["trace[2063290363] 'agreement among raft nodes before linearized reading' (duration: 122.806231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.36299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038493478s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T09:39:19.363325Z","caller":"traceutil/trace.go:171","msg":"trace[1871732067] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"943.109992ms","start":"2026-04-07T09:39:18.420189Z","end":"2026-04-07T09:39:19.363299Z","steps":["trace[1871732067] 'read index received' (duration: 82.572µs)","trace[1871732067] 'applied index is now lower than readState.Index' (duration: 943.02553ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:19.363805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.599026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:19.364198Z","caller":"traceutil/trace.go:171","msg":"trace[783668222] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"933.736291ms","start":"2026-04-07T09:39:18.430423Z","end":"2026-04-07T09:39:19.36416Z","steps":["trace[783668222] 'process raft request' (duration: 932.730922ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:19.3643Z","caller":"traceutil/trace.go:171","msg":"trace[1598089294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"943.750461ms","start":"2026-04-07T09:39:18.420171Z","end":"2026-04-07T09:39:19.363921Z","steps":["trace[1598089294] 'agreement among raft nodes before linearized reading' (duration: 943.435412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.364526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.430393Z","time spent":"933.996069ms","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:39:19.364581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.420076Z","time spent":"944.440961ms","remote":"127.0.0.1:53402","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-07T09:39:19.367882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.464683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T09:39:19.367904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.393243ms","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-07T09:39:19.367944Z","caller":"traceutil/trace.go:171","msg":"trace[1066812082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"867.554896ms","start":"2026-04-07T09:39:18.500375Z","end":"2026-04-07T09:39:19.367929Z","steps":["trace[1066812082] 'agreement among raft nodes before linearized reading' (duration: 863.97348ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:19.36797Z","caller":"traceutil/trace.go:171","msg":"trace[1069080360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"864.514216ms","start":"2026-04-07T09:39:18.503437Z","end":"2026-04-07T09:39:19.367951Z","steps":["trace[1069080360] 'agreement among raft nodes before linearized reading' (duration: 860.869007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.368033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.503397Z","time spent":"864.624579ms","remote":"127.0.0.1:53662","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-07T09:39:19.367983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.500361Z","time spent":"867.614499ms","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T09:39:19.368089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.093946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-klz2h\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-07T09:39:19.368133Z","caller":"traceutil/trace.go:171","msg":"trace[1585042026] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-klz2h; range_end:; response_count:1; response_revision:784; }","duration":"908.155347ms","start":"2026-04-07T09:39:18.459965Z","end":"2026-04-07T09:39:19.36812Z","steps":["trace[1585042026] 'agreement among raft nodes before linearized reading' (duration: 904.150948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.368174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.459952Z","time spent":"908.21509ms","remote":"127.0.0.1:53594","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-klz2h\" "} {"level":"warn","ts":"2026-04-07T09:39:19.368023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.158846ms","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-07T09:39:19.368325Z","caller":"traceutil/trace.go:171","msg":"trace[911202297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:784; }","duration":"858.405213ms","start":"2026-04-07T09:39:18.509802Z","end":"2026-04-07T09:39:19.368208Z","steps":["trace[911202297] 'agreement among raft nodes before linearized reading' (duration: 854.527448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.368397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.509778Z","time spent":"858.605939ms","remote":"127.0.0.1:53662","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-07T09:39:19.368492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.861966ms","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-07T09:39:19.368668Z","caller":"traceutil/trace.go:171","msg":"trace[1224847202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"860.170095ms","start":"2026-04-07T09:39:18.508448Z","end":"2026-04-07T09:39:19.368618Z","steps":["trace[1224847202] 'agreement among raft nodes before linearized reading' (duration: 855.731814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:19.369171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:18.508416Z","time spent":"860.287709ms","remote":"127.0.0.1:53662","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-07T09:39:33.034712Z","caller":"traceutil/trace.go:171","msg":"trace[371365902] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"101.515691ms","start":"2026-04-07T09:39:32.933158Z","end":"2026-04-07T09:39:33.034674Z","steps":["trace[371365902] 'read index received' (duration: 101.239154ms)","trace[371365902] 'applied index is now lower than readState.Index' (duration: 274.927µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:39:33.035337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.147926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-tdpvh\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-04-07T09:39:33.035407Z","caller":"traceutil/trace.go:171","msg":"trace[1630362315] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-tdpvh; range_end:; response_count:1; response_revision:945; }","duration":"102.28071ms","start":"2026-04-07T09:39:32.933108Z","end":"2026-04-07T09:39:33.035389Z","steps":["trace[1630362315] 'agreement among raft nodes before linearized reading' (duration: 101.758307ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:33.036019Z","caller":"traceutil/trace.go:171","msg":"trace[660697081] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"366.687014ms","start":"2026-04-07T09:39:32.669316Z","end":"2026-04-07T09:39:33.036003Z","steps":["trace[660697081] 'process raft request' (duration: 365.152245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:33.040657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:39:32.669286Z","time spent":"366.794647ms","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:41:19.258304Z","caller":"traceutil/trace.go:171","msg":"trace[661097245] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"313.881006ms","start":"2026-04-07T09:41:18.944398Z","end":"2026-04-07T09:41:19.258279Z","steps":["trace[661097245] 'read index received' (duration: 313.603032ms)","trace[661097245] 'applied index is now lower than readState.Index' (duration: 276.864µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:19.258446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.022257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:19.258485Z","caller":"traceutil/trace.go:171","msg":"trace[1385685975] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1353; }","duration":"314.123618ms","start":"2026-04-07T09:41:18.944351Z","end":"2026-04-07T09:41:19.258474Z","steps":["trace[1385685975] 'agreement among raft nodes before linearized reading' (duration: 314.033267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:19.258539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:18.944329Z","time spent":"314.189478ms","remote":"127.0.0.1:53556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-04-07T09:41:19.258557Z","caller":"traceutil/trace.go:171","msg":"trace[1834643387] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"343.239451ms","start":"2026-04-07T09:41:18.915297Z","end":"2026-04-07T09:41:19.258536Z","steps":["trace[1834643387] 'process raft request' (duration: 342.802206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:19.258748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:18.915279Z","time spent":"343.391142ms","remote":"127.0.0.1:53662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}