{"level":"warn","ts":"2026-03-10T18:19:39.7984Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-10T18:19:39.798494Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-03-10T18:19:39.798561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-10T18:19:39.798572Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]}
{"level":"info","ts":"2026-03-10T18:19:39.798592Z","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-03-10T18:19:39.799292Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]}
{"level":"info","ts":"2026-03-10T18:19:39.799365Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-03-10T18:19:39.803653Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.075154ms"}
{"level":"info","ts":"2026-03-10T18:19:39.812184Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"}
{"level":"info","ts":"2026-03-10T18:19:39.812266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-10T18:19:39.812287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"}
{"level":"info","ts":"2026-03-10T18:19:39.812298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-10T18:19:39.812307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"}
{"level":"info","ts":"2026-03-10T18:19:39.812346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"}
{"level":"warn","ts":"2026-03-10T18:19:39.818748Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-10T18:19:39.82051Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-10T18:19:39.821586Z","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-03-10T18:19:39.823629Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-10T18:19:39.823851Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-10T18:19:39.82391Z","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-03-10T18:19:39.823956Z","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-03-10T18:19:39.823967Z","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-03-10T18:19:39.827157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"}
{"level":"info","ts":"2026-03-10T18:19:39.827281Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]}
{"level":"info","ts":"2026-03-10T18:19:39.828138Z","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-03-10T18:19:39.828283Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"}
{"level":"info","ts":"2026-03-10T18:19:39.828331Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"}
{"level":"info","ts":"2026-03-10T18:19:39.82835Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-10T18:19:39.828386Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-10T18:19:40.312985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-10T18:19:40.313058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-10T18:19:40.313105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"}
{"level":"info","ts":"2026-03-10T18:19:40.313138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"}
{"level":"info","ts":"2026-03-10T18:19:40.31316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"}
{"level":"info","ts":"2026-03-10T18:19:40.313188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"}
{"level":"info","ts":"2026-03-10T18:19:40.313264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"}
{"level":"info","ts":"2026-03-10T18:19:40.314656Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-10T18:19:40.316174Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-10T18:19:40.316357Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-10T18:19:40.316411Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-10T18:19:40.316475Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-10T18:19:40.316595Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-10T18:19:40.316562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-10T18:19:40.316897Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-10T18:19:40.31697Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-10T18:19:40.319943Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-10T18:19:40.322496Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"}
{"level":"info","ts":"2026-03-10T18:19:41.599005Z","caller":"traceutil/trace.go:171","msg":"trace[734177829] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"105.618764ms","start":"2026-03-10T18:19:41.493345Z","end":"2026-03-10T18:19:41.598964Z","steps":["trace[734177829] 'process raft request'  (duration: 105.398709ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.599398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.598433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.598976Z","caller":"traceutil/trace.go:171","msg":"trace[768123894] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"104.190994ms","start":"2026-03-10T18:19:41.494762Z","end":"2026-03-10T18:19:41.598953Z","steps":["trace[768123894] 'read index received'  (duration: 104.129753ms)","trace[768123894] 'applied index is now lower than readState.Index'  (duration: 60.131µs)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:19:41.599514Z","caller":"traceutil/trace.go:171","msg":"trace[134994010] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:2; }","duration":"104.754155ms","start":"2026-03-10T18:19:41.494747Z","end":"2026-03-10T18:19:41.599501Z","steps":["trace[134994010] 'agreement among raft nodes before linearized reading'  (duration: 104.357878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.828743Z","caller":"traceutil/trace.go:171","msg":"trace[724050233] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"254.272146ms","start":"2026-03-10T18:19:41.574409Z","end":"2026-03-10T18:19:41.828681Z","steps":["trace[724050233] 'process raft request'  (duration: 193.736207ms)","trace[724050233] 'compare'  (duration: 60.309114ms)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:19:41.829008Z","caller":"traceutil/trace.go:171","msg":"trace[604724644] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"251.468399ms","start":"2026-03-10T18:19:41.577364Z","end":"2026-03-10T18:19:41.828832Z","steps":["trace[604724644] 'process raft request'  (duration: 251.221514ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.829023Z","caller":"traceutil/trace.go:171","msg":"trace[1650199367] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"251.434328ms","start":"2026-03-10T18:19:41.577559Z","end":"2026-03-10T18:19:41.828994Z","steps":["trace[1650199367] 'process raft request'  (duration: 251.079661ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.830557Z","caller":"traceutil/trace.go:171","msg":"trace[1260195127] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"230.887407ms","start":"2026-03-10T18:19:41.599616Z","end":"2026-03-10T18:19:41.830504Z","steps":["trace[1260195127] 'read index received'  (duration: 168.559601ms)","trace[1260195127] 'applied index is now lower than readState.Index'  (duration: 62.274085ms)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:19:41.831339Z","caller":"traceutil/trace.go:171","msg":"trace[1615047985] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"253.516201ms","start":"2026-03-10T18:19:41.577651Z","end":"2026-03-10T18:19:41.831167Z","steps":["trace[1615047985] 'process raft request'  (duration: 251.102942ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.833007Z","caller":"traceutil/trace.go:171","msg":"trace[252701953] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"249.865046ms","start":"2026-03-10T18:19:41.58284Z","end":"2026-03-10T18:19:41.832705Z","steps":["trace[252701953] 'process raft request'  (duration: 247.417666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.833028Z","caller":"traceutil/trace.go:171","msg":"trace[1534757073] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"255.018832ms","start":"2026-03-10T18:19:41.57771Z","end":"2026-03-10T18:19:41.832729Z","steps":["trace[1534757073] 'process raft request'  (duration: 252.416228ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.833881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.300312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.833955Z","caller":"traceutil/trace.go:171","msg":"trace[616288272] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:0; response_revision:10; }","duration":"261.396653ms","start":"2026-03-10T18:19:41.572536Z","end":"2026-03-10T18:19:41.833933Z","steps":["trace[616288272] 'agreement among raft nodes before linearized reading'  (duration: 260.523184ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.83437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.660666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.834438Z","caller":"traceutil/trace.go:171","msg":"trace[65753734] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"279.732038ms","start":"2026-03-10T18:19:41.554683Z","end":"2026-03-10T18:19:41.834415Z","steps":["trace[65753734] 'agreement among raft nodes before linearized reading'  (duration: 279.37458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.833019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.658796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.834983Z","caller":"traceutil/trace.go:171","msg":"trace[1181328031] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"261.488494ms","start":"2026-03-10T18:19:41.573308Z","end":"2026-03-10T18:19:41.834796Z","steps":["trace[1181328031] 'agreement among raft nodes before linearized reading'  (duration: 258.86019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.835329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.278238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-10T18:19:41.835344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.469494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-10T18:19:41.835469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.694927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.835521Z","caller":"traceutil/trace.go:171","msg":"trace[1948799255] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"257.809149ms","start":"2026-03-10T18:19:41.577696Z","end":"2026-03-10T18:19:41.835505Z","steps":["trace[1948799255] 'process raft request'  (duration: 251.086241ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.835566Z","caller":"traceutil/trace.go:171","msg":"trace[1726163727] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"280.890151ms","start":"2026-03-10T18:19:41.554639Z","end":"2026-03-10T18:19:41.83553Z","steps":["trace[1726163727] 'agreement among raft nodes before linearized reading'  (duration: 280.750188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.835809Z","caller":"traceutil/trace.go:171","msg":"trace[2009478121] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"338.355959ms","start":"2026-03-10T18:19:41.497014Z","end":"2026-03-10T18:19:41.83537Z","steps":["trace[2009478121] 'agreement among raft nodes before linearized reading'  (duration: 338.257217ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.835833Z","caller":"traceutil/trace.go:171","msg":"trace[74385107] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"260.602416ms","start":"2026-03-10T18:19:41.574783Z","end":"2026-03-10T18:19:41.835386Z","steps":["trace[74385107] 'agreement among raft nodes before linearized reading'  (duration: 256.630455ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.835892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-10T18:19:41.497002Z","time spent":"338.846698ms","remote":"127.0.0.1:42594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-03-10T18:19:41.840191Z","caller":"traceutil/trace.go:171","msg":"trace[1162899706] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"242.240699ms","start":"2026-03-10T18:19:41.593151Z","end":"2026-03-10T18:19:41.835392Z","steps":["trace[1162899706] 'process raft request'  (duration: 237.165795ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:41.844177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.064676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-10T18:19:41.844182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.139247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:41.844227Z","caller":"traceutil/trace.go:171","msg":"trace[268262312] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"218.171968ms","start":"2026-03-10T18:19:41.626033Z","end":"2026-03-10T18:19:41.844205Z","steps":["trace[268262312] 'agreement among raft nodes before linearized reading'  (duration: 218.069406ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.84432Z","caller":"traceutil/trace.go:171","msg":"trace[457921877] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"200.135038ms","start":"2026-03-10T18:19:41.644074Z","end":"2026-03-10T18:19:41.844209Z","steps":["trace[457921877] 'agreement among raft nodes before linearized reading'  (duration: 200.009295ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:41.844533Z","caller":"traceutil/trace.go:171","msg":"trace[1592889053] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"243.331433ms","start":"2026-03-10T18:19:41.600732Z","end":"2026-03-10T18:19:41.844063Z","steps":["trace[1592889053] 'process raft request'  (duration: 243.280872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.070872Z","caller":"traceutil/trace.go:171","msg":"trace[1024948246] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"232.673015ms","start":"2026-03-10T18:19:41.83817Z","end":"2026-03-10T18:19:42.070843Z","steps":["trace[1024948246] 'process raft request'  (duration: 232.562463ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.070996Z","caller":"traceutil/trace.go:171","msg":"trace[1392035983] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:14; }","duration":"226.890907ms","start":"2026-03-10T18:19:41.844084Z","end":"2026-03-10T18:19:42.070975Z","steps":["trace[1392035983] 'read index received'  (duration: 155.143698ms)","trace[1392035983] 'applied index is now lower than readState.Index'  (duration: 71.746149ms)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:19:42.071129Z","caller":"traceutil/trace.go:171","msg":"trace[871528917] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"231.53578ms","start":"2026-03-10T18:19:41.839579Z","end":"2026-03-10T18:19:42.071115Z","steps":["trace[871528917] 'process raft request'  (duration: 231.185893ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071111Z","caller":"traceutil/trace.go:171","msg":"trace[595639408] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"235.780929ms","start":"2026-03-10T18:19:41.8353Z","end":"2026-03-10T18:19:42.07108Z","steps":["trace[595639408] 'process raft request'  (duration: 163.973019ms)","trace[595639408] 'compare'  (duration: 71.33868ms)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:19:42.071226Z","caller":"traceutil/trace.go:171","msg":"trace[324862172] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"230.704664ms","start":"2026-03-10T18:19:41.840479Z","end":"2026-03-10T18:19:42.071184Z","steps":["trace[324862172] 'process raft request'  (duration: 230.390788ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071245Z","caller":"traceutil/trace.go:171","msg":"trace[1075800147] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"231.579412ms","start":"2026-03-10T18:19:41.839651Z","end":"2026-03-10T18:19:42.07123Z","steps":["trace[1075800147] 'process raft request'  (duration: 231.187524ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:42.071365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.192654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-brwrt\" ","response":"range_response_count:1 size:861"}
{"level":"warn","ts":"2026-03-10T18:19:42.071436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.250037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-10T18:19:42.071441Z","caller":"traceutil/trace.go:171","msg":"trace[855914772] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"231.789906ms","start":"2026-03-10T18:19:41.839637Z","end":"2026-03-10T18:19:42.071427Z","steps":["trace[855914772] 'process raft request'  (duration: 231.159763ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071454Z","caller":"traceutil/trace.go:171","msg":"trace[1521241266] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-brwrt; range_end:; response_count:1; response_revision:18; }","duration":"229.304916ms","start":"2026-03-10T18:19:41.84213Z","end":"2026-03-10T18:19:42.071435Z","steps":["trace[1521241266] 'agreement among raft nodes before linearized reading'  (duration: 229.064681ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071468Z","caller":"traceutil/trace.go:171","msg":"trace[908320242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"233.288507ms","start":"2026-03-10T18:19:41.838168Z","end":"2026-03-10T18:19:42.071456Z","steps":["trace[908320242] 'agreement among raft nodes before linearized reading'  (duration: 233.250987ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071676Z","caller":"traceutil/trace.go:171","msg":"trace[695067864] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"231.102623ms","start":"2026-03-10T18:19:41.840563Z","end":"2026-03-10T18:19:42.071666Z","steps":["trace[695067864] 'process raft request'  (duration: 230.377438ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:42.071394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.599392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"}
{"level":"info","ts":"2026-03-10T18:19:42.071782Z","caller":"traceutil/trace.go:171","msg":"trace[1020408727] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"231.242495ms","start":"2026-03-10T18:19:41.840522Z","end":"2026-03-10T18:19:42.071764Z","steps":["trace[1020408727] 'process raft request'  (duration: 230.393377ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.071822Z","caller":"traceutil/trace.go:171","msg":"trace[1928286893] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"232.052341ms","start":"2026-03-10T18:19:41.839757Z","end":"2026-03-10T18:19:42.071809Z","steps":["trace[1928286893] 'agreement among raft nodes before linearized reading'  (duration: 231.577322ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:19:42.072065Z","caller":"traceutil/trace.go:171","msg":"trace[620614671] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"227.684713ms","start":"2026-03-10T18:19:41.844358Z","end":"2026-03-10T18:19:42.072043Z","steps":["trace[620614671] 'process raft request'  (duration: 227.580251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:19:42.07213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.398709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-03-10T18:19:42.072181Z","caller":"traceutil/trace.go:171","msg":"trace[835089730] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"169.461901ms","start":"2026-03-10T18:19:41.902707Z","end":"2026-03-10T18:19:42.072169Z","steps":["trace[835089730] 'agreement among raft nodes before linearized reading'  (duration: 169.333198ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:20:14.549817Z","caller":"traceutil/trace.go:171","msg":"trace[1711896281] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"328.992779ms","start":"2026-03-10T18:20:14.2208Z","end":"2026-03-10T18:20:14.549793Z","steps":["trace[1711896281] 'process raft request'  (duration: 328.838836ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:20:14.55026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-10T18:20:14.22078Z","time spent":"329.115681ms","remote":"127.0.0.1:42386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gms8w\" mod_revision:506 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gms8w\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gms8w\" > >"}
{"level":"warn","ts":"2026-03-10T18:20:34.693162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.947858ms","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-03-10T18:20:34.693264Z","caller":"traceutil/trace.go:171","msg":"trace[765101870] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:719; }","duration":"172.111701ms","start":"2026-03-10T18:20:34.521132Z","end":"2026-03-10T18:20:34.693243Z","steps":["trace[765101870] 'range keys from in-memory index tree'  (duration: 171.682714ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:21:00.67287Z","caller":"traceutil/trace.go:171","msg":"trace[2034090230] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"142.082704ms","start":"2026-03-10T18:21:00.530764Z","end":"2026-03-10T18:21:00.672847Z","steps":["trace[2034090230] 'read index received'  (duration: 141.977822ms)","trace[2034090230] 'applied index is now lower than readState.Index'  (duration: 104.182µs)"],"step_count":2}
{"level":"info","ts":"2026-03-10T18:21:00.672996Z","caller":"traceutil/trace.go:171","msg":"trace[937237946] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"158.112264ms","start":"2026-03-10T18:21:00.514875Z","end":"2026-03-10T18:21:00.672987Z","steps":["trace[937237946] 'process raft request'  (duration: 157.823208ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:21:00.673187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.407161ms","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-03-10T18:21:00.673207Z","caller":"traceutil/trace.go:171","msg":"trace[352900394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"142.444652ms","start":"2026-03-10T18:21:00.530756Z","end":"2026-03-10T18:21:00.673201Z","steps":["trace[352900394] 'agreement among raft nodes before linearized reading'  (duration: 142.34172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:21:12.408897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.170055ms","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-03-10T18:21:12.40898Z","caller":"traceutil/trace.go:171","msg":"trace[1290045632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:878; }","duration":"174.296048ms","start":"2026-03-10T18:21:12.234667Z","end":"2026-03-10T18:21:12.408963Z","steps":["trace[1290045632] 'range keys from in-memory index tree'  (duration: 174.011152ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:21:28.596969Z","caller":"traceutil/trace.go:171","msg":"trace[38373512] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:988; }","duration":"113.219777ms","start":"2026-03-10T18:21:28.483718Z","end":"2026-03-10T18:21:28.596938Z","steps":["trace[38373512] 'read index received'  (duration: 67.062811ms)","trace[38373512] 'applied index is now lower than readState.Index'  (duration: 46.155106ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-10T18:21:28.59731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.579114ms","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-03-10T18:21:28.597351Z","caller":"traceutil/trace.go:171","msg":"trace[1739126748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:951; }","duration":"113.676246ms","start":"2026-03-10T18:21:28.483663Z","end":"2026-03-10T18:21:28.59734Z","steps":["trace[1739126748] 'agreement among raft nodes before linearized reading'  (duration: 113.450312ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:21:28.748477Z","caller":"traceutil/trace.go:171","msg":"trace[1723682969] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"147.576048ms","start":"2026-03-10T18:21:28.600877Z","end":"2026-03-10T18:21:28.748453Z","steps":["trace[1723682969] 'process raft request'  (duration: 147.115229ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:21:29.388378Z","caller":"traceutil/trace.go:171","msg":"trace[280352917] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"161.955474ms","start":"2026-03-10T18:21:29.226385Z","end":"2026-03-10T18:21:29.38834Z","steps":["trace[280352917] 'process raft request'  (duration: 161.798181ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-10T18:21:29.571383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.308848ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398339257293712430 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-10T18:21:29.571558Z","caller":"traceutil/trace.go:171","msg":"trace[1384870318] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"176.505473ms","start":"2026-03-10T18:21:29.395031Z","end":"2026-03-10T18:21:29.571536Z","steps":["trace[1384870318] 'process raft request'  (duration: 176.448801ms)"],"step_count":1}
{"level":"info","ts":"2026-03-10T18:21:29.571617Z","caller":"traceutil/trace.go:171","msg":"trace[1099051344] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"177.331479ms","start":"2026-03-10T18:21:29.394256Z","end":"2026-03-10T18:21:29.571588Z","steps":["trace[1099051344] 'process raft request'  (duration: 63.607742ms)","trace[1099051344] 'compare'  (duration: 113.131274ms)"],"step_count":2}