{"level":"warn","ts":"2026-03-06T00:28:13.967058Z","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-06T00:28:13.967143Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-06T00:28:13.967306Z","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-06T00:28:13.967321Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]}
{"level":"info","ts":"2026-03-06T00:28:13.967339Z","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-06T00:28:13.968084Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]}
{"level":"info","ts":"2026-03-06T00:28:13.968204Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-06T00:28:13.972113Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.638413ms"}
{"level":"info","ts":"2026-03-06T00:28:13.97834Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"}
{"level":"info","ts":"2026-03-06T00:28:13.978415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"}
{"level":"info","ts":"2026-03-06T00:28:13.978434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"}
{"level":"info","ts":"2026-03-06T00:28:13.978453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-06T00:28:13.978519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"}
{"level":"info","ts":"2026-03-06T00:28:13.978624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"}
{"level":"warn","ts":"2026-03-06T00:28:13.985678Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-06T00:28:13.987099Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-06T00:28:13.991846Z","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-06T00:28:13.997163Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-06T00:28:13.997594Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-06T00:28:13.997742Z","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-06T00:28:13.997913Z","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-06T00:28:13.997927Z","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-06T00:28:13.999948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"}
{"level":"info","ts":"2026-03-06T00:28:14.000108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]}
{"level":"info","ts":"2026-03-06T00:28:14.001352Z","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-06T00:28:14.001504Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"}
{"level":"info","ts":"2026-03-06T00:28:14.001581Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-06T00:28:14.001613Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-06T00:28:14.001585Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"}
{"level":"info","ts":"2026-03-06T00:28:14.479441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"}
{"level":"info","ts":"2026-03-06T00:28:14.479513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-06T00:28:14.47953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"}
{"level":"info","ts":"2026-03-06T00:28:14.479542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"}
{"level":"info","ts":"2026-03-06T00:28:14.479547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"}
{"level":"info","ts":"2026-03-06T00:28:14.479555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"}
{"level":"info","ts":"2026-03-06T00:28:14.479561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"}
{"level":"info","ts":"2026-03-06T00:28:14.480705Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:28:14.481417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-06T00:28:14.481627Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T00:28:14.481709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T00:28:14.481959Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-06T00:28:14.482011Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-06T00:28:14.484313Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:28:14.48442Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:28:14.484454Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:28:14.485353Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"}
{"level":"info","ts":"2026-03-06T00:28:14.485791Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-06T00:28:17.195829Z","caller":"traceutil/trace.go:171","msg":"trace[1618142966] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"350.709946ms","start":"2026-03-06T00:28:16.845073Z","end":"2026-03-06T00:28:17.195783Z","steps":["trace[1618142966] 'read index received'  (duration: 350.389504ms)","trace[1618142966] 'applied index is now lower than readState.Index'  (duration: 319.152µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:28:17.196345Z","caller":"traceutil/trace.go:171","msg":"trace[1995210704] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"352.824926ms","start":"2026-03-06T00:28:16.8435Z","end":"2026-03-06T00:28:17.196325Z","steps":["trace[1995210704] 'process raft request'  (duration: 352.06064ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:17.196501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.091797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-06T00:28:17.196699Z","caller":"traceutil/trace.go:171","msg":"trace[2123511419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"253.303569ms","start":"2026-03-06T00:28:16.943355Z","end":"2026-03-06T00:28:17.196659Z","steps":["trace[2123511419] 'agreement among raft nodes before linearized reading'  (duration: 252.929686ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:17.196984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.875907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-06T00:28:17.197151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:16.843482Z","time spent":"352.918217ms","remote":"127.0.0.1:38642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/priorityclasses/system-node-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-node-critical\" value_size:375 >> failure:<>"}
{"level":"info","ts":"2026-03-06T00:28:17.197093Z","caller":"traceutil/trace.go:171","msg":"trace[410580049] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"352.020969ms","start":"2026-03-06T00:28:16.845048Z","end":"2026-03-06T00:28:17.197069Z","steps":["trace[410580049] 'agreement among raft nodes before linearized reading'  (duration: 351.276562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:17.197381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:16.84504Z","time spent":"352.233041ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "}
{"level":"warn","ts":"2026-03-06T00:28:18.13864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.904862ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880867854697962201 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/priorityclasses/system-cluster-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-cluster-critical\" value_size:407 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-03-06T00:28:18.138775Z","caller":"traceutil/trace.go:171","msg":"trace[55166792] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"933.980856ms","start":"2026-03-06T00:28:17.204776Z","end":"2026-03-06T00:28:18.138757Z","steps":["trace[55166792] 'read index received'  (duration: 346.672381ms)","trace[55166792] 'applied index is now lower than readState.Index'  (duration: 587.307275ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:28:18.138885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.100257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-06T00:28:18.138922Z","caller":"traceutil/trace.go:171","msg":"trace[1839587351] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:73; }","duration":"934.151238ms","start":"2026-03-06T00:28:17.204762Z","end":"2026-03-06T00:28:18.138913Z","steps":["trace[1839587351] 'agreement among raft nodes before linearized reading'  (duration: 934.063527ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:28:18.138826Z","caller":"traceutil/trace.go:171","msg":"trace[1543580580] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"934.629892ms","start":"2026-03-06T00:28:17.204135Z","end":"2026-03-06T00:28:18.138765Z","steps":["trace[1543580580] 'process raft request'  (duration: 347.352386ms)","trace[1543580580] 'compare'  (duration: 586.754701ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:28:18.139004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:17.204752Z","time spent":"934.197268ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/view\" "}
{"level":"warn","ts":"2026-03-06T00:28:18.139139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:17.204114Z","time spent":"934.900344ms","remote":"127.0.0.1:38642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/priorityclasses/system-cluster-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-cluster-critical\" value_size:407 >> failure:<>"}
{"level":"warn","ts":"2026-03-06T00:28:18.140767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.548222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-06T00:28:18.140823Z","caller":"traceutil/trace.go:171","msg":"trace[223164463] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:73; }","duration":"613.647092ms","start":"2026-03-06T00:28:17.527163Z","end":"2026-03-06T00:28:18.14081Z","steps":["trace[223164463] 'agreement among raft nodes before linearized reading'  (duration: 613.568462ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:18.140856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:17.527138Z","time spent":"613.711303ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"warn","ts":"2026-03-06T00:28:18.140862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.09094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-06T00:28:18.141064Z","caller":"traceutil/trace.go:171","msg":"trace[1375662427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"197.332132ms","start":"2026-03-06T00:28:17.943691Z","end":"2026-03-06T00:28:18.141023Z","steps":["trace[1375662427] 'agreement among raft nodes before linearized reading'  (duration: 197.093629ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:20.269044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.201442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:28:20.269165Z","caller":"traceutil/trace.go:171","msg":"trace[538870669] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:0; response_revision:269; }","duration":"144.439323ms","start":"2026-03-06T00:28:20.124696Z","end":"2026-03-06T00:28:20.269136Z","steps":["trace[538870669] 'range keys from in-memory index tree'  (duration: 144.06602ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:28:45.279908Z","caller":"traceutil/trace.go:171","msg":"trace[250199600] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"499.308537ms","start":"2026-03-06T00:28:44.780575Z","end":"2026-03-06T00:28:45.279883Z","steps":["trace[250199600] 'process raft request'  (duration: 499.132326ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:45.280545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:44.780545Z","time spent":"499.443538ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:478 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:28:51.790692Z","caller":"traceutil/trace.go:171","msg":"trace[1069796071] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"446.86883ms","start":"2026-03-06T00:28:51.343808Z","end":"2026-03-06T00:28:51.790677Z","steps":["trace[1069796071] 'process raft request'  (duration: 446.751059ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:51.790818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:51.343789Z","time spent":"446.954501ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:550 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:28:52.214336Z","caller":"traceutil/trace.go:171","msg":"trace[48781491] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"567.752548ms","start":"2026-03-06T00:28:51.646563Z","end":"2026-03-06T00:28:52.214316Z","steps":["trace[48781491] 'read index received'  (duration: 144.049668ms)","trace[48781491] 'applied index is now lower than readState.Index'  (duration: 423.70204ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:28:52.214423Z","caller":"traceutil/trace.go:171","msg":"trace[2017048411] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"710.01739ms","start":"2026-03-06T00:28:51.50437Z","end":"2026-03-06T00:28:52.214388Z","steps":["trace[2017048411] 'process raft request'  (duration: 706.259265ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:52.214507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.927765ms","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-06T00:28:52.214534Z","caller":"traceutil/trace.go:171","msg":"trace[1616084176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"567.988497ms","start":"2026-03-06T00:28:51.646537Z","end":"2026-03-06T00:28:52.214525Z","steps":["trace[1616084176] 'agreement among raft nodes before linearized reading'  (duration: 567.878922ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:52.214557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:51.646523Z","time spent":"568.028478ms","remote":"127.0.0.1:38536","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-06T00:28:52.214579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:51.504354Z","time spent":"710.144595ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:474 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-06T00:28:52.214575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.590132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-06T00:28:52.214667Z","caller":"traceutil/trace.go:171","msg":"trace[2144153451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"220.728105ms","start":"2026-03-06T00:28:51.993924Z","end":"2026-03-06T00:28:52.214652Z","steps":["trace[2144153451] 'agreement among raft nodes before linearized reading'  (duration: 220.544208ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:52.673712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.191707ms","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-06T00:28:52.673793Z","caller":"traceutil/trace.go:171","msg":"trace[1388905400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:560; }","duration":"136.311261ms","start":"2026-03-06T00:28:52.537464Z","end":"2026-03-06T00:28:52.673775Z","steps":["trace[1388905400] 'range keys from in-memory index tree'  (duration: 136.045161ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:28:53.286978Z","caller":"traceutil/trace.go:171","msg":"trace[1235120197] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"419.572907ms","start":"2026-03-06T00:28:52.867385Z","end":"2026-03-06T00:28:53.286957Z","steps":["trace[1235120197] 'process raft request'  (duration: 419.435852ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:53.287118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:52.867357Z","time spent":"419.692331ms","remote":"127.0.0.1:38462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jnfwm\" mod_revision:509 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jnfwm\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jnfwm\" > >"}
{"level":"info","ts":"2026-03-06T00:28:54.288554Z","caller":"traceutil/trace.go:171","msg":"trace[323027283] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"490.255031ms","start":"2026-03-06T00:28:53.798278Z","end":"2026-03-06T00:28:54.288533Z","steps":["trace[323027283] 'process raft request'  (duration: 490.131857ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:54.288736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:53.798266Z","time spent":"490.363745ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:554 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:28:54.974028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:54.507633Z","time spent":"466.389013ms","remote":"127.0.0.1:57152","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-06T00:28:54.977845Z","caller":"traceutil/trace.go:171","msg":"trace[1196765997] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"765.097594ms","start":"2026-03-06T00:28:54.212714Z","end":"2026-03-06T00:28:54.977812Z","steps":["trace[1196765997] 'read index received'  (duration: 75.805433ms)","trace[1196765997] 'applied index is now lower than readState.Index'  (duration: 689.290361ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:28:54.978025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.287261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:28:54.978095Z","caller":"traceutil/trace.go:171","msg":"trace[128240437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"765.407755ms","start":"2026-03-06T00:28:54.212671Z","end":"2026-03-06T00:28:54.978079Z","steps":["trace[128240437] 'agreement among raft nodes before linearized reading'  (duration: 765.25871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:54.978151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:54.212655Z","time spent":"765.477198ms","remote":"127.0.0.1:38288","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-06T00:28:54.978198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.397918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-06T00:28:54.978263Z","caller":"traceutil/trace.go:171","msg":"trace[2144753714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:563; }","duration":"755.502262ms","start":"2026-03-06T00:28:54.222745Z","end":"2026-03-06T00:28:54.978247Z","steps":["trace[2144753714] 'agreement among raft nodes before linearized reading'  (duration: 755.278424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:54.978322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:54.222737Z","time spent":"755.572105ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-06T00:28:54.978505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.315346ms","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-06T00:28:54.978575Z","caller":"traceutil/trace.go:171","msg":"trace[559310539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"243.427461ms","start":"2026-03-06T00:28:54.735128Z","end":"2026-03-06T00:28:54.978556Z","steps":["trace[559310539] 'agreement among raft nodes before linearized reading'  (duration: 243.265015ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:54.978722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.240151ms","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-06T00:28:54.978805Z","caller":"traceutil/trace.go:171","msg":"trace[1532268195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"752.373365ms","start":"2026-03-06T00:28:54.226412Z","end":"2026-03-06T00:28:54.978786Z","steps":["trace[1532268195] 'agreement among raft nodes before linearized reading'  (duration: 752.095674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:28:54.978854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:28:54.226392Z","time spent":"752.453239ms","remote":"127.0.0.1:38536","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-06T00:29:00.156873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.268731ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3880867854697963316 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:187148 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:29:00.156953Z","caller":"traceutil/trace.go:171","msg":"trace[1432931620] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"148.963862ms","start":"2026-03-06T00:29:00.007969Z","end":"2026-03-06T00:29:00.156933Z","steps":["trace[1432931620] 'process raft request'  (duration: 44.581647ms)","trace[1432931620] 'compare'  (duration: 104.089315ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:29:00.157403Z","caller":"traceutil/trace.go:171","msg":"trace[100402108] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"104.725487ms","start":"2026-03-06T00:29:00.052669Z","end":"2026-03-06T00:29:00.157395Z","steps":["trace[100402108] 'process raft request'  (duration: 104.621993ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:30:27.650501Z","caller":"traceutil/trace.go:171","msg":"trace[106840078] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"126.334769ms","start":"2026-03-06T00:30:27.524139Z","end":"2026-03-06T00:30:27.650473Z","steps":["trace[106840078] 'process raft request'  (duration: 107.444833ms)","trace[106840078] 'compare'  (duration: 18.615322ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:30:27.650799Z","caller":"traceutil/trace.go:171","msg":"trace[639345062] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"123.892599ms","start":"2026-03-06T00:30:27.526859Z","end":"2026-03-06T00:30:27.650752Z","steps":["trace[639345062] 'process raft request'  (duration: 123.569034ms)"],"step_count":1}