{"level":"warn","ts":"2026-03-14T01:25:37.93496Z","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-14T01:25:37.935049Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-14T01:25:37.935115Z","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-14T01:25:37.935129Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-03-14T01:25:37.935148Z","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-14T01:25:37.935933Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]}
{"level":"info","ts":"2026-03-14T01:25:37.93602Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-14T01:25:38.708698Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"772.459641ms"}
{"level":"info","ts":"2026-03-14T01:25:38.761221Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"}
{"level":"info","ts":"2026-03-14T01:25:38.761296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-14T01:25:38.761315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"}
{"level":"info","ts":"2026-03-14T01:25:38.761343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-14T01:25:38.761362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"}
{"level":"info","ts":"2026-03-14T01:25:38.761413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"warn","ts":"2026-03-14T01:25:38.864039Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-14T01:25:38.8705Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-14T01:25:38.891548Z","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-14T01:25:38.907945Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-14T01:25:38.908078Z","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-14T01:25:38.908194Z","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-14T01:25:38.908206Z","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-14T01:25:38.908273Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-14T01:25:38.91075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"}
{"level":"info","ts":"2026-03-14T01:25:38.91151Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]}
{"level":"info","ts":"2026-03-14T01:25:38.913328Z","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-14T01:25:38.91358Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-14T01:25:38.913615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-14T01:25:38.913753Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-03-14T01:25:38.913765Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"}
{"level":"info","ts":"2026-03-14T01:25:39.461827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-14T01:25:39.461911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-14T01:25:39.461948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"}
{"level":"info","ts":"2026-03-14T01:25:39.461985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"}
{"level":"info","ts":"2026-03-14T01:25:39.461999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-03-14T01:25:39.462026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"}
{"level":"info","ts":"2026-03-14T01:25:39.462042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"}
{"level":"info","ts":"2026-03-14T01:25:39.470756Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:39.472757Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:25:39.472755Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-14T01:25:39.472786Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-14T01:25:39.473172Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-14T01:25:39.473237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-14T01:25:39.473478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:39.473593Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:39.473633Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-14T01:25:39.476022Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-14T01:25:39.476848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"}
{"level":"warn","ts":"2026-03-14T01:25:41.520805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.184498ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774337992 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/flowschemas/kube-scheduler\" mod_revision:58 > success:<request_put:<key:\"/registry/flowschemas/kube-scheduler\" value_size:1045 >> failure:<request_range:<key:\"/registry/flowschemas/kube-scheduler\" > >>","response":"size:14"}
{"level":"info","ts":"2026-03-14T01:25:41.521569Z","caller":"traceutil/trace.go:171","msg":"trace[2112910000] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"242.071895ms","start":"2026-03-14T01:25:41.279436Z","end":"2026-03-14T01:25:41.521508Z","steps":["trace[2112910000] 'process raft request'  (duration: 77.179892ms)","trace[2112910000] 'compare'  (duration: 161.731025ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:41.523416Z","caller":"traceutil/trace.go:171","msg":"trace[1913286314] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"242.449268ms","start":"2026-03-14T01:25:41.280946Z","end":"2026-03-14T01:25:41.523395Z","steps":["trace[1913286314] 'process raft request'  (duration: 240.307116ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:42.603194Z","caller":"traceutil/trace.go:171","msg":"trace[1791256404] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"109.894691ms","start":"2026-03-14T01:25:42.493267Z","end":"2026-03-14T01:25:42.603162Z","steps":["trace[1791256404] 'process raft request'  (duration: 50.431661ms)","trace[1791256404] 'compare'  (duration: 59.337019ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:43.716254Z","caller":"traceutil/trace.go:171","msg":"trace[729269849] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"121.553441ms","start":"2026-03-14T01:25:43.594673Z","end":"2026-03-14T01:25:43.716226Z","steps":["trace[729269849] 'process raft request'  (duration: 45.158939ms)","trace[729269849] 'compare'  (duration: 76.235531ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:44.808872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.727727ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338239 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" value_size:579 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:44.808978Z","caller":"traceutil/trace.go:171","msg":"trace[461457978] linearizableReadLoop","detail":"{readStateIndex:190; appliedIndex:189; }","duration":"846.97019ms","start":"2026-03-14T01:25:43.961992Z","end":"2026-03-14T01:25:44.808962Z","steps":["trace[461457978] 'read index received'  (duration: 62.641µs)","trace[461457978] 'applied index is now lower than readState.Index'  (duration: 846.906529ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:44.809122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.125711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:44.809166Z","caller":"traceutil/trace.go:171","msg":"trace[977303936] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"1.026771853s","start":"2026-03-14T01:25:43.782191Z","end":"2026-03-14T01:25:44.808963Z","steps":["trace[977303936] 'process raft request'  (duration: 67.879545ms)","trace[977303936] 'compare'  (duration: 958.549646ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:44.809311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.214421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:25:44.809982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:43.782176Z","time spent":"1.027751828s","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" value_size:579 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:25:44.81014Z","caller":"traceutil/trace.go:171","msg":"trace[1990521903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:186; }","duration":"227.053296ms","start":"2026-03-14T01:25:44.583004Z","end":"2026-03-14T01:25:44.810057Z","steps":["trace[1990521903] 'agreement among raft nodes before linearized reading'  (duration: 226.137621ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:44.810167Z","caller":"traceutil/trace.go:171","msg":"trace[1699159957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:186; }","duration":"848.161326ms","start":"2026-03-14T01:25:43.961918Z","end":"2026-03-14T01:25:44.81008Z","steps":["trace[1699159957] 'agreement among raft nodes before linearized reading'  (duration: 847.13798ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:44.811056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:43.961886Z","time spent":"848.597778ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-14T01:25:45.318125Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757019042774338242,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:25:45.84913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.501889ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338243 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:45.849248Z","caller":"traceutil/trace.go:171","msg":"trace[1267465604] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"1.032821629s","start":"2026-03-14T01:25:44.816405Z","end":"2026-03-14T01:25:45.849227Z","steps":["trace[1267465604] 'process raft request'  (duration: 543.138059ms)","trace[1267465604] 'compare'  (duration: 487.890791ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:45.849302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:44.816389Z","time spent":"1.03289127s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:25:46.780198Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.420689073s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-14T01:25:46.861233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000019384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-14T01:25:46.861356Z","caller":"traceutil/trace.go:171","msg":"trace[847802434] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000196736s","start":"2026-03-14T01:25:44.861136Z","end":"2026-03-14T01:25:46.861333Z","steps":["trace[847802434] 'agreement among raft nodes before linearized reading'  (duration: 2.000043395s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:46.861408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:44.861126Z","time spent":"2.000270506s","remote":"127.0.0.1:39246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-14T01:25:46.93625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.799745ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338245 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:34239ce9f2f14ac4>","response":"size:40"}
{"level":"info","ts":"2026-03-14T01:25:46.936479Z","caller":"traceutil/trace.go:171","msg":"trace[106993460] linearizableReadLoop","detail":"{readStateIndex:193; appliedIndex:190; }","duration":"2.119070043s","start":"2026-03-14T01:25:44.817391Z","end":"2026-03-14T01:25:46.936461Z","steps":["trace[106993460] 'read index received'  (duration: 542.131473ms)","trace[106993460] 'applied index is now lower than readState.Index'  (duration: 1.57693774s)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:46.93648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.063184Z","time spent":"1.873291726s","remote":"127.0.0.1:39332","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-14T01:25:46.936543Z","caller":"traceutil/trace.go:171","msg":"trace[1384424455] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"1.675565818s","start":"2026-03-14T01:25:45.260969Z","end":"2026-03-14T01:25:46.936535Z","steps":["trace[1384424455] 'process raft request'  (duration: 1.675394047s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:46.936627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.26094Z","time spent":"1.675632948s","remote":"127.0.0.1:39450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3911 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:25:46.936781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.119362685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-14T01:25:46.936876Z","caller":"traceutil/trace.go:171","msg":"trace[1323278354] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:188; }","duration":"2.119473855s","start":"2026-03-14T01:25:44.817381Z","end":"2026-03-14T01:25:46.936854Z","steps":["trace[1323278354] 'agreement among raft nodes before linearized reading'  (duration: 2.119216364s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:46.936984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:44.817367Z","time spent":"2.119605786s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-14T01:25:47.198179Z","caller":"traceutil/trace.go:171","msg":"trace[1976584899] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"1.49332505s","start":"2026-03-14T01:25:45.704802Z","end":"2026-03-14T01:25:47.198127Z","steps":["trace[1976584899] 'process raft request'  (duration: 1.490351074s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:47.198216Z","caller":"traceutil/trace.go:171","msg":"trace[1222441366] linearizableReadLoop","detail":"{readStateIndex:194; appliedIndex:193; }","duration":"261.665092ms","start":"2026-03-14T01:25:46.936509Z","end":"2026-03-14T01:25:47.198174Z","steps":["trace[1222441366] 'read index received'  (duration: 258.639426ms)","trace[1222441366] 'applied index is now lower than readState.Index'  (duration: 3.022686ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:47.198262Z","caller":"traceutil/trace.go:171","msg":"trace[771712758] transaction","detail":"{read_only:false; response_revision:192; number_of_response:1; }","duration":"257.991812ms","start":"2026-03-14T01:25:46.940234Z","end":"2026-03-14T01:25:47.198225Z","steps":["trace[771712758] 'process raft request'  (duration: 257.931362ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.704782Z","time spent":"1.4934771s","remote":"127.0.0.1:39450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5819 >> failure:<>"}
{"level":"warn","ts":"2026-03-14T01:25:47.198417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29175008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-14T01:25:47.198461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.09857732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-14T01:25:47.198505Z","caller":"traceutil/trace.go:171","msg":"trace[1213885313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:192; }","duration":"2.098677731s","start":"2026-03-14T01:25:45.099814Z","end":"2026-03-14T01:25:47.198492Z","steps":["trace[1213885313] 'agreement among raft nodes before linearized reading'  (duration: 2.09847565s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.068253255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:47.198518Z","caller":"traceutil/trace.go:171","msg":"trace[1134049201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:192; }","duration":"1.291880261s","start":"2026-03-14T01:25:45.906609Z","end":"2026-03-14T01:25:47.198489Z","steps":["trace[1134049201] 'agreement among raft nodes before linearized reading'  (duration: 1.291621469s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.0998Z","time spent":"2.098736891s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-14T01:25:47.198558Z","caller":"traceutil/trace.go:171","msg":"trace[1455963440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:192; }","duration":"2.068370576s","start":"2026-03-14T01:25:45.130167Z","end":"2026-03-14T01:25:47.198537Z","steps":["trace[1455963440] 'agreement among raft nodes before linearized reading'  (duration: 2.068249125s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.130154Z","time spent":"2.068448396s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-14T01:25:47.198616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.053806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:25:47.198648Z","caller":"traceutil/trace.go:171","msg":"trace[1566505285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:192; }","duration":"336.118596ms","start":"2026-03-14T01:25:46.86252Z","end":"2026-03-14T01:25:47.198638Z","steps":["trace[1566505285] 'agreement among raft nodes before linearized reading'  (duration: 336.074496ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:46.8625Z","time spent":"336.167727ms","remote":"127.0.0.1:39248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-14T01:25:47.19868Z","caller":"traceutil/trace.go:171","msg":"trace[1725290576] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"260.069394ms","start":"2026-03-14T01:25:46.938598Z","end":"2026-03-14T01:25:47.198668Z","steps":["trace[1725290576] 'process raft request'  (duration: 259.527301ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.09843518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-03-14T01:25:47.198763Z","caller":"traceutil/trace.go:171","msg":"trace[2080124996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:192; }","duration":"2.09848296s","start":"2026-03-14T01:25:45.100272Z","end":"2026-03-14T01:25:47.198755Z","steps":["trace[2080124996] 'agreement among raft nodes before linearized reading'  (duration: 2.09843337s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.100257Z","time spent":"2.09853124s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-14T01:25:47.198819Z","caller":"traceutil/trace.go:171","msg":"trace[2027454990] transaction","detail":"{read_only:false; response_revision:190; number_of_response:1; }","duration":"260.312175ms","start":"2026-03-14T01:25:46.938496Z","end":"2026-03-14T01:25:47.198808Z","steps":["trace[2027454990] 'process raft request'  (duration: 259.559111ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346063236s","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-14T01:25:47.198862Z","caller":"traceutil/trace.go:171","msg":"trace[1374363887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:192; }","duration":"1.346141767s","start":"2026-03-14T01:25:45.85271Z","end":"2026-03-14T01:25:47.198851Z","steps":["trace[1374363887] 'agreement among raft nodes before linearized reading'  (duration: 1.346063636s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.852691Z","time spent":"1.346191437s","remote":"127.0.0.1:39532","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-03-14T01:25:47.198957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.013147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"}
{"level":"info","ts":"2026-03-14T01:25:47.198989Z","caller":"traceutil/trace.go:171","msg":"trace[1725246250] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:192; }","duration":"779.087317ms","start":"2026-03-14T01:25:46.419893Z","end":"2026-03-14T01:25:47.19898Z","steps":["trace[1725246250] 'agreement among raft nodes before linearized reading'  (duration: 779.014697ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:47.198568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:45.906598Z","time spent":"1.291962661s","remote":"127.0.0.1:39246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-14T01:25:47.199016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:25:46.419876Z","time spent":"779.133997ms","remote":"127.0.0.1:39450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "}
{"level":"info","ts":"2026-03-14T01:25:48.233096Z","caller":"traceutil/trace.go:171","msg":"trace[1018145971] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"117.070507ms","start":"2026-03-14T01:25:48.115996Z","end":"2026-03-14T01:25:48.233067Z","steps":["trace[1018145971] 'process raft request'  (duration: 117.005797ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:48.233199Z","caller":"traceutil/trace.go:171","msg":"trace[700291412] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"125.364381ms","start":"2026-03-14T01:25:48.107769Z","end":"2026-03-14T01:25:48.233133Z","steps":["trace[700291412] 'process raft request'  (duration: 49.424515ms)","trace[700291412] 'compare'  (duration: 75.584165ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:48.473934Z","caller":"traceutil/trace.go:171","msg":"trace[127508003] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"105.466225ms","start":"2026-03-14T01:25:48.368431Z","end":"2026-03-14T01:25:48.473897Z","steps":["trace[127508003] 'process raft request'  (duration: 96.074245ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:25:48.474053Z","caller":"traceutil/trace.go:171","msg":"trace[1343688206] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"102.980212ms","start":"2026-03-14T01:25:48.371047Z","end":"2026-03-14T01:25:48.474027Z","steps":["trace[1343688206] 'process raft request'  (duration: 102.765721ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:25:51.078757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.114565ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338546 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:198 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4593 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:25:51.078871Z","caller":"traceutil/trace.go:171","msg":"trace[1904686496] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"158.834089ms","start":"2026-03-14T01:25:50.92002Z","end":"2026-03-14T01:25:51.078854Z","steps":["trace[1904686496] 'read index received'  (duration: 53.506473ms)","trace[1904686496] 'applied index is now lower than readState.Index'  (duration: 105.326516ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:25:51.078955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.93296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-14T01:25:51.07894Z","caller":"traceutil/trace.go:171","msg":"trace[341556096] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"175.607098ms","start":"2026-03-14T01:25:50.903298Z","end":"2026-03-14T01:25:51.078905Z","steps":["trace[341556096] 'process raft request'  (duration: 70.238542ms)","trace[341556096] 'compare'  (duration: 104.903624ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:25:51.078987Z","caller":"traceutil/trace.go:171","msg":"trace[1462390717] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:336; }","duration":"158.99132ms","start":"2026-03-14T01:25:50.919985Z","end":"2026-03-14T01:25:51.078977Z","steps":["trace[1462390717] 'agreement among raft nodes before linearized reading'  (duration: 158.915169ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:13.313287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.678588ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338905 > lease_revoke:<id:34239ce9f2f14c97>","response":"size:27"}
{"level":"info","ts":"2026-03-14T01:26:13.313425Z","caller":"traceutil/trace.go:171","msg":"trace[366593414] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"230.483321ms","start":"2026-03-14T01:26:13.082924Z","end":"2026-03-14T01:26:13.313407Z","steps":["trace[366593414] 'read index received'  (duration: 51.733µs)","trace[366593414] 'applied index is now lower than readState.Index'  (duration: 230.430087ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:26:13.313532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.603669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4419"}
{"level":"info","ts":"2026-03-14T01:26:13.31359Z","caller":"traceutil/trace.go:171","msg":"trace[1915294552] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:518; }","duration":"230.712365ms","start":"2026-03-14T01:26:13.082862Z","end":"2026-03-14T01:26:13.313575Z","steps":["trace[1915294552] 'agreement among raft nodes before linearized reading'  (duration: 230.592288ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:20.331635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757019042774338989,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-14T01:26:20.360351Z","caller":"traceutil/trace.go:171","msg":"trace[858055508] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"824.469615ms","start":"2026-03-14T01:26:19.535855Z","end":"2026-03-14T01:26:20.360325Z","steps":["trace[858055508] 'process raft request'  (duration: 824.325017ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:20.360499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:19.535837Z","time spent":"824.586212ms","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-14T01:26:20.618922Z","caller":"traceutil/trace.go:171","msg":"trace[560170749] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"1.081804688s","start":"2026-03-14T01:26:19.537094Z","end":"2026-03-14T01:26:20.618899Z","steps":["trace[560170749] 'process raft request'  (duration: 1.081626357s)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:20.618979Z","caller":"traceutil/trace.go:171","msg":"trace[566668027] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.081809158s","start":"2026-03-14T01:26:19.537129Z","end":"2026-03-14T01:26:20.618939Z","steps":["trace[566668027] 'process raft request'  (duration: 1.081710612s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:20.619045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:19.537088Z","time spent":"1.081897794s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:553 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-14T01:26:20.619176Z","caller":"traceutil/trace.go:171","msg":"trace[1908281787] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:577; }","duration":"787.913261ms","start":"2026-03-14T01:26:19.831232Z","end":"2026-03-14T01:26:20.619145Z","steps":["trace[1908281787] 'read index received'  (duration: 528.933661ms)","trace[1908281787] 'applied index is now lower than readState.Index'  (duration: 258.97826ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:26:20.619259Z","caller":"traceutil/trace.go:171","msg":"trace[1202725680] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"292.011759ms","start":"2026-03-14T01:26:20.327204Z","end":"2026-03-14T01:26:20.619215Z","steps":["trace[1202725680] 'process raft request'  (duration: 291.662319ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:20.619278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:19.537126Z","time spent":"1.082079584s","remote":"127.0.0.1:39532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-14T01:26:20.6194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.166846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vf7mc\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-03-14T01:26:20.619439Z","caller":"traceutil/trace.go:171","msg":"trace[1871940438] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vf7mc; range_end:; response_count:1; response_revision:562; }","duration":"788.249311ms","start":"2026-03-14T01:26:19.831177Z","end":"2026-03-14T01:26:20.619426Z","steps":["trace[1871940438] 'agreement among raft nodes before linearized reading'  (duration: 788.06127ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:20.619484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:19.831149Z","time spent":"788.327045ms","remote":"127.0.0.1:39450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-vf7mc\" "}
{"level":"info","ts":"2026-03-14T01:26:20.64785Z","caller":"traceutil/trace.go:171","msg":"trace[2026416682] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"139.399422ms","start":"2026-03-14T01:26:20.50842Z","end":"2026-03-14T01:26:20.647819Z","steps":["trace[2026416682] 'process raft request'  (duration: 139.266264ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:21.4838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757019042774338995,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-14T01:26:21.772945Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125168126s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-14T01:26:22.554547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.320601ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3757019042774338996 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-vf7mc\" mod_revision:508 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-vf7mc\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-vf7mc\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-14T01:26:22.554649Z","caller":"traceutil/trace.go:171","msg":"trace[372628132] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"1.571249732s","start":"2026-03-14T01:26:20.983382Z","end":"2026-03-14T01:26:22.554632Z","steps":["trace[372628132] 'read index received'  (duration: 789.699848ms)","trace[372628132] 'applied index is now lower than readState.Index'  (duration: 781.548934ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:26:22.554754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.571379009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-14T01:26:22.554743Z","caller":"traceutil/trace.go:171","msg":"trace[1196329948] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.921994098s","start":"2026-03-14T01:26:20.632714Z","end":"2026-03-14T01:26:22.554708Z","steps":["trace[1196329948] 'process raft request'  (duration: 1.140422562s)","trace[1196329948] 'compare'  (duration: 781.213425ms)"],"step_count":2}
{"level":"info","ts":"2026-03-14T01:26:22.554784Z","caller":"traceutil/trace.go:171","msg":"trace[472349669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"1.571466204s","start":"2026-03-14T01:26:20.983305Z","end":"2026-03-14T01:26:22.554772Z","steps":["trace[472349669] 'agreement among raft nodes before linearized reading'  (duration: 1.57139432s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:22.554846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:20.983286Z","time spent":"1.571545499s","remote":"127.0.0.1:39246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-14T01:26:22.554898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:20.632689Z","time spent":"1.922117664s","remote":"127.0.0.1:39450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-vf7mc\" mod_revision:508 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-vf7mc\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-vf7mc\" > >"}
{"level":"info","ts":"2026-03-14T01:26:22.557705Z","caller":"traceutil/trace.go:171","msg":"trace[73073178] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"267.334823ms","start":"2026-03-14T01:26:22.290353Z","end":"2026-03-14T01:26:22.557688Z","steps":["trace[73073178] 'process raft request'  (duration: 267.205566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:22.55783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020502952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-14T01:26:22.55787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.25514ms","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-03-14T01:26:22.557886Z","caller":"traceutil/trace.go:171","msg":"trace[1914269657] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"1.020585868s","start":"2026-03-14T01:26:21.537285Z","end":"2026-03-14T01:26:22.557871Z","steps":["trace[1914269657] 'agreement among raft nodes before linearized reading'  (duration: 1.020405877s)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:22.557929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:21.537269Z","time spent":"1.020653141s","remote":"127.0.0.1:39532","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":"info","ts":"2026-03-14T01:26:22.557932Z","caller":"traceutil/trace.go:171","msg":"trace[695909140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"194.362076ms","start":"2026-03-14T01:26:22.363552Z","end":"2026-03-14T01:26:22.557914Z","steps":["trace[695909140] 'agreement among raft nodes before linearized reading'  (duration: 194.170435ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:23.009762Z","caller":"traceutil/trace.go:171","msg":"trace[1330832592] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"164.541954ms","start":"2026-03-14T01:26:22.845201Z","end":"2026-03-14T01:26:23.009743Z","steps":["trace[1330832592] 'process raft request'  (duration: 164.412957ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:23.015161Z","caller":"traceutil/trace.go:171","msg":"trace[1276178371] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"155.492633ms","start":"2026-03-14T01:26:22.859646Z","end":"2026-03-14T01:26:23.015138Z","steps":["trace[1276178371] 'process raft request'  (duration: 155.340784ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:26:24.639738Z","caller":"traceutil/trace.go:171","msg":"trace[1225416106] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"491.075353ms","start":"2026-03-14T01:26:24.148631Z","end":"2026-03-14T01:26:24.639706Z","steps":["trace[1225416106] 'process raft request'  (duration: 488.685839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-14T01:26:24.639861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-14T01:26:24.148607Z","time spent":"491.19467ms","remote":"127.0.0.1:39296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"info","ts":"2026-03-14T01:26:24.6411Z","caller":"traceutil/trace.go:171","msg":"trace[1752051729] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"292.79227ms","start":"2026-03-14T01:26:24.348282Z","end":"2026-03-14T01:26:24.641075Z","steps":["trace[1752051729] 'process raft request'  (duration: 292.391408ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:47.332183Z","caller":"traceutil/trace.go:171","msg":"trace[847786970] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"158.719189ms","start":"2026-03-14T01:27:47.173437Z","end":"2026-03-14T01:27:47.332156Z","steps":["trace[847786970] 'process raft request'  (duration: 157.882619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:47.339295Z","caller":"traceutil/trace.go:171","msg":"trace[1072018764] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"165.651375ms","start":"2026-03-14T01:27:47.173624Z","end":"2026-03-14T01:27:47.339275Z","steps":["trace[1072018764] 'process raft request'  (duration: 165.513821ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:47.339644Z","caller":"traceutil/trace.go:171","msg":"trace[731608321] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"165.920281ms","start":"2026-03-14T01:27:47.173693Z","end":"2026-03-14T01:27:47.339613Z","steps":["trace[731608321] 'process raft request'  (duration: 165.536682ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:54.67687Z","caller":"traceutil/trace.go:171","msg":"trace[1532345492] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1057; }","duration":"144.593303ms","start":"2026-03-14T01:27:54.53225Z","end":"2026-03-14T01:27:54.676843Z","steps":["trace[1532345492] 'read index received'  (duration: 144.368718ms)","trace[1532345492] 'applied index is now lower than readState.Index'  (duration: 223.295µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-14T01:27:54.677025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.744536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-14T01:27:54.677062Z","caller":"traceutil/trace.go:171","msg":"trace[1314823514] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1016; }","duration":"144.803308ms","start":"2026-03-14T01:27:54.532243Z","end":"2026-03-14T01:27:54.677046Z","steps":["trace[1314823514] 'agreement among raft nodes before linearized reading'  (duration: 144.696985ms)"],"step_count":1}
{"level":"info","ts":"2026-03-14T01:27:54.677093Z","caller":"traceutil/trace.go:171","msg":"trace[598732369] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"238.793565ms","start":"2026-03-14T01:27:54.438279Z","end":"2026-03-14T01:27:54.677072Z","steps":["trace[598732369] 'process raft request'  (duration: 238.360205ms)"],"step_count":1}