{"level":"warn","ts":"2026-07-21T13:15:02.208725Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:15:02.208831Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.213: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.213:2380","--initial-cluster=instance=https://199.19.213.213:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.213:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.213: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-07-21T13:15:02.20894Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T13:15:02.208954Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.213:2380"]} {"level":"info","ts":"2026-07-21T13:15:02.208984Z","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-07-21T13:15:02.210121Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"]} {"level":"info","ts":"2026-07-21T13:15:02.210225Z","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.213:2380"],"listen-peer-urls":["https://199.19.213.213:2380"],"advertise-client-urls":["https://199.19.213.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.213: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-07-21T13:15:02.290827Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"80.197223ms"} {"level":"info","ts":"2026-07-21T13:15:02.362114Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3faf6a3dfbe0100","cluster-id":"4c2e50e35fb92a79"} {"level":"info","ts":"2026-07-21T13:15:02.362343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T13:15:02.362383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became follower at term 0"} {"level":"info","ts":"2026-07-21T13:15:02.362405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3faf6a3dfbe0100 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T13:15:02.362425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became follower at term 1"} {"level":"info","ts":"2026-07-21T13:15:02.362493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=(17580635279088025856)"} {"level":"warn","ts":"2026-07-21T13:15:02.46385Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T13:15:02.467764Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T13:15:02.480204Z","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-07-21T13:15:02.486168Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3faf6a3dfbe0100","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T13:15:02.486733Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3faf6a3dfbe0100","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T13:15:02.487028Z","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-07-21T13:15:02.487078Z","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-07-21T13:15:02.487104Z","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-07-21T13:15:02.489105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 switched to configuration voters=(17580635279088025856)"} {"level":"info","ts":"2026-07-21T13:15:02.489281Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4c2e50e35fb92a79","local-member-id":"f3faf6a3dfbe0100","added-peer-id":"f3faf6a3dfbe0100","added-peer-peer-urls":["https://199.19.213.213:2380"]} {"level":"info","ts":"2026-07-21T13:15:02.491993Z","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-07-21T13:15:02.492148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.213:2380"} {"level":"info","ts":"2026-07-21T13:15:02.492173Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.213:2380"} {"level":"info","ts":"2026-07-21T13:15:02.492432Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3faf6a3dfbe0100","initial-advertise-peer-urls":["https://199.19.213.213:2380"],"listen-peer-urls":["https://199.19.213.213:2380"],"advertise-client-urls":["https://199.19.213.213:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.213:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T13:15:02.492587Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T13:15:02.963554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T13:15:02.963703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T13:15:02.963779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 received MsgPreVoteResp from f3faf6a3dfbe0100 at term 1"} {"level":"info","ts":"2026-07-21T13:15:02.963827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became candidate at term 2"} {"level":"info","ts":"2026-07-21T13:15:02.963875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 received MsgVoteResp from f3faf6a3dfbe0100 at term 2"} {"level":"info","ts":"2026-07-21T13:15:02.963965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3faf6a3dfbe0100 became leader at term 2"} {"level":"info","ts":"2026-07-21T13:15:02.964049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3faf6a3dfbe0100 elected leader f3faf6a3dfbe0100 at term 2"} {"level":"info","ts":"2026-07-21T13:15:02.966054Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:15:02.966828Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3faf6a3dfbe0100","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.213:2379]}","request-path":"/0/members/f3faf6a3dfbe0100/attributes","cluster-id":"4c2e50e35fb92a79","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T13:15:02.967019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:15:02.967056Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T13:15:02.967346Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4c2e50e35fb92a79","local-member-id":"f3faf6a3dfbe0100","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:15:02.967488Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:15:02.967575Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T13:15:02.97049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T13:15:02.9708Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.213:2379"} {"level":"info","ts":"2026-07-21T13:15:02.977442Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T13:15:02.977464Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T13:15:21.298516Z","caller":"traceutil/trace.go:171","msg":"trace[1856445262] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"920.634365ms","start":"2026-07-21T13:15:20.377865Z","end":"2026-07-21T13:15:21.298499Z","steps":["trace[1856445262] 'process raft request' (duration: 920.489993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:21.299049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:20.377848Z","time spent":"920.784188ms","remote":"127.0.0.1:51354","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-07-21T13:15:22.706446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825022834,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:23.207151Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825022834,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:23.301614Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.718274806s","expected-duration":"1s"} {"level":"info","ts":"2026-07-21T13:15:23.308094Z","caller":"traceutil/trace.go:171","msg":"trace[2009157398] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"1.10236388s","start":"2026-07-21T13:15:22.205708Z","end":"2026-07-21T13:15:23.308072Z","steps":["trace[2009157398] 'read index received' (duration: 1.10232961s)","trace[2009157398] 'applied index is now lower than readState.Index' (duration: 33.35µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:15:23.308209Z","caller":"traceutil/trace.go:171","msg":"trace[641212729] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"1.724952087s","start":"2026-07-21T13:15:21.583241Z","end":"2026-07-21T13:15:23.308193Z","steps":["trace[641212729] 'process raft request' (duration: 1.724705223s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:23.308297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:21.583223Z","time spent":"1.725006028s","remote":"127.0.0.1:51354","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-07-21T13:15:23.308269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.983806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:15:23.308379Z","caller":"traceutil/trace.go:171","msg":"trace[1834861784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:378; }","duration":"978.127599ms","start":"2026-07-21T13:15:22.330232Z","end":"2026-07-21T13:15:23.308359Z","steps":["trace[1834861784] 'agreement among raft nodes before linearized reading' (duration: 977.980137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:23.30842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:22.330216Z","time spent":"978.19209ms","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T13:15:23.308525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102815248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-21T13:15:23.308548Z","caller":"traceutil/trace.go:171","msg":"trace[1508470281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:378; }","duration":"1.102872659s","start":"2026-07-21T13:15:22.205669Z","end":"2026-07-21T13:15:23.308542Z","steps":["trace[1508470281] 'agreement among raft nodes before linearized reading' (duration: 1.102830828s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:23.308565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:22.205653Z","time spent":"1.102907959s","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T13:15:27.586416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.09724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:15:27.586589Z","caller":"traceutil/trace.go:171","msg":"trace[2102839559] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"223.278739ms","start":"2026-07-21T13:15:27.363276Z","end":"2026-07-21T13:15:27.586554Z","steps":["trace[2102839559] 'process raft request' (duration: 50.790862ms)","trace[2102839559] 'compare' (duration: 171.977328ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:15:27.58667Z","caller":"traceutil/trace.go:171","msg":"trace[1949781968] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"222.869241ms","start":"2026-07-21T13:15:27.363766Z","end":"2026-07-21T13:15:27.586635Z","steps":["trace[1949781968] 'process raft request' (duration: 222.78053ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:27.586657Z","caller":"traceutil/trace.go:171","msg":"trace[291704571] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"223.166026ms","start":"2026-07-21T13:15:27.363458Z","end":"2026-07-21T13:15:27.586624Z","steps":["trace[291704571] 'read index received' (duration: 50.573998ms)","trace[291704571] 'applied index is now lower than readState.Index' (duration: 172.589358ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:27.586814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.333198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:15:27.586862Z","caller":"traceutil/trace.go:171","msg":"trace[1613203924] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:390; }","duration":"223.40324ms","start":"2026-07-21T13:15:27.363447Z","end":"2026-07-21T13:15:27.58685Z","steps":["trace[1613203924] 'agreement among raft nodes before linearized reading' (duration: 223.284698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:41.924646Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825022983,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-21T13:15:42.20951Z","caller":"traceutil/trace.go:171","msg":"trace[2145155852] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"785.946253ms","start":"2026-07-21T13:15:41.423524Z","end":"2026-07-21T13:15:42.20947Z","steps":["trace[2145155852] 'read index received' (duration: 772.649226ms)","trace[2145155852] 'applied index is now lower than readState.Index' (duration: 13.295146ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:42.209841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.547608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-21T13:15:42.209806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.237537ms","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-07-21T13:15:42.209959Z","caller":"traceutil/trace.go:171","msg":"trace[250745977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"786.41579ms","start":"2026-07-21T13:15:41.423517Z","end":"2026-07-21T13:15:42.209933Z","steps":["trace[250745977] 'agreement among raft nodes before linearized reading' (duration: 786.094015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:42.209967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.187774ms","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-07-21T13:15:42.210013Z","caller":"traceutil/trace.go:171","msg":"trace[1885952484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:449; }","duration":"514.290096ms","start":"2026-07-21T13:15:41.695712Z","end":"2026-07-21T13:15:42.210002Z","steps":["trace[1885952484] 'agreement among raft nodes before linearized reading' (duration: 514.194074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:42.210028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:41.423462Z","time spent":"786.551152ms","remote":"127.0.0.1:51354","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-07-21T13:15:42.21006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:41.695697Z","time spent":"514.350187ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-21T13:15:42.209885Z","caller":"traceutil/trace.go:171","msg":"trace[92262003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"523.668319ms","start":"2026-07-21T13:15:41.686203Z","end":"2026-07-21T13:15:42.209871Z","steps":["trace[92262003] 'agreement among raft nodes before linearized reading' (duration: 523.521667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:42.210333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:41.686181Z","time spent":"524.141267ms","remote":"127.0.0.1:51354","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-07-21T13:15:42.210506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.30242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:15:42.210584Z","caller":"traceutil/trace.go:171","msg":"trace[566373076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:449; }","duration":"508.431341ms","start":"2026-07-21T13:15:41.70214Z","end":"2026-07-21T13:15:42.210572Z","steps":["trace[566373076] 'agreement among raft nodes before linearized reading' (duration: 507.721529ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:42.211212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:41.702123Z","time spent":"509.054302ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:15:48.543723Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.206915808s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-21T13:15:48.55086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.080409ms","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-07-21T13:15:48.552111Z","caller":"traceutil/trace.go:171","msg":"trace[1573520680] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:521; }","duration":"461.361779ms","start":"2026-07-21T13:15:48.090739Z","end":"2026-07-21T13:15:48.552101Z","steps":["trace[1573520680] 'range keys from in-memory index tree' (duration: 460.061819ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:48.551283Z","caller":"traceutil/trace.go:171","msg":"trace[259916390] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.225766462s","start":"2026-07-21T13:15:47.325444Z","end":"2026-07-21T13:15:48.551211Z","steps":["trace[259916390] 'process raft request' (duration: 1.218498114s)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:48.551503Z","caller":"traceutil/trace.go:171","msg":"trace[1295221120] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:541; }","duration":"1.218637907s","start":"2026-07-21T13:15:47.332847Z","end":"2026-07-21T13:15:48.551485Z","steps":["trace[1295221120] 'read index received' (duration: 3.942123ms)","trace[1295221120] 'applied index is now lower than readState.Index' (duration: 1.214695183s)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:48.5523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:47.325423Z","time spent":"1.226803779s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:15:48.551589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218726818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:15:48.552354Z","caller":"traceutil/trace.go:171","msg":"trace[67709326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:524; }","duration":"1.219524551s","start":"2026-07-21T13:15:47.332823Z","end":"2026-07-21T13:15:48.552347Z","steps":["trace[67709326] 'agreement among raft nodes before linearized reading' (duration: 1.218718248s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:48.552387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:47.332812Z","time spent":"1.219559512s","remote":"127.0.0.1:51106","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-07-21T13:15:48.5517Z","caller":"traceutil/trace.go:171","msg":"trace[260648936] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.222588141s","start":"2026-07-21T13:15:47.329104Z","end":"2026-07-21T13:15:48.551692Z","steps":["trace[260648936] 'process raft request' (duration: 1.222276526s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:48.552529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:47.329081Z","time spent":"1.223416704s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:48.551721Z","caller":"traceutil/trace.go:171","msg":"trace[1963234416] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.218561585s","start":"2026-07-21T13:15:47.333154Z","end":"2026-07-21T13:15:48.551715Z","steps":["trace[1963234416] 'process raft request' (duration: 1.218278091s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:48.552632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:47.333143Z","time spent":"1.21944458s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:15:48.551977Z","caller":"traceutil/trace.go:171","msg":"trace[1379684186] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"709.333842ms","start":"2026-07-21T13:15:47.842621Z","end":"2026-07-21T13:15:48.551955Z","steps":["trace[1379684186] 'process raft request' (duration: 709.22684ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:48.552697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:47.842604Z","time spent":"710.082305ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T13:15:48.552531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.767002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-21T13:15:48.552765Z","caller":"traceutil/trace.go:171","msg":"trace[166616615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"296.026728ms","start":"2026-07-21T13:15:48.256732Z","end":"2026-07-21T13:15:48.552758Z","steps":["trace[166616615] 'agreement among raft nodes before linearized reading' (duration: 295.670111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:49.678743Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:50.179698Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:50.680476Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:51.181664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:51.682262Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:52.182515Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:52.334329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.007287159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-21T13:15:52.336013Z","caller":"traceutil/trace.go:171","msg":"trace[398448708] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.009058978s","start":"2026-07-21T13:15:50.326935Z","end":"2026-07-21T13:15:52.335994Z","steps":["trace[398448708] 'agreement among raft nodes before linearized reading' (duration: 2.007330099s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:52.336061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.326909Z","time spent":"2.009141719s","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/21 13:15:52 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-21T13:15:52.683106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:54.243054Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":72232986825023126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-21T13:15:54.334276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.998399312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-21T13:15:54.334351Z","caller":"traceutil/trace.go:171","msg":"trace[1748005549] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.998491523s","start":"2026-07-21T13:15:52.335844Z","end":"2026-07-21T13:15:54.334335Z","steps":["trace[1748005549] 'agreement among raft nodes before linearized reading' (duration: 1.998396582s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.334417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:52.335782Z","time spent":"1.998625465s","remote":"127.0.0.1:51114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/21 13:15:54 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-21T13:15:54.334707Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.521500823s","expected-duration":"1s"} {"level":"info","ts":"2026-07-21T13:15:54.352873Z","caller":"traceutil/trace.go:171","msg":"trace[871649565] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"5.539782537s","start":"2026-07-21T13:15:48.813062Z","end":"2026-07-21T13:15:54.352844Z","steps":["trace[871649565] 'process raft request' (duration: 5.52188843s)","trace[871649565] 'compare' (duration: 17.030994ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:54.353073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:48.813044Z","time spent":"5.539952551s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:15:54.36188Z","caller":"traceutil/trace.go:171","msg":"trace[968489969] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"5.540784293s","start":"2026-07-21T13:15:48.821069Z","end":"2026-07-21T13:15:54.361853Z","steps":["trace[968489969] 'process raft request' (duration: 5.540527869s)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:54.361904Z","caller":"traceutil/trace.go:171","msg":"trace[330589364] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"5.526583374s","start":"2026-07-21T13:15:48.835294Z","end":"2026-07-21T13:15:54.361877Z","steps":["trace[330589364] 'process raft request' (duration: 5.526419751s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.362029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:48.821044Z","time spent":"5.540900865s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:15:54.362031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:48.835264Z","time spent":"5.526703485s","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:54.362153Z","caller":"traceutil/trace.go:171","msg":"trace[1031295687] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"4.547044089s","start":"2026-07-21T13:15:49.815097Z","end":"2026-07-21T13:15:54.362141Z","steps":["trace[1031295687] 'process raft request' (duration: 4.546708323s)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:54.362184Z","caller":"traceutil/trace.go:171","msg":"trace[1897383331] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"4.071692505s","start":"2026-07-21T13:15:50.29048Z","end":"2026-07-21T13:15:54.362173Z","steps":["trace[1897383331] 'process raft request' (duration: 4.07136171s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.362199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:49.815079Z","time spent":"4.547094359s","remote":"127.0.0.1:51354","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-07-21T13:15:54.36222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.29045Z","time spent":"4.071750916s","remote":"127.0.0.1:51182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":846,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:54.397038Z","caller":"traceutil/trace.go:171","msg":"trace[661990781] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:571; }","duration":"5.218816197s","start":"2026-07-21T13:15:49.178197Z","end":"2026-07-21T13:15:54.397013Z","steps":["trace[661990781] 'read index received' (duration: 5.156766119s)","trace[661990781] 'applied index is now lower than readState.Index' (duration: 62.045398ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:54.397342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.219128212s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-21T13:15:54.397388Z","caller":"traceutil/trace.go:171","msg":"trace[1847574345] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:555; }","duration":"5.219214523s","start":"2026-07-21T13:15:49.178163Z","end":"2026-07-21T13:15:54.397377Z","steps":["trace[1847574345] 'agreement among raft nodes before linearized reading' (duration: 5.218966849s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.397923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:49.178147Z","time spent":"5.219760722s","remote":"127.0.0.1:51204","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":"warn","ts":"2026-07-21T13:15:54.39824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.107491421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-qmc7x\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-07-21T13:15:54.398308Z","caller":"traceutil/trace.go:171","msg":"trace[1807627245] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-qmc7x; range_end:; response_count:1; response_revision:556; }","duration":"4.107630444s","start":"2026-07-21T13:15:50.290664Z","end":"2026-07-21T13:15:54.398294Z","steps":["trace[1807627245] 'agreement among raft nodes before linearized reading' (duration: 4.107491101s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.398344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.290655Z","time spent":"4.107681554s","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4706,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-qmc7x\" "} {"level":"warn","ts":"2026-07-21T13:15:54.398359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.812344389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-21T13:15:54.398484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.823280965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-21T13:15:54.398517Z","caller":"traceutil/trace.go:171","msg":"trace[1337055968] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"3.823374017s","start":"2026-07-21T13:15:50.575133Z","end":"2026-07-21T13:15:54.398507Z","steps":["trace[1337055968] 'agreement among raft nodes before linearized reading' (duration: 3.823314716s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.398543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.575002Z","time spent":"3.823535149s","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T13:15:54.398551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.812515872s","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-07-21T13:15:54.398645Z","caller":"traceutil/trace.go:171","msg":"trace[291469185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"3.812667374s","start":"2026-07-21T13:15:50.585962Z","end":"2026-07-21T13:15:54.398629Z","steps":["trace[291469185] 'agreement among raft nodes before linearized reading' (duration: 3.81239614s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.398701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.585956Z","time spent":"3.812736345s","remote":"127.0.0.1:51354","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-07-21T13:15:54.398738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.809090615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-21T13:15:54.398772Z","caller":"traceutil/trace.go:171","msg":"trace[1465966627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"3.812765316s","start":"2026-07-21T13:15:50.585995Z","end":"2026-07-21T13:15:54.398761Z","steps":["trace[1465966627] 'agreement among raft nodes before linearized reading' (duration: 3.812308269s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.398815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.585987Z","time spent":"3.812816537s","remote":"127.0.0.1:51354","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":"info","ts":"2026-07-21T13:15:54.398812Z","caller":"traceutil/trace.go:171","msg":"trace[1655308938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"3.809196558s","start":"2026-07-21T13:15:50.589598Z","end":"2026-07-21T13:15:54.398795Z","steps":["trace[1655308938] 'agreement among raft nodes before linearized reading' (duration: 3.809032525s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:54.398857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:50.589592Z","time spent":"3.809256508s","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-21T13:15:55.620908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.05299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T13:15:55.621067Z","caller":"traceutil/trace.go:171","msg":"trace[1892440411] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"500.112528ms","start":"2026-07-21T13:15:55.12093Z","end":"2026-07-21T13:15:55.621042Z","steps":["trace[1892440411] 'process raft request' (duration: 210.832104ms)","trace[1892440411] 'compare' (duration: 288.700164ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:15:55.621212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:55.120913Z","time spent":"500.24557ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T13:15:55.622549Z","caller":"traceutil/trace.go:171","msg":"trace[1356309639] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"481.518739ms","start":"2026-07-21T13:15:55.141001Z","end":"2026-07-21T13:15:55.622519Z","steps":["trace[1356309639] 'process raft request' (duration: 481.107893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:55.622724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:55.140981Z","time spent":"481.682932ms","remote":"127.0.0.1:51588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:55.623858Z","caller":"traceutil/trace.go:171","msg":"trace[1999432836] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"326.727135ms","start":"2026-07-21T13:15:55.297086Z","end":"2026-07-21T13:15:55.623813Z","steps":["trace[1999432836] 'process raft request' (duration: 326.676464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:55.623971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:55.297063Z","time spent":"326.856187ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:55.624276Z","caller":"traceutil/trace.go:171","msg":"trace[385392515] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"420.654053ms","start":"2026-07-21T13:15:55.20359Z","end":"2026-07-21T13:15:55.624244Z","steps":["trace[385392515] 'process raft request' (duration: 418.877184ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:15:55.624515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:15:55.203563Z","time spent":"420.793034ms","remote":"127.0.0.1:51160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-21T13:15:55.631379Z","caller":"traceutil/trace.go:171","msg":"trace[684204035] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"141.064234ms","start":"2026-07-21T13:15:55.490277Z","end":"2026-07-21T13:15:55.631341Z","steps":["trace[684204035] 'process raft request' (duration: 141.033223ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:55.631544Z","caller":"traceutil/trace.go:171","msg":"trace[58125062] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"297.686998ms","start":"2026-07-21T13:15:55.333849Z","end":"2026-07-21T13:15:55.631536Z","steps":["trace[58125062] 'process raft request' (duration: 297.131059ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:15:59.549084Z","caller":"traceutil/trace.go:171","msg":"trace[126093622] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"193.506774ms","start":"2026-07-21T13:15:59.355548Z","end":"2026-07-21T13:15:59.549055Z","steps":["trace[126093622] 'process raft request' (duration: 188.005816ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:16:02.435268Z","caller":"traceutil/trace.go:171","msg":"trace[1377112531] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"105.670694ms","start":"2026-07-21T13:16:02.329546Z","end":"2026-07-21T13:16:02.435217Z","steps":["trace[1377112531] 'read index received' (duration: 105.493351ms)","trace[1377112531] 'applied index is now lower than readState.Index' (duration: 174.373µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T13:16:02.435397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.831657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:16:02.435369Z","caller":"traceutil/trace.go:171","msg":"trace[1646471513] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"144.753178ms","start":"2026-07-21T13:16:02.29056Z","end":"2026-07-21T13:16:02.435313Z","steps":["trace[1646471513] 'process raft request' (duration: 144.470983ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:16:02.435603Z","caller":"traceutil/trace.go:171","msg":"trace[1528656036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"105.935848ms","start":"2026-07-21T13:16:02.329486Z","end":"2026-07-21T13:16:02.435421Z","steps":["trace[1528656036] 'agreement among raft nodes before linearized reading' (duration: 105.861127ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:16:16.545437Z","caller":"traceutil/trace.go:171","msg":"trace[840518748] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"172.923161ms","start":"2026-07-21T13:16:16.37249Z","end":"2026-07-21T13:16:16.545413Z","steps":["trace[840518748] 'process raft request' (duration: 172.722298ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T13:16:19.588308Z","caller":"traceutil/trace.go:171","msg":"trace[1666144447] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"488.781269ms","start":"2026-07-21T13:16:19.0995Z","end":"2026-07-21T13:16:19.588281Z","steps":["trace[1666144447] 'read index received' (duration: 488.619687ms)","trace[1666144447] 'applied index is now lower than readState.Index' (duration: 160.432µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T13:16:19.588446Z","caller":"traceutil/trace.go:171","msg":"trace[1293270005] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"875.090985ms","start":"2026-07-21T13:16:18.713343Z","end":"2026-07-21T13:16:19.588434Z","steps":["trace[1293270005] 'process raft request' (duration: 874.781121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:16:19.58856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:16:18.713328Z","time spent":"875.139336ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T13:16:19.58859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.77727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:16:19.588932Z","caller":"traceutil/trace.go:171","msg":"trace[1596373325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"258.933863ms","start":"2026-07-21T13:16:19.329754Z","end":"2026-07-21T13:16:19.588688Z","steps":["trace[1596373325] 'agreement among raft nodes before linearized reading' (duration: 258.763251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:16:19.589127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.562952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T13:16:19.589205Z","caller":"traceutil/trace.go:171","msg":"trace[2006903417] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:790; }","duration":"489.723685ms","start":"2026-07-21T13:16:19.099458Z","end":"2026-07-21T13:16:19.589181Z","steps":["trace[2006903417] 'agreement among raft nodes before linearized reading' (duration: 489.541402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:16:19.589248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:16:19.099442Z","time spent":"489.796056ms","remote":"127.0.0.1:51196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/envoy-gateway\" "} {"level":"info","ts":"2026-07-21T13:17:43.260048Z","caller":"traceutil/trace.go:171","msg":"trace[1482198447] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"309.00936ms","start":"2026-07-21T13:17:42.950992Z","end":"2026-07-21T13:17:43.260002Z","steps":["trace[1482198447] 'process raft request' (duration: 308.679405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T13:17:43.260891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T13:17:42.950973Z","time spent":"309.837933ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}