{"level":"warn","ts":"2026-03-18T00:43:49.237676Z","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-18T00:43:49.237798Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-18T00:43:49.237895Z","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-18T00:43:49.237916Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]}
{"level":"info","ts":"2026-03-18T00:43:49.237974Z","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-18T00:43:49.238934Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]}
{"level":"info","ts":"2026-03-18T00:43:49.239049Z","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.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-18T00:43:49.242737Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.411312ms"}
{"level":"info","ts":"2026-03-18T00:43:49.250088Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"}
{"level":"info","ts":"2026-03-18T00:43:49.250173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:43:49.250217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:43:49.250235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:43:49.250248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:43:49.250298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"}
{"level":"warn","ts":"2026-03-18T00:43:49.255161Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:43:49.256361Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:43:49.258568Z","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-18T00:43:49.261661Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:43:49.261798Z","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-18T00:43:49.261947Z","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-18T00:43:49.26196Z","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-18T00:43:49.262231Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:43:49.268562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"}
{"level":"info","ts":"2026-03-18T00:43:49.268887Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]}
{"level":"info","ts":"2026-03-18T00:43:49.27496Z","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-18T00:43:49.275147Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:43:49.275179Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:43:49.275179Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"}
{"level":"info","ts":"2026-03-18T00:43:49.275289Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"}
{"level":"info","ts":"2026-03-18T00:43:49.55132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:43:49.551482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:43:49.551525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"}
{"level":"info","ts":"2026-03-18T00:43:49.551555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:43:49.55157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"}
{"level":"info","ts":"2026-03-18T00:43:49.551587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:43:49.551608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"}
{"level":"info","ts":"2026-03-18T00:43:49.552493Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:43:49.552866Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:43:49.552972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:43:49.553021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:43:49.553473Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:43:49.553623Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:43:49.553666Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:43:49.554841Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"}
{"level":"info","ts":"2026-03-18T00:43:49.55532Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:43:49.555336Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:43:49.556458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-18T00:43:53.270927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.305642ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15036002922378199837 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:node-proxier\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:node-proxier\" value_size:649 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-03-18T00:43:53.271158Z","caller":"traceutil/trace.go:171","msg":"trace[1069616968] linearizableReadLoop","detail":"{readStateIndex:107; appliedIndex:106; }","duration":"196.285684ms","start":"2026-03-18T00:43:53.074849Z","end":"2026-03-18T00:43:53.271135Z","steps":["trace[1069616968] 'read index received'  (duration: 65.982µs)","trace[1069616968] 'applied index is now lower than readState.Index'  (duration: 196.217962ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:43:53.27129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.438907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-18T00:43:53.271354Z","caller":"traceutil/trace.go:171","msg":"trace[1814035460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:103; }","duration":"196.54834ms","start":"2026-03-18T00:43:53.074794Z","end":"2026-03-18T00:43:53.271342Z","steps":["trace[1814035460] 'agreement among raft nodes before linearized reading'  (duration: 196.432497ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:53.271383Z","caller":"traceutil/trace.go:171","msg":"trace[243456519] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"1.114278485s","start":"2026-03-18T00:43:52.157022Z","end":"2026-03-18T00:43:53.2713Z","steps":["trace[243456519] 'process raft request'  (duration: 314.01582ms)","trace[243456519] 'compare'  (duration: 799.122267ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:43:53.271685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:52.156999Z","time spent":"1.114532922s","remote":"127.0.0.1:60322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":699,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:node-proxier\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:node-proxier\" value_size:649 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:43:53.886102Z","caller":"traceutil/trace.go:171","msg":"trace[1597452903] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"609.264895ms","start":"2026-03-18T00:43:53.276786Z","end":"2026-03-18T00:43:53.886051Z","steps":["trace[1597452903] 'process raft request'  (duration: 538.583726ms)","trace[1597452903] 'compare'  (duration: 70.362971ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:43:53.886592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:53.276756Z","time spent":"609.48925ms","remote":"127.0.0.1:60322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1368,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:kube-scheduler\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:kube-scheduler\" value_size:1316 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:43:56.375944Z","caller":"traceutil/trace.go:171","msg":"trace[1490114223] linearizableReadLoop","detail":"{readStateIndex:238; appliedIndex:236; }","duration":"161.657724ms","start":"2026-03-18T00:43:56.214258Z","end":"2026-03-18T00:43:56.375916Z","steps":["trace[1490114223] 'read index received'  (duration: 74.874078ms)","trace[1490114223] 'applied index is now lower than readState.Index'  (duration: 86.782056ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:56.376038Z","caller":"traceutil/trace.go:171","msg":"trace[91032260] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"190.358288ms","start":"2026-03-18T00:43:56.185617Z","end":"2026-03-18T00:43:56.375975Z","steps":["trace[91032260] 'process raft request'  (duration: 103.346276ms)","trace[91032260] 'compare'  (duration: 86.697444ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:56.376057Z","caller":"traceutil/trace.go:171","msg":"trace[635185093] transaction","detail":"{read_only:false; number_of_response:0; response_revision:231; }","duration":"166.206014ms","start":"2026-03-18T00:43:56.209806Z","end":"2026-03-18T00:43:56.376012Z","steps":["trace[635185093] 'process raft request'  (duration: 166.047671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:56.376185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.532444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-03-18T00:43:56.376238Z","caller":"traceutil/trace.go:171","msg":"trace[307218389] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:231; }","duration":"229.612896ms","start":"2026-03-18T00:43:56.146613Z","end":"2026-03-18T00:43:56.376226Z","steps":["trace[307218389] 'agreement among raft nodes before linearized reading'  (duration: 229.450722ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.38102Z","caller":"traceutil/trace.go:171","msg":"trace[1511861923] transaction","detail":"{read_only:false; number_of_response:0; response_revision:232; }","duration":"145.930795ms","start":"2026-03-18T00:43:56.235076Z","end":"2026-03-18T00:43:56.381007Z","steps":["trace[1511861923] 'process raft request'  (duration: 145.777051ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.380994Z","caller":"traceutil/trace.go:171","msg":"trace[1879219669] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"162.420063ms","start":"2026-03-18T00:43:56.218532Z","end":"2026-03-18T00:43:56.380952Z","steps":["trace[1879219669] 'process raft request'  (duration: 162.141486ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.381147Z","caller":"traceutil/trace.go:171","msg":"trace[402838844] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"145.634328ms","start":"2026-03-18T00:43:56.235495Z","end":"2026-03-18T00:43:56.38113Z","steps":["trace[402838844] 'process raft request'  (duration: 145.404872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.38118Z","caller":"traceutil/trace.go:171","msg":"trace[815936411] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"144.824768ms","start":"2026-03-18T00:43:56.236339Z","end":"2026-03-18T00:43:56.381164Z","steps":["trace[815936411] 'process raft request'  (duration: 144.726665ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.381289Z","caller":"traceutil/trace.go:171","msg":"trace[383533007] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"145.393131ms","start":"2026-03-18T00:43:56.235876Z","end":"2026-03-18T00:43:56.381269Z","steps":["trace[383533007] 'process raft request'  (duration: 145.097704ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.381321Z","caller":"traceutil/trace.go:171","msg":"trace[1486084552] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"145.35618ms","start":"2026-03-18T00:43:56.235954Z","end":"2026-03-18T00:43:56.38131Z","steps":["trace[1486084552] 'process raft request'  (duration: 145.074953ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:56.381546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.117611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"}
{"level":"info","ts":"2026-03-18T00:43:56.381604Z","caller":"traceutil/trace.go:171","msg":"trace[783245571] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:234; }","duration":"161.236254ms","start":"2026-03-18T00:43:56.220352Z","end":"2026-03-18T00:43:56.381589Z","steps":["trace[783245571] 'agreement among raft nodes before linearized reading'  (duration: 161.040769ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.53179Z","caller":"traceutil/trace.go:171","msg":"trace[659316183] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:248; }","duration":"114.025074ms","start":"2026-03-18T00:43:56.417707Z","end":"2026-03-18T00:43:56.531732Z","steps":["trace[659316183] 'read index received'  (duration: 14.91638ms)","trace[659316183] 'applied index is now lower than readState.Index'  (duration: 99.106683ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:56.531809Z","caller":"traceutil/trace.go:171","msg":"trace[2053785924] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"114.174707ms","start":"2026-03-18T00:43:56.417552Z","end":"2026-03-18T00:43:56.531727Z","steps":["trace[2053785924] 'process raft request'  (duration: 98.679563ms)","trace[2053785924] 'compare'  (duration: 15.192647ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:56.531939Z","caller":"traceutil/trace.go:171","msg":"trace[1321758023] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"109.109625ms","start":"2026-03-18T00:43:56.422815Z","end":"2026-03-18T00:43:56.531924Z","steps":["trace[1321758023] 'process raft request'  (duration: 108.822458ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:56.531965Z","caller":"traceutil/trace.go:171","msg":"trace[1459419150] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"113.824169ms","start":"2026-03-18T00:43:56.418057Z","end":"2026-03-18T00:43:56.531881Z","steps":["trace[1459419150] 'process raft request'  (duration: 113.535202ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:56.532366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.458795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:43:56.532509Z","caller":"traceutil/trace.go:171","msg":"trace[2071012066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:242; }","duration":"114.802933ms","start":"2026-03-18T00:43:56.417649Z","end":"2026-03-18T00:43:56.532452Z","steps":["trace[2071012066] 'agreement among raft nodes before linearized reading'  (duration: 114.398913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:56.5353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.922464ms","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-03-18T00:43:56.535433Z","caller":"traceutil/trace.go:171","msg":"trace[2093851098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:243; }","duration":"117.124489ms","start":"2026-03-18T00:43:56.418293Z","end":"2026-03-18T00:43:56.535417Z","steps":["trace[2093851098] 'agreement among raft nodes before linearized reading'  (duration: 116.920224ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:07.42309Z","caller":"traceutil/trace.go:171","msg":"trace[481922213] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"130.587828ms","start":"2026-03-18T00:44:07.292476Z","end":"2026-03-18T00:44:07.423064Z","steps":["trace[481922213] 'process raft request'  (duration: 130.477106ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.139179Z","caller":"traceutil/trace.go:171","msg":"trace[1444150646] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"152.069145ms","start":"2026-03-18T00:44:07.987074Z","end":"2026-03-18T00:44:08.139144Z","steps":["trace[1444150646] 'process raft request'  (duration: 82.792266ms)","trace[1444150646] 'compare'  (duration: 69.102925ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:44:08.140756Z","caller":"traceutil/trace.go:171","msg":"trace[1099717750] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:408; }","duration":"104.610812ms","start":"2026-03-18T00:44:08.036124Z","end":"2026-03-18T00:44:08.140735Z","steps":["trace[1099717750] 'read index received'  (duration: 33.626181ms)","trace[1099717750] 'applied index is now lower than readState.Index'  (duration: 70.983691ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:44:08.140912Z","caller":"traceutil/trace.go:171","msg":"trace[1746314495] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"149.554145ms","start":"2026-03-18T00:44:07.991334Z","end":"2026-03-18T00:44:08.140888Z","steps":["trace[1746314495] 'process raft request'  (duration: 149.274099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.141056Z","caller":"traceutil/trace.go:171","msg":"trace[1798284773] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"144.079343ms","start":"2026-03-18T00:44:07.996963Z","end":"2026-03-18T00:44:08.141042Z","steps":["trace[1798284773] 'process raft request'  (duration: 143.699844ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.141103Z","caller":"traceutil/trace.go:171","msg":"trace[1627260089] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"151.551843ms","start":"2026-03-18T00:44:07.989544Z","end":"2026-03-18T00:44:08.141096Z","steps":["trace[1627260089] 'process raft request'  (duration: 150.918658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.141175Z","caller":"traceutil/trace.go:171","msg":"trace[659463524] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"142.650658ms","start":"2026-03-18T00:44:07.998513Z","end":"2026-03-18T00:44:08.141164Z","steps":["trace[659463524] 'process raft request'  (duration: 142.185737ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:44:08.141297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.154855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:44:08.141313Z","caller":"traceutil/trace.go:171","msg":"trace[1741154964] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"150.733293ms","start":"2026-03-18T00:44:07.990573Z","end":"2026-03-18T00:44:08.141306Z","steps":["trace[1741154964] 'process raft request'  (duration: 149.986875ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.141329Z","caller":"traceutil/trace.go:171","msg":"trace[554521770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"105.224176ms","start":"2026-03-18T00:44:08.036094Z","end":"2026-03-18T00:44:08.141318Z","steps":["trace[554521770] 'agreement among raft nodes before linearized reading'  (duration: 105.158144ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:08.335344Z","caller":"traceutil/trace.go:171","msg":"trace[1574095276] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"106.661231ms","start":"2026-03-18T00:44:08.228654Z","end":"2026-03-18T00:44:08.335316Z","steps":["trace[1574095276] 'process raft request'  (duration: 88.830191ms)","trace[1574095276] 'compare'  (duration: 17.724337ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:44:20.396803Z","caller":"traceutil/trace.go:171","msg":"trace[38451577] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"124.988128ms","start":"2026-03-18T00:44:20.271789Z","end":"2026-03-18T00:44:20.396777Z","steps":["trace[38451577] 'process raft request'  (duration: 124.843025ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:20.764743Z","caller":"traceutil/trace.go:171","msg":"trace[430571771] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"158.796062ms","start":"2026-03-18T00:44:20.605915Z","end":"2026-03-18T00:44:20.764711Z","steps":["trace[430571771] 'process raft request'  (duration: 158.551996ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:24.577029Z","caller":"traceutil/trace.go:171","msg":"trace[2060430958] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"164.707244ms","start":"2026-03-18T00:44:24.412284Z","end":"2026-03-18T00:44:24.576991Z","steps":["trace[2060430958] 'process raft request'  (duration: 164.486658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:26.738311Z","caller":"traceutil/trace.go:171","msg":"trace[883309473] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"152.801316ms","start":"2026-03-18T00:44:26.585479Z","end":"2026-03-18T00:44:26.73828Z","steps":["trace[883309473] 'process raft request'  (duration: 152.608942ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:27.22821Z","caller":"traceutil/trace.go:171","msg":"trace[1638903509] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"114.73389ms","start":"2026-03-18T00:44:27.113448Z","end":"2026-03-18T00:44:27.228182Z","steps":["trace[1638903509] 'process raft request'  (duration: 114.598807ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:27.636197Z","caller":"traceutil/trace.go:171","msg":"trace[717248339] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"393.754252ms","start":"2026-03-18T00:44:27.242421Z","end":"2026-03-18T00:44:27.636175Z","steps":["trace[717248339] 'process raft request'  (duration: 393.633909ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:44:27.636469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:44:27.242398Z","time spent":"393.857185ms","remote":"127.0.0.1:60172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-84tn5\" mod_revision:458 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-84tn5\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-84tn5\" > >"}
{"level":"info","ts":"2026-03-18T00:44:28.43398Z","caller":"traceutil/trace.go:171","msg":"trace[1691029816] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"396.630261ms","start":"2026-03-18T00:44:28.037325Z","end":"2026-03-18T00:44:28.433955Z","steps":["trace[1691029816] 'read index received'  (duration: 396.371795ms)","trace[1691029816] 'applied index is now lower than readState.Index'  (duration: 257.376µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:44:28.434101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.754824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:44:28.434098Z","caller":"traceutil/trace.go:171","msg":"trace[1032347900] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"613.020427ms","start":"2026-03-18T00:44:27.821042Z","end":"2026-03-18T00:44:28.434062Z","steps":["trace[1032347900] 'process raft request'  (duration: 612.775411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:28.434163Z","caller":"traceutil/trace.go:171","msg":"trace[1082613993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"396.842197ms","start":"2026-03-18T00:44:28.037282Z","end":"2026-03-18T00:44:28.434125Z","steps":["trace[1082613993] 'agreement among raft nodes before linearized reading'  (duration: 396.768495ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:44:28.434223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:44:28.037264Z","time spent":"396.950069ms","remote":"127.0.0.1:60018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T00:44:28.434286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:44:27.821014Z","time spent":"613.187231ms","remote":"127.0.0.1:60246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:501 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-18T00:44:29.183458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.021839ms","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-03-18T00:44:29.183534Z","caller":"traceutil/trace.go:171","msg":"trace[1563437995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"303.135772ms","start":"2026-03-18T00:44:28.880381Z","end":"2026-03-18T00:44:29.183516Z","steps":["trace[1563437995] 'range keys from in-memory index tree'  (duration: 302.848725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:44:29.183574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:44:28.880366Z","time spent":"303.199773ms","remote":"127.0.0.1:60246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-18T00:44:29.183692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.64377ms","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-18T00:44:29.183748Z","caller":"traceutil/trace.go:171","msg":"trace[1561575851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"440.748022ms","start":"2026-03-18T00:44:28.742987Z","end":"2026-03-18T00:44:29.183735Z","steps":["trace[1561575851] 'range keys from in-memory index tree'  (duration: 440.512896ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:44:29.183824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:44:28.742967Z","time spent":"440.848855ms","remote":"127.0.0.1:60246","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-03-18T00:44:30.633576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.699448ms","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-03-18T00:44:30.633671Z","caller":"traceutil/trace.go:171","msg":"trace[1895237120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"195.864651ms","start":"2026-03-18T00:44:30.437786Z","end":"2026-03-18T00:44:30.633651Z","steps":["trace[1895237120] 'range keys from in-memory index tree'  (duration: 195.517853ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:44:30.6388Z","caller":"traceutil/trace.go:171","msg":"trace[1737006467] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"138.166594ms","start":"2026-03-18T00:44:30.500612Z","end":"2026-03-18T00:44:30.638778Z","steps":["trace[1737006467] 'process raft request'  (duration: 137.932848ms)"],"step_count":1}