{"level":"warn","ts":"2026-02-25T16:25:46.772286Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T16:25:46.772357Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-02-25T16:25:46.772416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T16:25:46.772426Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]}
{"level":"info","ts":"2026-02-25T16:25:46.772445Z","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-02-25T16:25:46.773068Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]}
{"level":"info","ts":"2026-02-25T16:25:46.773144Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-02-25T16:25:46.778236Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.801884ms"}
{"level":"info","ts":"2026-02-25T16:25:46.791505Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"}
{"level":"info","ts":"2026-02-25T16:25:46.791587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T16:25:46.791627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"}
{"level":"info","ts":"2026-02-25T16:25:46.791647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T16:25:46.791656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"}
{"level":"info","ts":"2026-02-25T16:25:46.791698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"}
{"level":"warn","ts":"2026-02-25T16:25:46.806323Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T16:25:46.807837Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T16:25:46.809811Z","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-02-25T16:25:46.814249Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T16:25:46.814371Z","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-02-25T16:25:46.81449Z","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-02-25T16:25:46.814538Z","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-02-25T16:25:46.814478Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T16:25:46.816727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"}
{"level":"info","ts":"2026-02-25T16:25:46.816953Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]}
{"level":"info","ts":"2026-02-25T16:25:46.819112Z","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-02-25T16:25:46.819205Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"}
{"level":"info","ts":"2026-02-25T16:25:46.81924Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"}
{"level":"info","ts":"2026-02-25T16:25:46.820242Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T16:25:46.820279Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T16:25:47.494339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T16:25:47.494414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T16:25:47.494434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"}
{"level":"info","ts":"2026-02-25T16:25:47.494464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T16:25:47.494472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"}
{"level":"info","ts":"2026-02-25T16:25:47.494483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"}
{"level":"info","ts":"2026-02-25T16:25:47.494498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"}
{"level":"info","ts":"2026-02-25T16:25:47.536386Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:25:47.572301Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T16:25:47.572186Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T16:25:47.572499Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T16:25:47.572717Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T16:25:47.572794Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T16:25:47.573178Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:25:47.573254Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:25:47.573276Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:25:47.574393Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"}
{"level":"info","ts":"2026-02-25T16:25:47.578955Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-25T16:26:11.433104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.441451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-02-25T16:26:11.433197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.158604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T16:26:11.433256Z","caller":"traceutil/trace.go:171","msg":"trace[1190412879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:460; }","duration":"478.619541ms","start":"2026-02-25T16:26:10.954609Z","end":"2026-02-25T16:26:11.433228Z","steps":["trace[1190412879] 'range keys from in-memory index tree'  (duration: 478.377199ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:26:11.433269Z","caller":"traceutil/trace.go:171","msg":"trace[739232127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:460; }","duration":"380.271054ms","start":"2026-02-25T16:26:11.052977Z","end":"2026-02-25T16:26:11.433248Z","steps":["trace[739232127] 'range keys from in-memory index tree'  (duration: 380.020484ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:11.433313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:10.954601Z","time spent":"478.699871ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T16:26:11.433309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:11.052957Z","time spent":"380.343554ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T16:26:11.433145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.205969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:26:11.433447Z","caller":"traceutil/trace.go:171","msg":"trace[1043485639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"489.52791ms","start":"2026-02-25T16:26:10.943906Z","end":"2026-02-25T16:26:11.433434Z","steps":["trace[1043485639] 'range keys from in-memory index tree'  (duration: 489.155058ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:11.433491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:10.943866Z","time spent":"489.60977ms","remote":"127.0.0.1:52638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T16:26:13.617535Z","caller":"traceutil/trace.go:171","msg":"trace[983348920] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"167.861787ms","start":"2026-02-25T16:26:13.449646Z","end":"2026-02-25T16:26:13.617508Z","steps":["trace[983348920] 'process raft request'  (duration: 167.698346ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:26:13.627586Z","caller":"traceutil/trace.go:171","msg":"trace[417979285] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"176.444855ms","start":"2026-02-25T16:26:13.451126Z","end":"2026-02-25T16:26:13.627571Z","steps":["trace[417979285] 'process raft request'  (duration: 176.339055ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:26:13.627808Z","caller":"traceutil/trace.go:171","msg":"trace[897835497] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"175.638132ms","start":"2026-02-25T16:26:13.452143Z","end":"2026-02-25T16:26:13.627781Z","steps":["trace[897835497] 'process raft request'  (duration: 175.401071ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:26:17.634569Z","caller":"traceutil/trace.go:171","msg":"trace[1447416413] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"388.285587ms","start":"2026-02-25T16:26:17.246252Z","end":"2026-02-25T16:26:17.634538Z","steps":["trace[1447416413] 'process raft request'  (duration: 388.017136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:17.635154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:17.246229Z","time spent":"388.423448ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:408 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4179 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-25T16:26:19.879817Z","caller":"traceutil/trace.go:171","msg":"trace[1032784039] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"236.444136ms","start":"2026-02-25T16:26:19.643354Z","end":"2026-02-25T16:26:19.879798Z","steps":["trace[1032784039] 'read index received'  (duration: 236.286265ms)","trace[1032784039] 'applied index is now lower than readState.Index'  (duration: 157.261µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:26:19.879951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.578337ms","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-02-25T16:26:19.87992Z","caller":"traceutil/trace.go:171","msg":"trace[2109289505] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"462.973958ms","start":"2026-02-25T16:26:19.4169Z","end":"2026-02-25T16:26:19.879873Z","steps":["trace[2109289505] 'process raft request'  (duration: 462.786676ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:19.880068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.6229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T16:26:19.880089Z","caller":"traceutil/trace.go:171","msg":"trace[1413589317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"230.661911ms","start":"2026-02-25T16:26:19.64942Z","end":"2026-02-25T16:26:19.880082Z","steps":["trace[1413589317] 'agreement among raft nodes before linearized reading'  (duration: 230.5786ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:19.880143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.634781ms","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-02-25T16:26:19.880267Z","caller":"traceutil/trace.go:171","msg":"trace[1360272608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"230.733022ms","start":"2026-02-25T16:26:19.649459Z","end":"2026-02-25T16:26:19.880192Z","steps":["trace[1360272608] 'agreement among raft nodes before linearized reading'  (duration: 230.631541ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:19.880146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:19.41687Z","time spent":"463.172829ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:458 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T16:26:19.879983Z","caller":"traceutil/trace.go:171","msg":"trace[1424209199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"236.659718ms","start":"2026-02-25T16:26:19.643312Z","end":"2026-02-25T16:26:19.879971Z","steps":["trace[1424209199] 'agreement among raft nodes before linearized reading'  (duration: 236.592157ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:24.607793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.373927ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432438334222380210 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:544 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T16:26:24.607951Z","caller":"traceutil/trace.go:171","msg":"trace[709915556] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"635.688648ms","start":"2026-02-25T16:26:23.972244Z","end":"2026-02-25T16:26:24.607933Z","steps":["trace[709915556] 'process raft request'  (duration: 88.697141ms)","trace[709915556] 'compare'  (duration: 546.031151ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:26:24.60801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:23.972177Z","time spent":"635.809383ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:544 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T16:26:24.608666Z","caller":"traceutil/trace.go:171","msg":"trace[582778641] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:567; }","duration":"542.430122ms","start":"2026-02-25T16:26:24.066198Z","end":"2026-02-25T16:26:24.608628Z","steps":["trace[582778641] 'read index received'  (duration: 14.228449ms)","trace[582778641] 'applied index is now lower than readState.Index'  (duration: 528.200493ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:26:24.609084Z","caller":"traceutil/trace.go:171","msg":"trace[1957310983] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"635.501237ms","start":"2026-02-25T16:26:23.973558Z","end":"2026-02-25T16:26:24.609059Z","steps":["trace[1957310983] 'process raft request'  (duration: 634.322791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:24.609144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:23.973543Z","time spent":"635.572221ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:543 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-25T16:26:24.609357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.143035ms","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-02-25T16:26:24.609419Z","caller":"traceutil/trace.go:171","msg":"trace[1669722702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"543.233589ms","start":"2026-02-25T16:26:24.066171Z","end":"2026-02-25T16:26:24.609405Z","steps":["trace[1669722702] 'agreement among raft nodes before linearized reading'  (duration: 542.574978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:24.609471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:24.066157Z","time spent":"543.305183ms","remote":"127.0.0.1:52914","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":"info","ts":"2026-02-25T16:26:24.840904Z","caller":"traceutil/trace.go:171","msg":"trace[1685511011] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"179.600737ms","start":"2026-02-25T16:26:24.661286Z","end":"2026-02-25T16:26:24.840887Z","steps":["trace[1685511011] 'process raft request'  (duration: 179.496382ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:26.445889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432438334222380214,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T16:26:26.738393Z","caller":"traceutil/trace.go:171","msg":"trace[665023592] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"793.286307ms","start":"2026-02-25T16:26:25.945082Z","end":"2026-02-25T16:26:26.738368Z","steps":["trace[665023592] 'read index received'  (duration: 742.017296ms)","trace[665023592] 'applied index is now lower than readState.Index'  (duration: 51.267831ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:26:26.738643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.552648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T16:26:26.738677Z","caller":"traceutil/trace.go:171","msg":"trace[364816360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"765.652683ms","start":"2026-02-25T16:26:25.973014Z","end":"2026-02-25T16:26:26.738667Z","steps":["trace[364816360] 'agreement among raft nodes before linearized reading'  (duration: 765.491016ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:26.738648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.518827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:26:26.73877Z","caller":"traceutil/trace.go:171","msg":"trace[1132198713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"793.709526ms","start":"2026-02-25T16:26:25.945031Z","end":"2026-02-25T16:26:26.73874Z","steps":["trace[1132198713] 'agreement among raft nodes before linearized reading'  (duration: 793.442623ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:26.738826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:25.94501Z","time spent":"793.80696ms","remote":"127.0.0.1:52638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T16:26:26.738704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:25.972991Z","time spent":"765.706106ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T16:26:26.738985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.884136ms","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-02-25T16:26:26.739101Z","caller":"traceutil/trace.go:171","msg":"trace[809167620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"125.026472ms","start":"2026-02-25T16:26:26.614041Z","end":"2026-02-25T16:26:26.739068Z","steps":["trace[809167620] 'agreement among raft nodes before linearized reading'  (duration: 124.770531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:26.739707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.238104ms","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-02-25T16:26:26.739792Z","caller":"traceutil/trace.go:171","msg":"trace[1170801429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"127.413761ms","start":"2026-02-25T16:26:26.612356Z","end":"2026-02-25T16:26:26.73977Z","steps":["trace[1170801429] 'agreement among raft nodes before linearized reading'  (duration: 126.50549ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:29.061076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.64863ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6432438334222380272 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:555 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T16:26:29.061185Z","caller":"traceutil/trace.go:171","msg":"trace[254033101] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"296.796356ms","start":"2026-02-25T16:26:28.76437Z","end":"2026-02-25T16:26:29.061166Z","steps":["trace[254033101] 'process raft request'  (duration: 71.970488ms)","trace[254033101] 'compare'  (duration: 224.538716ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:26:29.208571Z","caller":"traceutil/trace.go:171","msg":"trace[1209037474] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"440.236885ms","start":"2026-02-25T16:26:28.768319Z","end":"2026-02-25T16:26:29.208556Z","steps":["trace[1209037474] 'process raft request'  (duration: 440.210844ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:26:29.208637Z","caller":"traceutil/trace.go:171","msg":"trace[1901432405] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"442.190353ms","start":"2026-02-25T16:26:28.766416Z","end":"2026-02-25T16:26:29.208606Z","steps":["trace[1901432405] 'process raft request'  (duration: 442.005965ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:29.208667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:28.768306Z","time spent":"440.311329ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:558 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T16:26:29.208749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:28.766384Z","time spent":"442.303378ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:556 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T16:26:29.208744Z","caller":"traceutil/trace.go:171","msg":"trace[2108246238] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"441.125166ms","start":"2026-02-25T16:26:28.767556Z","end":"2026-02-25T16:26:29.208681Z","steps":["trace[2108246238] 'process raft request'  (duration: 440.946538ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:29.208985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:28.767537Z","time spent":"441.341145ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:557 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T16:26:29.212825Z","caller":"traceutil/trace.go:171","msg":"trace[518962955] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"302.235094ms","start":"2026-02-25T16:26:28.910551Z","end":"2026-02-25T16:26:29.212786Z","steps":["trace[518962955] 'process raft request'  (duration: 302.1293ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:26:29.212934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:26:28.910531Z","time spent":"302.35842ms","remote":"127.0.0.1:52696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3013 >> failure:<>"}
{"level":"info","ts":"2026-02-25T16:26:29.213045Z","caller":"traceutil/trace.go:171","msg":"trace[1469881341] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"101.597534ms","start":"2026-02-25T16:26:29.111438Z","end":"2026-02-25T16:26:29.213035Z","steps":["trace[1469881341] 'process raft request'  (duration: 101.307002ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:27:51.857113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.329826ms","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-02-25T16:27:51.857222Z","caller":"traceutil/trace.go:171","msg":"trace[1598105514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"240.467148ms","start":"2026-02-25T16:27:51.616737Z","end":"2026-02-25T16:27:51.857204Z","steps":["trace[1598105514] 'range keys from in-memory index tree'  (duration: 240.160673ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:27:51.857113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.234942ms","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-02-25T16:27:51.857343Z","caller":"traceutil/trace.go:171","msg":"trace[1305210608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"249.500367ms","start":"2026-02-25T16:27:51.607816Z","end":"2026-02-25T16:27:51.857316Z","steps":["trace[1305210608] 'range keys from in-memory index tree'  (duration: 249.088309ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:27:51.857341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.965013ms","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-02-25T16:27:51.857444Z","caller":"traceutil/trace.go:171","msg":"trace[212281914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"245.087456ms","start":"2026-02-25T16:27:51.612327Z","end":"2026-02-25T16:27:51.857414Z","steps":["trace[212281914] 'range keys from in-memory index tree'  (duration: 244.83012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:27:59.220362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.837113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T16:27:59.220462Z","caller":"traceutil/trace.go:171","msg":"trace[1647606624] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:999; }","duration":"149.991916ms","start":"2026-02-25T16:27:59.070448Z","end":"2026-02-25T16:27:59.22044Z","steps":["trace[1647606624] 'count revisions from in-memory index tree'  (duration: 149.764312ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:28:00.012866Z","caller":"traceutil/trace.go:171","msg":"trace[2026118141] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"215.663119ms","start":"2026-02-25T16:27:59.797178Z","end":"2026-02-25T16:28:00.012841Z","steps":["trace[2026118141] 'read index received'  (duration: 215.478786ms)","trace[2026118141] 'applied index is now lower than readState.Index'  (duration: 183.423µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:28:00.013179Z","caller":"traceutil/trace.go:171","msg":"trace[35052620] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"474.128016ms","start":"2026-02-25T16:27:59.539036Z","end":"2026-02-25T16:28:00.013164Z","steps":["trace[35052620] 'process raft request'  (duration: 473.672188ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:28:00.013288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:27:59.539018Z","time spent":"474.196986ms","remote":"127.0.0.1:52914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:993 > 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-02-25T16:28:00.01352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.34213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T16:28:00.013561Z","caller":"traceutil/trace.go:171","msg":"trace[363136640] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1000; }","duration":"216.416312ms","start":"2026-02-25T16:27:59.797134Z","end":"2026-02-25T16:28:00.01355Z","steps":["trace[363136640] 'agreement among raft nodes before linearized reading'  (duration: 216.344661ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:28:00.013664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.836075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:28:00.013752Z","caller":"traceutil/trace.go:171","msg":"trace[1550964983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"194.984028ms","start":"2026-02-25T16:27:59.818745Z","end":"2026-02-25T16:28:00.013729Z","steps":["trace[1550964983] 'agreement among raft nodes before linearized reading'  (duration: 194.830796ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:28:00.149097Z","caller":"traceutil/trace.go:171","msg":"trace[944790328] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"130.718261ms","start":"2026-02-25T16:28:00.018195Z","end":"2026-02-25T16:28:00.148914Z","steps":["trace[944790328] 'process raft request'  (duration: 55.681564ms)","trace[944790328] 'compare'  (duration: 74.856184ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:28:00.152666Z","caller":"traceutil/trace.go:171","msg":"trace[352636985] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"134.209133ms","start":"2026-02-25T16:28:00.018446Z","end":"2026-02-25T16:28:00.152655Z","steps":["trace[352636985] 'process raft request'  (duration: 134.119931ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:28:00.152752Z","caller":"traceutil/trace.go:171","msg":"trace[1674825846] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1041; }","duration":"125.613963ms","start":"2026-02-25T16:28:00.027131Z","end":"2026-02-25T16:28:00.152745Z","steps":["trace[1674825846] 'read index received'  (duration: 46.83743ms)","trace[1674825846] 'applied index is now lower than readState.Index'  (duration: 78.775703ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:28:00.152846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.712106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:28:00.152866Z","caller":"traceutil/trace.go:171","msg":"trace[1259916284] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1003; }","duration":"125.769386ms","start":"2026-02-25T16:28:00.02709Z","end":"2026-02-25T16:28:00.152859Z","steps":["trace[1259916284] 'agreement among raft nodes before linearized reading'  (duration: 125.681225ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:28:00.153857Z","caller":"traceutil/trace.go:171","msg":"trace[1283743133] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"134.60312ms","start":"2026-02-25T16:28:00.0191Z","end":"2026-02-25T16:28:00.153703Z","steps":["trace[1283743133] 'process raft request'  (duration: 133.523771ms)"],"step_count":1}