{"level":"warn","ts":"2026-03-13T23:02:42.263129Z","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-13T23:02:42.263399Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-13T23:02:42.26364Z","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-13T23:02:42.263676Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-03-13T23:02:42.263998Z","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-13T23:02:42.265363Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-03-13T23:02:42.265488Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-13T23:02:42.268426Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.705376ms"}
{"level":"info","ts":"2026-03-13T23:02:42.273028Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-03-13T23:02:42.27312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-13T23:02:42.273137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-03-13T23:02:42.27315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-13T23:02:42.273161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-03-13T23:02:42.273203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-03-13T23:02:42.278196Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-13T23:02:42.27935Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-13T23:02:42.280975Z","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-13T23:02:42.28312Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-13T23:02:42.283366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-13T23:02:42.283632Z","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-13T23:02:42.283734Z","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-13T23:02:42.283744Z","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-13T23:02:42.284347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-03-13T23:02:42.28559Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-03-13T23:02:42.288224Z","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-13T23:02:42.288624Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-13T23:02:42.288656Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-13T23:02:42.289593Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-03-13T23:02:42.289724Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-03-13T23:02:42.874454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-13T23:02:42.874728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-13T23:02:42.874864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-03-13T23:02:42.87498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-03-13T23:02:42.875092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-03-13T23:02:42.875213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-03-13T23:02:42.875377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-03-13T23:02:42.876975Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T23:02:42.877902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T23:02:42.878074Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-13T23:02:42.878301Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T23:02:42.878511Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T23:02:42.878583Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-13T23:02:42.877874Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-13T23:02:42.879567Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-13T23:02:42.879615Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-13T23:02:42.881398Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-13T23:02:42.891132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-03-13T23:02:48.818486Z","caller":"traceutil/trace.go:171","msg":"trace[1425233398] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"300.515899ms","start":"2026-03-13T23:02:48.517943Z","end":"2026-03-13T23:02:48.818459Z","steps":["trace[1425233398] 'read index received'  (duration: 300.429667ms)","trace[1425233398] 'applied index is now lower than readState.Index'  (duration: 85.062µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T23:02:48.81872Z","caller":"traceutil/trace.go:171","msg":"trace[1294460091] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"307.214989ms","start":"2026-03-13T23:02:48.511494Z","end":"2026-03-13T23:02:48.818709Z","steps":["trace[1294460091] 'process raft request'  (duration: 306.778267ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.819158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.511456Z","time spent":"307.300302ms","remote":"127.0.0.1:39768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/ttl-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/ttl-controller\" value_size:119 >> failure:<>"}
{"level":"warn","ts":"2026-03-13T23:02:48.819395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.453386ms","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-03-13T23:02:48.819455Z","caller":"traceutil/trace.go:171","msg":"trace[180065653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:311; }","duration":"301.561999ms","start":"2026-03-13T23:02:48.51788Z","end":"2026-03-13T23:02:48.819442Z","steps":["trace[180065653] 'agreement among raft nodes before linearized reading'  (duration: 301.397714ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.819485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.51786Z","time spent":"301.61799ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-13T23:02:48.958514Z","caller":"traceutil/trace.go:171","msg":"trace[1244209518] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"139.911578ms","start":"2026-03-13T23:02:48.818573Z","end":"2026-03-13T23:02:48.958485Z","steps":["trace[1244209518] 'read index received'  (duration: 139.804026ms)","trace[1244209518] 'applied index is now lower than readState.Index'  (duration: 106.382µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T23:02:48.958553Z","caller":"traceutil/trace.go:171","msg":"trace[248701594] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"429.347814ms","start":"2026-03-13T23:02:48.529156Z","end":"2026-03-13T23:02:48.958504Z","steps":["trace[248701594] 'process raft request'  (duration: 429.246041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.958616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.88981ms","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-13T23:02:48.958703Z","caller":"traceutil/trace.go:171","msg":"trace[407765949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:311; }","duration":"402.002464ms","start":"2026-03-13T23:02:48.556677Z","end":"2026-03-13T23:02:48.958679Z","steps":["trace[407765949] 'agreement among raft nodes before linearized reading'  (duration: 401.839659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.958681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.957192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-13T23:02:48.958738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.529134Z","time spent":"429.516179ms","remote":"127.0.0.1:39754","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"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-13T23:02:48.958765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.672018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"}
{"level":"warn","ts":"2026-03-13T23:02:48.958768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.556667Z","time spent":"402.088016ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-13T23:02:48.958784Z","caller":"traceutil/trace.go:171","msg":"trace[1543840686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:311; }","duration":"419.127757ms","start":"2026-03-13T23:02:48.539634Z","end":"2026-03-13T23:02:48.958761Z","steps":["trace[1543840686] 'agreement among raft nodes before linearized reading'  (duration: 418.926812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.95876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.932983ms","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-13T23:02:48.958808Z","caller":"traceutil/trace.go:171","msg":"trace[1282666679] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:311; }","duration":"432.765161ms","start":"2026-03-13T23:02:48.526029Z","end":"2026-03-13T23:02:48.958794Z","steps":["trace[1282666679] 'agreement among raft nodes before linearized reading'  (duration: 432.595956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.958834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.539614Z","time spent":"419.210809ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-13T23:02:48.958858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:02:48.526013Z","time spent":"432.827552ms","remote":"127.0.0.1:39754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3490,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "}
{"level":"info","ts":"2026-03-13T23:02:48.958862Z","caller":"traceutil/trace.go:171","msg":"trace[908380137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:311; }","duration":"289.086937ms","start":"2026-03-13T23:02:48.669742Z","end":"2026-03-13T23:02:48.958829Z","steps":["trace[908380137] 'agreement among raft nodes before linearized reading'  (duration: 288.84918ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:02:48.959001Z","caller":"traceutil/trace.go:171","msg":"trace[1259790983] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"135.050691ms","start":"2026-03-13T23:02:48.823939Z","end":"2026-03-13T23:02:48.95899Z","steps":["trace[1259790983] 'process raft request'  (duration: 134.933147ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:02:48.959002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.566195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-03-13T23:02:48.959037Z","caller":"traceutil/trace.go:171","msg":"trace[1326001967] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:312; }","duration":"135.639237ms","start":"2026-03-13T23:02:48.823387Z","end":"2026-03-13T23:02:48.959026Z","steps":["trace[1326001967] 'agreement among raft nodes before linearized reading'  (duration: 135.557154ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:03:16.726227Z","caller":"traceutil/trace.go:171","msg":"trace[1387453164] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"115.816899ms","start":"2026-03-13T23:03:16.610391Z","end":"2026-03-13T23:03:16.726208Z","steps":["trace[1387453164] 'process raft request'  (duration: 115.684735ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:03:37.53114Z","caller":"traceutil/trace.go:171","msg":"trace[685175634] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"266.144374ms","start":"2026-03-13T23:03:37.264975Z","end":"2026-03-13T23:03:37.531119Z","steps":["trace[685175634] 'process raft request'  (duration: 266.021691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:03:37.614615Z","caller":"traceutil/trace.go:171","msg":"trace[1598567187] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:729; }","duration":"333.394015ms","start":"2026-03-13T23:03:37.281197Z","end":"2026-03-13T23:03:37.614591Z","steps":["trace[1598567187] 'read index received'  (duration: 249.819868ms)","trace[1598567187] 'applied index is now lower than readState.Index'  (duration: 83.572977ms)"],"step_count":2}
{"level":"info","ts":"2026-03-13T23:03:37.614739Z","caller":"traceutil/trace.go:171","msg":"trace[1645854519] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"348.837748ms","start":"2026-03-13T23:03:37.265863Z","end":"2026-03-13T23:03:37.6147Z","steps":["trace[1645854519] 'process raft request'  (duration: 344.556558ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:03:37.614997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.978656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-13T23:03:37.615033Z","caller":"traceutil/trace.go:171","msg":"trace[646938441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:710; }","duration":"327.031557ms","start":"2026-03-13T23:03:37.287991Z","end":"2026-03-13T23:03:37.615023Z","steps":["trace[646938441] 'agreement among raft nodes before linearized reading'  (duration: 326.806141ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:03:37.615063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:03:37.287985Z","time spent":"327.072239ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-13T23:03:37.615082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:03:37.265846Z","time spent":"348.990322ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:702 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-13T23:03:37.615071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.586045ms","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-03-13T23:03:37.615162Z","caller":"traceutil/trace.go:171","msg":"trace[2099705361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"331.701508ms","start":"2026-03-13T23:03:37.283437Z","end":"2026-03-13T23:03:37.615139Z","steps":["trace[2099705361] 'agreement among raft nodes before linearized reading'  (duration: 331.38872ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:03:37.61523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:03:37.283424Z","time spent":"331.790921ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-13T23:03:37.61538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.722395ms","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-13T23:03:37.615411Z","caller":"traceutil/trace.go:171","msg":"trace[1954834416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"334.22625ms","start":"2026-03-13T23:03:37.281176Z","end":"2026-03-13T23:03:37.615402Z","steps":["trace[1954834416] 'agreement among raft nodes before linearized reading'  (duration: 333.53139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:03:37.615432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-13T23:03:37.281166Z","time spent":"334.2587ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-13T23:04:38.115273Z","caller":"traceutil/trace.go:171","msg":"trace[1542209914] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"184.834875ms","start":"2026-03-13T23:04:37.93041Z","end":"2026-03-13T23:04:38.115245Z","steps":["trace[1542209914] 'read index received'  (duration: 184.706481ms)","trace[1542209914] 'applied index is now lower than readState.Index'  (duration: 127.134µs)"],"step_count":2}
{"level":"info","ts":"2026-03-13T23:04:38.11533Z","caller":"traceutil/trace.go:171","msg":"trace[2133386990] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"242.530201ms","start":"2026-03-13T23:04:37.872764Z","end":"2026-03-13T23:04:38.115294Z","steps":["trace[2133386990] 'process raft request'  (duration: 242.302475ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:04:38.115516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.069331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-13T23:04:38.115599Z","caller":"traceutil/trace.go:171","msg":"trace[834452497] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:965; }","duration":"185.205335ms","start":"2026-03-13T23:04:37.930376Z","end":"2026-03-13T23:04:38.115581Z","steps":["trace[834452497] 'agreement among raft nodes before linearized reading'  (duration: 185.01895ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:04:38.115636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.091685ms","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-03-13T23:04:38.115722Z","caller":"traceutil/trace.go:171","msg":"trace[1407072920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:965; }","duration":"171.214678ms","start":"2026-03-13T23:04:37.944481Z","end":"2026-03-13T23:04:38.115696Z","steps":["trace[1407072920] 'agreement among raft nodes before linearized reading'  (duration: 170.959231ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:04:38.116107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.510688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-13T23:04:38.116103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.949962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-13T23:04:38.116148Z","caller":"traceutil/trace.go:171","msg":"trace[53698186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:965; }","duration":"170.58494ms","start":"2026-03-13T23:04:37.945551Z","end":"2026-03-13T23:04:38.116135Z","steps":["trace[53698186] 'agreement among raft nodes before linearized reading'  (duration: 170.406435ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:04:38.116159Z","caller":"traceutil/trace.go:171","msg":"trace[1087756307] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:965; }","duration":"149.065215ms","start":"2026-03-13T23:04:37.967077Z","end":"2026-03-13T23:04:38.116142Z","steps":["trace[1087756307] 'agreement among raft nodes before linearized reading'  (duration: 148.910451ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:04:38.116265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.328456ms","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-13T23:04:38.116319Z","caller":"traceutil/trace.go:171","msg":"trace[1519468553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:965; }","duration":"156.415509ms","start":"2026-03-13T23:04:37.959894Z","end":"2026-03-13T23:04:38.11631Z","steps":["trace[1519468553] 'agreement among raft nodes before linearized reading'  (duration: 155.892564ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-13T23:04:38.777418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.161456ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313094499905530205 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-13T23:04:38.777552Z","caller":"traceutil/trace.go:171","msg":"trace[511902961] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"152.947933ms","start":"2026-03-13T23:04:38.624588Z","end":"2026-03-13T23:04:38.777536Z","steps":["trace[511902961] 'compare'  (duration: 144.997872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:04:39.044316Z","caller":"traceutil/trace.go:171","msg":"trace[1671334005] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"261.834527ms","start":"2026-03-13T23:04:38.782457Z","end":"2026-03-13T23:04:39.044291Z","steps":["trace[1671334005] 'process raft request'  (duration: 261.683483ms)"],"step_count":1}
{"level":"info","ts":"2026-03-13T23:04:39.068509Z","caller":"traceutil/trace.go:171","msg":"trace[1710881332] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"283.392452ms","start":"2026-03-13T23:04:38.785094Z","end":"2026-03-13T23:04:39.068486Z","steps":["trace[1710881332] 'process raft request'  (duration: 283.270859ms)"],"step_count":1}