{"level":"warn","ts":"2026-04-22T06:00:28.973677Z","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-22T06:00:28.973787Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-22T06:00:28.973865Z","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-22T06:00:28.973878Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-22T06:00:28.973903Z","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-22T06:00:28.974971Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-04-22T06:00:28.975122Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-22T06:00:28.978511Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.039282ms"} {"level":"info","ts":"2026-04-22T06:00:28.984482Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-04-22T06:00:28.984741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T06:00:28.984772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-04-22T06:00:28.9848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T06:00:28.984853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-04-22T06:00:28.985019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-04-22T06:00:28.990795Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T06:00:28.991948Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T06:00:28.993159Z","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-22T06:00:28.995431Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T06:00:28.995613Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T06:00:28.995766Z","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-22T06:00:28.995878Z","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-22T06:00:28.995889Z","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-22T06:00:28.996349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-04-22T06:00:28.996463Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-22T06:00:29.006224Z","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-22T06:00:29.006443Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-22T06:00:29.006487Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T06:00:29.006573Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T06:00:29.006542Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-22T06:00:29.286233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T06:00:29.286296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T06:00:29.286316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-04-22T06:00:29.286329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-04-22T06:00:29.286335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-22T06:00:29.286344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-04-22T06:00:29.286355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-22T06:00:29.287242Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:00:29.287576Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T06:00:29.290672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:00:29.290734Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:00:29.293161Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-04-22T06:00:29.293189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T06:00:29.29322Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T06:00:29.2987Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T06:00:29.299841Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:00:29.300037Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:00:29.300116Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-22T06:00:33.109846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605312576699081,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:00:33.14249Z","caller":"traceutil/trace.go:171","msg":"trace[719718835] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"868.978461ms","start":"2026-04-22T06:00:32.273484Z","end":"2026-04-22T06:00:33.142463Z","steps":["trace[719718835] 'process raft request' (duration: 865.911258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:33.142951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:32.273462Z","time spent":"869.102922ms","remote":"127.0.0.1:50152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":694,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T06:00:33.199063Z","caller":"traceutil/trace.go:171","msg":"trace[160513699] linearizableReadLoop","detail":"{readStateIndex:191; appliedIndex:189; }","duration":"589.847043ms","start":"2026-04-22T06:00:32.609189Z","end":"2026-04-22T06:00:33.199036Z","steps":["trace[160513699] 'read index received' (duration: 530.187601ms)","trace[160513699] 'applied index is now lower than readState.Index' (duration: 59.657912ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:33.199302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.044617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:33.199369Z","caller":"traceutil/trace.go:171","msg":"trace[1531092116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:186; }","duration":"590.231071ms","start":"2026-04-22T06:00:32.609124Z","end":"2026-04-22T06:00:33.199355Z","steps":["trace[1531092116] 'agreement among raft nodes before linearized reading' (duration: 590.050238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:33.199358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.800382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:33.199408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:32.609093Z","time spent":"590.306092ms","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:00:33.199453Z","caller":"traceutil/trace.go:171","msg":"trace[1997340295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:186; }","duration":"269.964305ms","start":"2026-04-22T06:00:32.929466Z","end":"2026-04-22T06:00:33.199431Z","steps":["trace[1997340295] 'agreement among raft nodes before linearized reading' (duration: 269.763822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:33.199409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:32.66971Z","time spent":"529.596647ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-22T06:00:33.908608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.909722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:00:33.909069Z","caller":"traceutil/trace.go:171","msg":"trace[1429122578] linearizableReadLoop","detail":"{readStateIndex:193; appliedIndex:191; }","duration":"704.597452ms","start":"2026-04-22T06:00:33.204441Z","end":"2026-04-22T06:00:33.909038Z","steps":["trace[1429122578] 'read index received' (duration: 407.847314ms)","trace[1429122578] 'applied index is now lower than readState.Index' (duration: 296.747958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:33.909412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.249199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:33.909422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.952969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-22T06:00:33.909465Z","caller":"traceutil/trace.go:171","msg":"trace[877855625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:188; }","duration":"201.364211ms","start":"2026-04-22T06:00:33.708086Z","end":"2026-04-22T06:00:33.909451Z","steps":["trace[877855625] 'agreement among raft nodes before linearized reading' (duration: 201.256478ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:33.909248Z","caller":"traceutil/trace.go:171","msg":"trace[2063474159] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"705.145543ms","start":"2026-04-22T06:00:33.204078Z","end":"2026-04-22T06:00:33.909224Z","steps":["trace[2063474159] 'process raft request' (duration: 704.669915ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:33.90954Z","caller":"traceutil/trace.go:171","msg":"trace[1743675685] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:188; }","duration":"705.105242ms","start":"2026-04-22T06:00:33.20441Z","end":"2026-04-22T06:00:33.909516Z","steps":["trace[1743675685] 'agreement among raft nodes before linearized reading' (duration: 704.792275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:33.909709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:33.204397Z","time spent":"705.263976ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-22T06:00:33.90906Z","caller":"traceutil/trace.go:171","msg":"trace[698815623] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"706.97409ms","start":"2026-04-22T06:00:33.202031Z","end":"2026-04-22T06:00:33.909005Z","steps":["trace[698815623] 'process raft request' (duration: 410.242702ms)","trace[698815623] 'compare' (duration: 295.703028ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:33.910037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:33.201995Z","time spent":"707.94291ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:00:33.910027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:33.204066Z","time spent":"705.539732ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:00:34.318792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.480869ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-22T06:00:34.319113Z","caller":"traceutil/trace.go:171","msg":"trace[1285891937] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:219; }","duration":"174.519381ms","start":"2026-04-22T06:00:34.144557Z","end":"2026-04-22T06:00:34.319076Z","steps":["trace[1285891937] 'read index received' (duration: 33.670034ms)","trace[1285891937] 'applied index is now lower than readState.Index' (duration: 140.846237ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:34.319456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.330526ms","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-22T06:00:34.319567Z","caller":"traceutil/trace.go:171","msg":"trace[2084112987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:215; }","duration":"137.493499ms","start":"2026-04-22T06:00:34.182057Z","end":"2026-04-22T06:00:34.31955Z","steps":["trace[2084112987] 'agreement among raft nodes before linearized reading' (duration: 137.298166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:34.319463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.813987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a898689fa5dd7b\" ","response":"range_response_count:1 size:657"} {"level":"info","ts":"2026-04-22T06:00:34.319888Z","caller":"traceutil/trace.go:171","msg":"trace[1022780741] range","detail":"{range_begin:/registry/events/default/instance.18a898689fa5dd7b; range_end:; response_count:1; response_revision:215; }","duration":"175.350718ms","start":"2026-04-22T06:00:34.144508Z","end":"2026-04-22T06:00:34.319859Z","steps":["trace[1022780741] 'agreement among raft nodes before linearized reading' (duration: 174.693115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:36.294028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.668852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-04-22T06:00:36.294085Z","caller":"traceutil/trace.go:171","msg":"trace[650037865] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:307; }","duration":"117.778323ms","start":"2026-04-22T06:00:36.176295Z","end":"2026-04-22T06:00:36.294073Z","steps":["trace[650037865] 'range keys from in-memory index tree' (duration: 117.594099ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:53.068838Z","caller":"traceutil/trace.go:171","msg":"trace[1231980765] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"138.579075ms","start":"2026-04-22T06:00:52.930233Z","end":"2026-04-22T06:00:53.068812Z","steps":["trace[1231980765] 'process raft request' (duration: 138.452382ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:00.495742Z","caller":"traceutil/trace.go:171","msg":"trace[915897557] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"447.091881ms","start":"2026-04-22T06:01:00.04863Z","end":"2026-04-22T06:01:00.495722Z","steps":["trace[915897557] 'read index received' (duration: 446.917997ms)","trace[915897557] 'applied index is now lower than readState.Index' (duration: 173.104µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:00.495798Z","caller":"traceutil/trace.go:171","msg":"trace[1846510461] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"450.546409ms","start":"2026-04-22T06:01:00.04522Z","end":"2026-04-22T06:01:00.495767Z","steps":["trace[1846510461] 'process raft request' (duration: 450.353056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:00.495926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.285776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T06:01:00.495963Z","caller":"traceutil/trace.go:171","msg":"trace[373968698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"447.411738ms","start":"2026-04-22T06:01:00.048543Z","end":"2026-04-22T06:01:00.495955Z","steps":["trace[373968698] 'agreement among raft nodes before linearized reading' (duration: 447.319676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:00.496033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:00.048513Z","time spent":"447.513191ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:01:00.496178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:00.045191Z","time spent":"450.691913ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:01:02.379252Z","caller":"traceutil/trace.go:171","msg":"trace[722665072] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"140.813353ms","start":"2026-04-22T06:01:02.238403Z","end":"2026-04-22T06:01:02.379216Z","steps":["trace[722665072] 'process raft request' (duration: 139.079602ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:02.379378Z","caller":"traceutil/trace.go:171","msg":"trace[141236014] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"124.250026ms","start":"2026-04-22T06:01:02.255028Z","end":"2026-04-22T06:01:02.379278Z","steps":["trace[141236014] 'read index received' (duration: 122.363639ms)","trace[141236014] 'applied index is now lower than readState.Index' (duration: 1.879237ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:01:02.381613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.555615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-22T06:01:02.381722Z","caller":"traceutil/trace.go:171","msg":"trace[541186745] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:593; }","duration":"126.696449ms","start":"2026-04-22T06:01:02.255003Z","end":"2026-04-22T06:01:02.3817Z","steps":["trace[541186745] 'agreement among raft nodes before linearized reading' (duration: 124.473803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:06.98059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.881436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:01:06.980677Z","caller":"traceutil/trace.go:171","msg":"trace[893047940] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"444.728774ms","start":"2026-04-22T06:01:06.535937Z","end":"2026-04-22T06:01:06.980665Z","steps":["trace[893047940] 'read index received' (duration: 286.676033ms)","trace[893047940] 'applied index is now lower than readState.Index' (duration: 158.038651ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:06.980776Z","caller":"traceutil/trace.go:171","msg":"trace[1321225859] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"512.77647ms","start":"2026-04-22T06:01:06.46799Z","end":"2026-04-22T06:01:06.980767Z","steps":["trace[1321225859] 'process raft request' (duration: 354.661577ms)","trace[1321225859] 'compare' (duration: 157.718412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:01:06.980809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.467942Z","time spent":"512.850852ms","remote":"127.0.0.1:50178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:01:06.980918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.96686ms","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-22T06:01:06.980989Z","caller":"traceutil/trace.go:171","msg":"trace[1194898915] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"445.084635ms","start":"2026-04-22T06:01:06.535885Z","end":"2026-04-22T06:01:06.980969Z","steps":["trace[1194898915] 'agreement among raft nodes before linearized reading' (duration: 444.857027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:06.981022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.535861Z","time spent":"445.155087ms","remote":"127.0.0.1:50106","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-22T06:01:07.69403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.039527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:01:07.694199Z","caller":"traceutil/trace.go:171","msg":"trace[112457549] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.120855755s","start":"2026-04-22T06:01:06.573306Z","end":"2026-04-22T06:01:07.694162Z","steps":["trace[112457549] 'process raft request' (duration: 562.605731ms)","trace[112457549] 'compare' (duration: 557.921704ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:07.694259Z","caller":"traceutil/trace.go:171","msg":"trace[1416354490] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"708.835055ms","start":"2026-04-22T06:01:06.985406Z","end":"2026-04-22T06:01:07.694241Z","steps":["trace[1416354490] 'process raft request' (duration: 708.751582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:07.694355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.985373Z","time spent":"708.935208ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:01:07.6944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.573274Z","time spent":"1.12103398s","remote":"127.0.0.1:50106","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-22T06:01:07.694583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15292444s","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-22T06:01:07.694352Z","caller":"traceutil/trace.go:171","msg":"trace[2019205965] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"713.591855ms","start":"2026-04-22T06:01:06.980693Z","end":"2026-04-22T06:01:07.694285Z","steps":["trace[2019205965] 'read index received' (duration: 155.299881ms)","trace[2019205965] 'applied index is now lower than readState.Index' (duration: 558.290714ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:07.694673Z","caller":"traceutil/trace.go:171","msg":"trace[864819295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"1.153032103s","start":"2026-04-22T06:01:06.541623Z","end":"2026-04-22T06:01:07.694655Z","steps":["trace[864819295] 'agreement among raft nodes before linearized reading' (duration: 1.152846288s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:07.694779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.541614Z","time spent":"1.153152607s","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:01:07.694818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.732995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:01:07.694846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.719889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T06:01:07.694882Z","caller":"traceutil/trace.go:171","msg":"trace[1098311531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"554.779341ms","start":"2026-04-22T06:01:07.140092Z","end":"2026-04-22T06:01:07.694871Z","steps":["trace[1098311531] 'agreement among raft nodes before linearized reading' (duration: 554.71608ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:07.694882Z","caller":"traceutil/trace.go:171","msg":"trace[19425146] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:621; }","duration":"702.822778ms","start":"2026-04-22T06:01:06.992043Z","end":"2026-04-22T06:01:07.694866Z","steps":["trace[19425146] 'agreement among raft nodes before linearized reading' (duration: 702.727916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:07.694927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:07.140079Z","time spent":"554.841203ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:01:07.69493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.992032Z","time spent":"702.88964ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-22T06:01:07.694944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.386846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wnwcr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-22T06:01:07.695027Z","caller":"traceutil/trace.go:171","msg":"trace[2067002553] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wnwcr; range_end:; response_count:1; response_revision:621; }","duration":"717.52411ms","start":"2026-04-22T06:01:06.977485Z","end":"2026-04-22T06:01:07.695009Z","steps":["trace[2067002553] 'agreement among raft nodes before linearized reading' (duration: 717.241492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:07.69515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.977467Z","time spent":"717.645675ms","remote":"127.0.0.1:50032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-wnwcr\" "} {"level":"warn","ts":"2026-04-22T06:01:07.696863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074875618s","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-22T06:01:07.696941Z","caller":"traceutil/trace.go:171","msg":"trace[1046858691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"1.075049393s","start":"2026-04-22T06:01:06.621872Z","end":"2026-04-22T06:01:07.696922Z","steps":["trace[1046858691] 'agreement among raft nodes before linearized reading' (duration: 1.074655442s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:07.696992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:06.621847Z","time spent":"1.075131395s","remote":"127.0.0.1:50106","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-22T06:01:08.328395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605312576699931,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:01:08.725538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.427094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:01:08.725842Z","caller":"traceutil/trace.go:171","msg":"trace[951541266] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.017335337s","start":"2026-04-22T06:01:07.708487Z","end":"2026-04-22T06:01:08.725823Z","steps":["trace[951541266] 'process raft request' (duration: 1.017236185s)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:08.725878Z","caller":"traceutil/trace.go:171","msg":"trace[1463188889] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.024349532s","start":"2026-04-22T06:01:07.701469Z","end":"2026-04-22T06:01:08.725818Z","steps":["trace[1463188889] 'process raft request' (duration: 696.553177ms)","trace[1463188889] 'compare' (duration: 327.091145ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:01:08.725957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:07.708477Z","time spent":"1.0174438s","remote":"127.0.0.1:50032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:01:08.726217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:07.701451Z","time spent":"1.024572769s","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:01:08.746924Z","caller":"traceutil/trace.go:171","msg":"trace[274430345] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:644; }","duration":"918.628447ms","start":"2026-04-22T06:01:07.828273Z","end":"2026-04-22T06:01:08.746901Z","steps":["trace[274430345] 'read index received' (duration: 569.807788ms)","trace[274430345] 'applied index is now lower than readState.Index' (duration: 348.819769ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:01:08.747092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.816033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:01:08.747152Z","caller":"traceutil/trace.go:171","msg":"trace[1530819202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"918.924826ms","start":"2026-04-22T06:01:07.828214Z","end":"2026-04-22T06:01:08.747139Z","steps":["trace[1530819202] 'agreement among raft nodes before linearized reading' (duration: 918.834193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:08.747225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:07.82819Z","time spent":"919.024259ms","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:01:08.747215Z","caller":"traceutil/trace.go:171","msg":"trace[379334849] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"637.603274ms","start":"2026-04-22T06:01:08.109574Z","end":"2026-04-22T06:01:08.747177Z","steps":["trace[379334849] 'process raft request' (duration: 636.865032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:08.747447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:08.109545Z","time spent":"637.80471ms","remote":"127.0.0.1:49946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:01:10.240239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.730689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:01:10.24024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.702398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:01:10.240352Z","caller":"traceutil/trace.go:171","msg":"trace[434235106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:663; }","duration":"116.867142ms","start":"2026-04-22T06:01:10.123466Z","end":"2026-04-22T06:01:10.240333Z","steps":["trace[434235106] 'count revisions from in-memory index tree' (duration: 116.430019ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:10.240344Z","caller":"traceutil/trace.go:171","msg":"trace[1763900583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:663; }","duration":"116.851802ms","start":"2026-04-22T06:01:10.123471Z","end":"2026-04-22T06:01:10.240323Z","steps":["trace[1763900583] 'range keys from in-memory index tree' (duration: 116.549833ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:13.292012Z","caller":"traceutil/trace.go:171","msg":"trace[960301760] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"120.126981ms","start":"2026-04-22T06:01:13.171849Z","end":"2026-04-22T06:01:13.291976Z","steps":["trace[960301760] 'process raft request' (duration: 119.613926ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:38.275086Z","caller":"traceutil/trace.go:171","msg":"trace[1987354855] linearizableReadLoop","detail":"{readStateIndex:856; appliedIndex:855; }","duration":"435.680392ms","start":"2026-04-22T06:01:37.839381Z","end":"2026-04-22T06:01:38.275061Z","steps":["trace[1987354855] 'read index received' (duration: 435.446436ms)","trace[1987354855] 'applied index is now lower than readState.Index' (duration: 232.886µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:38.275137Z","caller":"traceutil/trace.go:171","msg":"trace[471488814] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"436.279808ms","start":"2026-04-22T06:01:37.838825Z","end":"2026-04-22T06:01:38.275104Z","steps":["trace[471488814] 'process raft request' (duration: 436.092034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.275332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:37.838813Z","time spent":"436.421182ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:01:38.275372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.782456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:01:38.275392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.916768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:01:38.275413Z","caller":"traceutil/trace.go:171","msg":"trace[408465710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:826; }","duration":"435.858798ms","start":"2026-04-22T06:01:37.839545Z","end":"2026-04-22T06:01:38.275403Z","steps":["trace[408465710] 'agreement among raft nodes before linearized reading' (duration: 435.684653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.275394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.97288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:01:38.275459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:37.83954Z","time spent":"435.910009ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T06:01:38.275511Z","caller":"traceutil/trace.go:171","msg":"trace[705996249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:826; }","duration":"436.118955ms","start":"2026-04-22T06:01:37.839369Z","end":"2026-04-22T06:01:38.275488Z","steps":["trace[705996249] 'agreement among raft nodes before linearized reading' (duration: 435.842187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.275565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:37.839362Z","time spent":"436.192346ms","remote":"127.0.0.1:50106","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-22T06:01:38.27545Z","caller":"traceutil/trace.go:171","msg":"trace[1474885288] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:826; }","duration":"146.02775ms","start":"2026-04-22T06:01:38.129408Z","end":"2026-04-22T06:01:38.275436Z","steps":["trace[1474885288] 'agreement among raft nodes before linearized reading' (duration: 145.866006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.275566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.214194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-v9zmp\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-22T06:01:38.275807Z","caller":"traceutil/trace.go:171","msg":"trace[1368427999] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-v9zmp; range_end:; response_count:1; response_revision:826; }","duration":"161.490551ms","start":"2026-04-22T06:01:38.114296Z","end":"2026-04-22T06:01:38.275786Z","steps":["trace[1368427999] 'agreement among raft nodes before linearized reading' (duration: 161.011879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.634945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.305055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:01:38.635072Z","caller":"traceutil/trace.go:171","msg":"trace[1666457227] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"354.851389ms","start":"2026-04-22T06:01:38.28018Z","end":"2026-04-22T06:01:38.635031Z","steps":["trace[1666457227] 'process raft request' (duration: 200.025381ms)","trace[1666457227] 'compare' (duration: 154.076539ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:01:38.63526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:38.280159Z","time spent":"355.060636ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:01:38.638613Z","caller":"traceutil/trace.go:171","msg":"trace[2115190339] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"355.305523ms","start":"2026-04-22T06:01:38.283292Z","end":"2026-04-22T06:01:38.638597Z","steps":["trace[2115190339] 'process raft request' (duration: 355.22153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.638701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:38.283283Z","time spent":"355.375664ms","remote":"127.0.0.1:50032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:01:38.638895Z","caller":"traceutil/trace.go:171","msg":"trace[1818294577] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"358.649379ms","start":"2026-04-22T06:01:38.280236Z","end":"2026-04-22T06:01:38.638885Z","steps":["trace[1818294577] 'process raft request' (duration: 358.155806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.63896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:38.280213Z","time spent":"358.71256ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:01:38.639093Z","caller":"traceutil/trace.go:171","msg":"trace[1647995126] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"320.683733ms","start":"2026-04-22T06:01:38.318385Z","end":"2026-04-22T06:01:38.639068Z","steps":["trace[1647995126] 'process raft request' (duration: 320.17709ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:38.639209Z","caller":"traceutil/trace.go:171","msg":"trace[1546823634] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"358.661229ms","start":"2026-04-22T06:01:38.280538Z","end":"2026-04-22T06:01:38.639199Z","steps":["trace[1546823634] 'process raft request' (duration: 357.93821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:38.639311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:38.318374Z","time spent":"320.819106ms","remote":"127.0.0.1:50106","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-22T06:01:38.639288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:38.280531Z","time spent":"358.713571ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:03:23.453957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.431396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:03:23.454095Z","caller":"traceutil/trace.go:171","msg":"trace[2125067927] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1383; }","duration":"199.370736ms","start":"2026-04-22T06:03:23.254705Z","end":"2026-04-22T06:03:23.454076Z","steps":["trace[2125067927] 'read index received' (duration: 44.693325ms)","trace[2125067927] 'applied index is now lower than readState.Index' (duration: 154.676031ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:03:23.454232Z","caller":"traceutil/trace.go:171","msg":"trace[2128570862] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"214.321649ms","start":"2026-04-22T06:03:23.239848Z","end":"2026-04-22T06:03:23.45417Z","steps":["trace[2128570862] 'process raft request' (duration: 59.565566ms)","trace[2128570862] 'compare' (duration: 154.140839ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:03:23.454375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.647242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T06:03:23.454453Z","caller":"traceutil/trace.go:171","msg":"trace[1493364993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1332; }","duration":"199.760465ms","start":"2026-04-22T06:03:23.254673Z","end":"2026-04-22T06:03:23.454433Z","steps":["trace[1493364993] 'agreement among raft nodes before linearized reading' (duration: 199.483638ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:03:31.823399Z","caller":"traceutil/trace.go:171","msg":"trace[300762569] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"273.043054ms","start":"2026-04-22T06:03:31.550131Z","end":"2026-04-22T06:03:31.823174Z","steps":["trace[300762569] 'process raft request' (duration: 272.004282ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:03:31.823935Z","caller":"traceutil/trace.go:171","msg":"trace[1201625052] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"255.259013ms","start":"2026-04-22T06:03:31.568657Z","end":"2026-04-22T06:03:31.823916Z","steps":["trace[1201625052] 'process raft request' (duration: 253.878483ms)"],"step_count":1}