{"level":"warn","ts":"2026-04-02T16:42:37.184222Z","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-02T16:42:37.1843Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.87:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.87:2380","--initial-cluster=instance=https://199.19.213.87:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.87:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.87: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-02T16:42:37.184375Z","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-02T16:42:37.184388Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.87:2380"]} {"level":"info","ts":"2026-04-02T16:42:37.184407Z","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-02T16:42:37.185106Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"]} {"level":"info","ts":"2026-04-02T16:42:37.185187Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.87:2380"],"listen-peer-urls":["https://199.19.213.87:2380"],"advertise-client-urls":["https://199.19.213.87:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.87: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-02T16:42:37.18858Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.207845ms"} {"level":"info","ts":"2026-04-02T16:42:37.19397Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bc3cb673a921c717","cluster-id":"f315f77360ac6549"} {"level":"info","ts":"2026-04-02T16:42:37.194043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T16:42:37.194162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became follower at term 0"} {"level":"info","ts":"2026-04-02T16:42:37.194177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bc3cb673a921c717 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T16:42:37.194193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became follower at term 1"} {"level":"info","ts":"2026-04-02T16:42:37.194269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=(13563916785608148759)"} {"level":"warn","ts":"2026-04-02T16:42:37.200522Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T16:42:37.202393Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T16:42:37.203762Z","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-02T16:42:37.206321Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bc3cb673a921c717","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T16:42:37.206493Z","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-02T16:42:37.206545Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bc3cb673a921c717","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T16:42:37.209495Z","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-02T16:42:37.209597Z","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-02T16:42:37.209632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 switched to configuration voters=(13563916785608148759)"} {"level":"info","ts":"2026-04-02T16:42:37.209784Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f315f77360ac6549","local-member-id":"bc3cb673a921c717","added-peer-id":"bc3cb673a921c717","added-peer-peer-urls":["https://199.19.213.87:2380"]} {"level":"info","ts":"2026-04-02T16:42:37.212135Z","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-02T16:42:37.212235Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.87:2380"} {"level":"info","ts":"2026-04-02T16:42:37.212261Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.87:2380"} {"level":"info","ts":"2026-04-02T16:42:37.212382Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bc3cb673a921c717","initial-advertise-peer-urls":["https://199.19.213.87:2380"],"listen-peer-urls":["https://199.19.213.87:2380"],"advertise-client-urls":["https://199.19.213.87:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.87:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T16:42:37.212427Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T16:42:37.895436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T16:42:37.895494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T16:42:37.895559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 received MsgPreVoteResp from bc3cb673a921c717 at term 1"} {"level":"info","ts":"2026-04-02T16:42:37.895596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became candidate at term 2"} {"level":"info","ts":"2026-04-02T16:42:37.895609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 received MsgVoteResp from bc3cb673a921c717 at term 2"} {"level":"info","ts":"2026-04-02T16:42:37.89563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bc3cb673a921c717 became leader at term 2"} {"level":"info","ts":"2026-04-02T16:42:37.895682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bc3cb673a921c717 elected leader bc3cb673a921c717 at term 2"} {"level":"info","ts":"2026-04-02T16:42:37.896743Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bc3cb673a921c717","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.87:2379]}","request-path":"/0/members/bc3cb673a921c717/attributes","cluster-id":"f315f77360ac6549","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T16:42:37.897155Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:37.897515Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:42:37.898087Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:42:37.898132Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f315f77360ac6549","local-member-id":"bc3cb673a921c717","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:37.898337Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T16:42:37.898347Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:37.898361Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T16:42:37.901383Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T16:42:37.901683Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:37.902017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.87:2379"} {"level":"warn","ts":"2026-04-02T16:42:56.561418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.016084ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T16:43:13.327471Z","caller":"traceutil/trace.go:171","msg":"trace[2078647665] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"111.441736ms","start":"2026-04-02T16:43:13.216009Z","end":"2026-04-02T16:43:13.327451Z","steps":["trace[2078647665] 'read index received' (duration: 111.314749ms)","trace[2078647665] 'applied index is now lower than readState.Index' (duration: 126.047µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:43:13.32762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.599485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:13.327648Z","caller":"traceutil/trace.go:171","msg":"trace[859437072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"111.687669ms","start":"2026-04-02T16:43:13.215953Z","end":"2026-04-02T16:43:13.32764Z","steps":["trace[859437072] 'agreement among raft nodes before linearized reading' (duration: 111.626476ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:13.327623Z","caller":"traceutil/trace.go:171","msg":"trace[1768067177] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"161.772698ms","start":"2026-04-02T16:43:13.165818Z","end":"2026-04-02T16:43:13.327591Z","steps":["trace[1768067177] 'process raft request' (duration: 161.516924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.294465Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14346108100963536553,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T16:43:14.373101Z","caller":"traceutil/trace.go:171","msg":"trace[1648614432] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"588.053247ms","start":"2026-04-02T16:43:13.785021Z","end":"2026-04-02T16:43:14.373074Z","steps":["trace[1648614432] 'process raft request' (duration: 580.069296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.3736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.78501Z","time spent":"588.145423ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10488,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:14.373673Z","caller":"traceutil/trace.go:171","msg":"trace[1780868305] transaction","detail":"{read_only:false; number_of_response:1; response_revision:548; }","duration":"579.911155ms","start":"2026-04-02T16:43:13.793741Z","end":"2026-04-02T16:43:14.373652Z","steps":["trace[1780868305] 'process raft request' (duration: 579.785928ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:14.373764Z","caller":"traceutil/trace.go:171","msg":"trace[113348662] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"579.780208ms","start":"2026-04-02T16:43:13.793965Z","end":"2026-04-02T16:43:14.373745Z","steps":["trace[113348662] 'process raft request' (duration: 579.620499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.373788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.793718Z","time spent":"580.006011ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10538,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:14.373845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.793959Z","time spent":"579.843182ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:14.37386Z","caller":"traceutil/trace.go:171","msg":"trace[2013591553] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"579.810759ms","start":"2026-04-02T16:43:13.79404Z","end":"2026-04-02T16:43:14.37385Z","steps":["trace[2013591553] 'process raft request' (duration: 579.644851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.373916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.794033Z","time spent":"579.850512ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":30426,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:14.373939Z","caller":"traceutil/trace.go:171","msg":"trace[1131655336] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"579.876073ms","start":"2026-04-02T16:43:13.794052Z","end":"2026-04-02T16:43:14.373928Z","steps":["trace[1131655336] 'process raft request' (duration: 579.688594ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:14.373944Z","caller":"traceutil/trace.go:171","msg":"trace[433151219] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:572; }","duration":"579.99499ms","start":"2026-04-02T16:43:13.793936Z","end":"2026-04-02T16:43:14.373931Z","steps":["trace[433151219] 'read index received' (duration: 571.200465ms)","trace[433151219] 'applied index is now lower than readState.Index' (duration: 8.793795ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:14.373989Z","caller":"traceutil/trace.go:171","msg":"trace[702644457] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"578.468258ms","start":"2026-04-02T16:43:13.795512Z","end":"2026-04-02T16:43:14.37398Z","steps":["trace[702644457] 'process raft request' (duration: 578.301489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.79404Z","time spent":"579.932976ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:14.374029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.795499Z","time spent":"578.506751ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:14.374055Z","caller":"traceutil/trace.go:171","msg":"trace[549795002] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"499.019552ms","start":"2026-04-02T16:43:13.875029Z","end":"2026-04-02T16:43:14.374048Z","steps":["trace[549795002] 'process raft request' (duration: 498.848683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.374067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.123576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"warn","ts":"2026-04-02T16:43:14.374085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.875004Z","time spent":"499.067014ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:43:14.374093Z","caller":"traceutil/trace.go:171","msg":"trace[1122964008] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:552; }","duration":"580.153288ms","start":"2026-04-02T16:43:13.793932Z","end":"2026-04-02T16:43:14.374085Z","steps":["trace[1122964008] 'agreement among raft nodes before linearized reading' (duration: 580.046512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:14.374113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:13.79392Z","time spent":"580.18826ms","remote":"127.0.0.1:52462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1037,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-02T16:43:21.257073Z","caller":"traceutil/trace.go:171","msg":"trace[1189180915] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"881.644448ms","start":"2026-04-02T16:43:20.375403Z","end":"2026-04-02T16:43:21.257047Z","steps":["trace[1189180915] 'process raft request' (duration: 881.119122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.257282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:20.375379Z","time spent":"881.787685ms","remote":"127.0.0.1:52028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:21.726271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.504455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:43:21.726443Z","caller":"traceutil/trace.go:171","msg":"trace[315977982] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"410.706751ms","start":"2026-04-02T16:43:21.31572Z","end":"2026-04-02T16:43:21.726427Z","steps":["trace[315977982] 'process raft request' (duration: 410.652158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.726522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.3157Z","time spent":"410.795525ms","remote":"127.0.0.1:52432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:43:21.726622Z","caller":"traceutil/trace.go:171","msg":"trace[460674079] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"917.148292ms","start":"2026-04-02T16:43:20.809317Z","end":"2026-04-02T16:43:21.726465Z","steps":["trace[460674079] 'read index received' (duration: 447.056463ms)","trace[460674079] 'applied index is now lower than readState.Index' (duration: 470.088239ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:21.726668Z","caller":"traceutil/trace.go:171","msg":"trace[1174651679] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.013947928s","start":"2026-04-02T16:43:20.712695Z","end":"2026-04-02T16:43:21.726643Z","steps":["trace[1174651679] 'process raft request' (duration: 903.98385ms)","trace[1174651679] 'compare' (duration: 109.322235ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:43:21.726983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.644988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8f77t\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-02T16:43:21.727053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.965926ms","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-02T16:43:21.727051Z","caller":"traceutil/trace.go:171","msg":"trace[2134771258] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8f77t; range_end:; response_count:1; response_revision:630; }","duration":"917.743263ms","start":"2026-04-02T16:43:20.809291Z","end":"2026-04-02T16:43:21.727034Z","steps":["trace[2134771258] 'agreement among raft nodes before linearized reading' (duration: 917.555053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.727027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.92968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.87\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T16:43:21.727108Z","caller":"traceutil/trace.go:171","msg":"trace[237519231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"340.050071ms","start":"2026-04-02T16:43:21.387042Z","end":"2026-04-02T16:43:21.727092Z","steps":["trace[237519231] 'agreement among raft nodes before linearized reading' (duration: 339.909584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.727119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:20.809276Z","time spent":"917.829746ms","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-8f77t\" "} {"level":"warn","ts":"2026-04-02T16:43:21.727139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.387022Z","time spent":"340.110684ms","remote":"127.0.0.1:52162","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-02T16:43:21.727154Z","caller":"traceutil/trace.go:171","msg":"trace[2073628121] range","detail":"{range_begin:/registry/masterleases/199.19.213.87; range_end:; response_count:1; response_revision:630; }","duration":"853.059597ms","start":"2026-04-02T16:43:20.874059Z","end":"2026-04-02T16:43:21.727119Z","steps":["trace[2073628121] 'agreement among raft nodes before linearized reading' (duration: 852.869607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.727232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:20.874048Z","time spent":"853.135081ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.87\" "} {"level":"warn","ts":"2026-04-02T16:43:21.72733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:20.712667Z","time spent":"1.014275575s","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:21.727433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.976837ms","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-02T16:43:21.727456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.450048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:21.727518Z","caller":"traceutil/trace.go:171","msg":"trace[1348490936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"168.094722ms","start":"2026-04-02T16:43:21.559403Z","end":"2026-04-02T16:43:21.727497Z","steps":["trace[1348490936] 'agreement among raft nodes before linearized reading' (duration: 167.878571ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:21.727567Z","caller":"traceutil/trace.go:171","msg":"trace[1050514248] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"508.576475ms","start":"2026-04-02T16:43:21.218969Z","end":"2026-04-02T16:43:21.727546Z","steps":["trace[1050514248] 'agreement among raft nodes before linearized reading' (duration: 508.375635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.727624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.218918Z","time spent":"508.69765ms","remote":"127.0.0.1:51960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T16:43:21.729071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.494029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-02T16:43:21.729154Z","caller":"traceutil/trace.go:171","msg":"trace[503818513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"790.014606ms","start":"2026-04-02T16:43:20.939121Z","end":"2026-04-02T16:43:21.729136Z","steps":["trace[503818513] 'agreement among raft nodes before linearized reading' (duration: 788.3305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:21.729205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:20.939106Z","time spent":"790.084659ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T16:43:22.565783Z","caller":"traceutil/trace.go:171","msg":"trace[1095384958] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"833.80868ms","start":"2026-04-02T16:43:21.731945Z","end":"2026-04-02T16:43:22.565754Z","steps":["trace[1095384958] 'process raft request' (duration: 794.224029ms)","trace[1095384958] 'compare' (duration: 39.356149ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:22.56595Z","caller":"traceutil/trace.go:171","msg":"trace[1870114055] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"833.772459ms","start":"2026-04-02T16:43:21.732158Z","end":"2026-04-02T16:43:22.56593Z","steps":["trace[1870114055] 'process raft request' (duration: 833.543787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.566061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.732138Z","time spent":"833.864503ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:22.565951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.731928Z","time spent":"833.940547ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:22.566267Z","caller":"traceutil/trace.go:171","msg":"trace[1458578093] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"833.859053ms","start":"2026-04-02T16:43:21.732396Z","end":"2026-04-02T16:43:22.566255Z","steps":["trace[1458578093] 'process raft request' (duration: 833.467833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.566335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.732385Z","time spent":"833.918726ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:22.566456Z","caller":"traceutil/trace.go:171","msg":"trace[251401336] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"832.294953ms","start":"2026-04-02T16:43:21.734139Z","end":"2026-04-02T16:43:22.566434Z","steps":["trace[251401336] 'process raft request' (duration: 832.03667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.566565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.734124Z","time spent":"832.386918ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:22.567215Z","caller":"traceutil/trace.go:171","msg":"trace[876269673] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:658; }","duration":"828.49947ms","start":"2026-04-02T16:43:21.738669Z","end":"2026-04-02T16:43:22.567169Z","steps":["trace[876269673] 'read index received' (duration: 37.398041ms)","trace[876269673] 'applied index is now lower than readState.Index' (duration: 791.097929ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:22.567352Z","caller":"traceutil/trace.go:171","msg":"trace[1249708407] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"823.438093ms","start":"2026-04-02T16:43:21.743643Z","end":"2026-04-02T16:43:22.567081Z","steps":["trace[1249708407] 'process raft request' (duration: 822.641793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.567458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.743621Z","time spent":"823.7827ms","remote":"127.0.0.1:52098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:22.567795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.405701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:22.56779Z","caller":"traceutil/trace.go:171","msg":"trace[1412498954] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"790.440936ms","start":"2026-04-02T16:43:21.777318Z","end":"2026-04-02T16:43:22.567759Z","steps":["trace[1412498954] 'process raft request' (duration: 789.633585ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:22.567861Z","caller":"traceutil/trace.go:171","msg":"trace[720949806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"330.499816ms","start":"2026-04-02T16:43:22.237347Z","end":"2026-04-02T16:43:22.567847Z","steps":["trace[720949806] 'agreement among raft nodes before linearized reading' (duration: 330.356428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.56784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.639907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T16:43:22.567907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:22.23733Z","time spent":"330.562199ms","remote":"127.0.0.1:51960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T16:43:22.567925Z","caller":"traceutil/trace.go:171","msg":"trace[1222283631] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:635; }","duration":"829.265579ms","start":"2026-04-02T16:43:21.738641Z","end":"2026-04-02T16:43:22.567907Z","steps":["trace[1222283631] 'agreement among raft nodes before linearized reading' (duration: 828.639077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:22.567939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.7773Z","time spent":"790.567013ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:43:22.567972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:21.738628Z","time spent":"829.329482ms","remote":"127.0.0.1:52140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-02T16:43:23.705798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.253232ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:23.70592Z","caller":"traceutil/trace.go:171","msg":"trace[170053822] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:636; }","duration":"969.389449ms","start":"2026-04-02T16:43:22.736514Z","end":"2026-04-02T16:43:23.705903Z","steps":["trace[170053822] 'range keys from in-memory index tree' (duration: 969.23904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:23.716624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14346108100963536772,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T16:43:23.757915Z","caller":"traceutil/trace.go:171","msg":"trace[354654446] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"790.123973ms","start":"2026-04-02T16:43:22.967768Z","end":"2026-04-02T16:43:23.757892Z","steps":["trace[354654446] 'process raft request' (duration: 789.370666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:23.758053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:22.967661Z","time spent":"790.322453ms","remote":"127.0.0.1:52028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:23.758265Z","caller":"traceutil/trace.go:171","msg":"trace[425330340] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"541.903625ms","start":"2026-04-02T16:43:23.216339Z","end":"2026-04-02T16:43:23.758243Z","steps":["trace[425330340] 'read index received' (duration: 540.650752ms)","trace[425330340] 'applied index is now lower than readState.Index' (duration: 1.251523ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:23.758357Z","caller":"traceutil/trace.go:171","msg":"trace[1323334389] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"125.536091ms","start":"2026-04-02T16:43:23.632786Z","end":"2026-04-02T16:43:23.758322Z","steps":["trace[1323334389] 'process raft request' (duration: 125.011355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:23.758646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.069453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:23.758751Z","caller":"traceutil/trace.go:171","msg":"trace[2139003943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"542.432352ms","start":"2026-04-02T16:43:23.2163Z","end":"2026-04-02T16:43:23.758732Z","steps":["trace[2139003943] 'agreement among raft nodes before linearized reading' (duration: 542.071124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:23.758899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:23.216261Z","time spent":"542.621371ms","remote":"127.0.0.1:51948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T16:43:25.233622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.081493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:25.2337Z","caller":"traceutil/trace.go:171","msg":"trace[940010525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:659; }","duration":"271.197809ms","start":"2026-04-02T16:43:24.962488Z","end":"2026-04-02T16:43:25.233686Z","steps":["trace[940010525] 'range keys from in-memory index tree' (duration: 271.01393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.013495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.273945ms","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-02T16:43:39.0136Z","caller":"traceutil/trace.go:171","msg":"trace[1949945464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"368.424942ms","start":"2026-04-02T16:43:38.645142Z","end":"2026-04-02T16:43:39.013567Z","steps":["trace[1949945464] 'range keys from in-memory index tree' (duration: 368.089486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.01365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:38.645114Z","time spent":"368.526347ms","remote":"127.0.0.1:52162","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-02T16:43:39.013628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.451772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:39.013709Z","caller":"traceutil/trace.go:171","msg":"trace[1084940389] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:795; }","duration":"112.541616ms","start":"2026-04-02T16:43:38.901148Z","end":"2026-04-02T16:43:39.01369Z","steps":["trace[1084940389] 'count revisions from in-memory index tree' (duration: 112.393878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.01382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.739075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:43:39.013873Z","caller":"traceutil/trace.go:171","msg":"trace[1321075936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"797.82955ms","start":"2026-04-02T16:43:38.216028Z","end":"2026-04-02T16:43:39.013858Z","steps":["trace[1321075936] 'range keys from in-memory index tree' (duration: 797.663802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.013882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.059414ms","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-02T16:43:39.013883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.198857ms","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-02T16:43:39.013931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:38.216008Z","time spent":"797.910954ms","remote":"127.0.0.1:51960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T16:43:39.013936Z","caller":"traceutil/trace.go:171","msg":"trace[509884939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:795; }","duration":"374.154569ms","start":"2026-04-02T16:43:38.639768Z","end":"2026-04-02T16:43:39.013923Z","steps":["trace[509884939] 'range keys from in-memory index tree' (duration: 373.810782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.013954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.860243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-02T16:43:39.013958Z","caller":"traceutil/trace.go:171","msg":"trace[147473816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"375.333553ms","start":"2026-04-02T16:43:38.638606Z","end":"2026-04-02T16:43:39.013939Z","steps":["trace[147473816] 'range keys from in-memory index tree' (duration: 375.027579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.01398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:38.639746Z","time spent":"374.223432ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T16:43:39.014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:38.638588Z","time spent":"375.403817ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T16:43:39.013986Z","caller":"traceutil/trace.go:171","msg":"trace[1015865533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:795; }","duration":"368.934166ms","start":"2026-04-02T16:43:38.645042Z","end":"2026-04-02T16:43:39.013977Z","steps":["trace[1015865533] 'range keys from in-memory index tree' (duration: 368.744517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:39.014058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:38.64502Z","time spent":"369.031121ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T16:43:48.086088Z","caller":"traceutil/trace.go:171","msg":"trace[1371271656] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"122.638593ms","start":"2026-04-02T16:43:47.963152Z","end":"2026-04-02T16:43:48.08579Z","steps":["trace[1371271656] 'process raft request' (duration: 42.808599ms)","trace[1371271656] 'compare' (duration: 79.704719ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:48.091813Z","caller":"traceutil/trace.go:171","msg":"trace[582895707] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"124.918523ms","start":"2026-04-02T16:43:47.966878Z","end":"2026-04-02T16:43:48.091797Z","steps":["trace[582895707] 'process raft request' (duration: 124.776046ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:48.091948Z","caller":"traceutil/trace.go:171","msg":"trace[98931412] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"120.780039ms","start":"2026-04-02T16:43:47.971157Z","end":"2026-04-02T16:43:48.091937Z","steps":["trace[98931412] 'process raft request' (duration: 120.5852ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:53.591001Z","caller":"traceutil/trace.go:171","msg":"trace[542701862] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"147.119004ms","start":"2026-04-02T16:43:53.443843Z","end":"2026-04-02T16:43:53.590962Z","steps":["trace[542701862] 'read index received' (duration: 146.866623ms)","trace[542701862] 'applied index is now lower than readState.Index' (duration: 250.881µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:53.591064Z","caller":"traceutil/trace.go:171","msg":"trace[1523196017] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"198.666214ms","start":"2026-04-02T16:43:53.392335Z","end":"2026-04-02T16:43:53.591001Z","steps":["trace[1523196017] 'process raft request' (duration: 198.410963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:53.591379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.512581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T16:43:53.591428Z","caller":"traceutil/trace.go:171","msg":"trace[1255635214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:962; }","duration":"147.633886ms","start":"2026-04-02T16:43:53.443779Z","end":"2026-04-02T16:43:53.591413Z","steps":["trace[1255635214] 'agreement among raft nodes before linearized reading' (duration: 147.367945ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:11.653447Z","caller":"traceutil/trace.go:171","msg":"trace[901517426] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"102.430925ms","start":"2026-04-02T16:45:11.550989Z","end":"2026-04-02T16:45:11.653419Z","steps":["trace[901517426] 'process raft request' (duration: 41.436419ms)","trace[901517426] 'compare' (duration: 60.840272ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:45:11.653691Z","caller":"traceutil/trace.go:171","msg":"trace[1617464277] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1288; }","duration":"101.896149ms","start":"2026-04-02T16:45:11.551758Z","end":"2026-04-02T16:45:11.653654Z","steps":["trace[1617464277] 'read index received' (duration: 12.295256ms)","trace[1617464277] 'applied index is now lower than readState.Index' (duration: 89.599462ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:45:11.653817Z","caller":"traceutil/trace.go:171","msg":"trace[1926342837] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"101.28468ms","start":"2026-04-02T16:45:11.552459Z","end":"2026-04-02T16:45:11.653744Z","steps":["trace[1926342837] 'process raft request' (duration: 100.924059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:11.653919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.139726ms","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-02T16:45:11.654009Z","caller":"traceutil/trace.go:171","msg":"trace[1139167530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1235; }","duration":"102.25813ms","start":"2026-04-02T16:45:11.551729Z","end":"2026-04-02T16:45:11.653987Z","steps":["trace[1139167530] 'agreement among raft nodes before linearized reading' (duration: 102.051883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:24.009234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.215096ms","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-02T16:45:24.00924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.148446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-02T16:45:24.009247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.576183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-02T16:45:24.009306Z","caller":"traceutil/trace.go:171","msg":"trace[56865539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1305; }","duration":"277.35386ms","start":"2026-04-02T16:45:23.731935Z","end":"2026-04-02T16:45:24.009289Z","steps":["trace[56865539] 'range keys from in-memory index tree' (duration: 276.961338ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:24.009316Z","caller":"traceutil/trace.go:171","msg":"trace[1122580402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1305; }","duration":"274.258269ms","start":"2026-04-02T16:45:23.735036Z","end":"2026-04-02T16:45:24.009295Z","steps":["trace[1122580402] 'range keys from in-memory index tree' (duration: 273.951121ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:24.009331Z","caller":"traceutil/trace.go:171","msg":"trace[460747068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1305; }","duration":"268.698756ms","start":"2026-04-02T16:45:23.740615Z","end":"2026-04-02T16:45:24.009314Z","steps":["trace[460747068] 'range keys from in-memory index tree' (duration: 268.391737ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:31.17433Z","caller":"traceutil/trace.go:171","msg":"trace[1673569646] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1394; }","duration":"229.639262ms","start":"2026-04-02T16:45:30.944662Z","end":"2026-04-02T16:45:31.174301Z","steps":["trace[1673569646] 'read index received' (duration: 229.424395ms)","trace[1673569646] 'applied index is now lower than readState.Index' (duration: 213.136µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:45:31.17448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.805357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:45:31.174538Z","caller":"traceutil/trace.go:171","msg":"trace[163429429] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1335; }","duration":"229.91896ms","start":"2026-04-02T16:45:30.944601Z","end":"2026-04-02T16:45:31.17452Z","steps":["trace[163429429] 'agreement among raft nodes before linearized reading' (duration: 229.805667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:31.426999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.706773ms","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-02T16:45:31.427104Z","caller":"traceutil/trace.go:171","msg":"trace[1126002347] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1336; }","duration":"160.849138ms","start":"2026-04-02T16:45:31.26623Z","end":"2026-04-02T16:45:31.427079Z","steps":["trace[1126002347] 'range keys from in-memory index tree' (duration: 160.608131ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:32.217726Z","caller":"traceutil/trace.go:171","msg":"trace[738135238] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1396; }","duration":"396.561015ms","start":"2026-04-02T16:45:31.821144Z","end":"2026-04-02T16:45:32.217705Z","steps":["trace[738135238] 'read index received' (duration: 396.411981ms)","trace[738135238] 'applied index is now lower than readState.Index' (duration: 148.304µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:45:32.217845Z","caller":"traceutil/trace.go:171","msg":"trace[474938052] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"516.024636ms","start":"2026-04-02T16:45:31.701798Z","end":"2026-04-02T16:45:32.217823Z","steps":["trace[474938052] 'process raft request' (duration: 515.787469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.217915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.757721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:45:32.217993Z","caller":"traceutil/trace.go:171","msg":"trace[139270216] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1337; }","duration":"396.850524ms","start":"2026-04-02T16:45:31.821127Z","end":"2026-04-02T16:45:32.217977Z","steps":["trace[139270216] 'agreement among raft nodes before linearized reading' (duration: 396.732231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.217997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:45:31.701786Z","time spent":"516.111619ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:45:32.218064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.7325ms","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-02T16:45:32.218121Z","caller":"traceutil/trace.go:171","msg":"trace[769906987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1337; }","duration":"147.798952ms","start":"2026-04-02T16:45:32.070287Z","end":"2026-04-02T16:45:32.218086Z","steps":["trace[769906987] 'agreement among raft nodes before linearized reading' (duration: 147.635077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.218022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.661458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T16:45:32.218182Z","caller":"traceutil/trace.go:171","msg":"trace[929153095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1337; }","duration":"147.836832ms","start":"2026-04-02T16:45:32.070329Z","end":"2026-04-02T16:45:32.218166Z","steps":["trace[929153095] 'agreement among raft nodes before linearized reading' (duration: 147.634237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.218268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.909985ms","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-02T16:45:32.218314Z","caller":"traceutil/trace.go:171","msg":"trace[381447705] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1337; }","duration":"147.984247ms","start":"2026-04-02T16:45:32.070323Z","end":"2026-04-02T16:45:32.218307Z","steps":["trace[381447705] 'agreement among raft nodes before linearized reading' (duration: 147.905345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.218129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:45:31.821073Z","time spent":"396.952136ms","remote":"127.0.0.1:52012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-04-02T16:45:32.49327Z","caller":"traceutil/trace.go:171","msg":"trace[1225610483] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"271.506001ms","start":"2026-04-02T16:45:32.221742Z","end":"2026-04-02T16:45:32.493248Z","steps":["trace[1225610483] 'process raft request' (duration: 229.666934ms)","trace[1225610483] 'compare' (duration: 41.731944ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:45:32.686735Z","caller":"traceutil/trace.go:171","msg":"trace[527115628] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"463.876527ms","start":"2026-04-02T16:45:32.222829Z","end":"2026-04-02T16:45:32.686706Z","steps":["trace[527115628] 'process raft request' (duration: 463.822305ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:32.686814Z","caller":"traceutil/trace.go:171","msg":"trace[1301656739] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"464.662339ms","start":"2026-04-02T16:45:32.222133Z","end":"2026-04-02T16:45:32.686796Z","steps":["trace[1301656739] 'process raft request' (duration: 464.025851ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:32.686878Z","caller":"traceutil/trace.go:171","msg":"trace[1287014554] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"464.439003ms","start":"2026-04-02T16:45:32.222389Z","end":"2026-04-02T16:45:32.686828Z","steps":["trace[1287014554] 'process raft request' (duration: 464.203257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:32.686915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:45:32.222821Z","time spent":"463.995591ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:45:32.686915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:45:32.222123Z","time spent":"464.740221ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T16:45:32.687017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:45:32.22238Z","time spent":"464.543536ms","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:45:32.690669Z","caller":"traceutil/trace.go:171","msg":"trace[1417044029] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"213.68576ms","start":"2026-04-02T16:45:32.476788Z","end":"2026-04-02T16:45:32.690474Z","steps":["trace[1417044029] 'process raft request' (duration: 213.572347ms)"],"step_count":1}