{"level":"warn","ts":"2026-03-18T00:42:32.741566Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-18T00:42:32.741667Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-18T00:42:32.741748Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-18T00:42:32.741762Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]}
{"level":"info","ts":"2026-03-18T00:42:32.741785Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-18T00:42:32.742665Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]}
{"level":"info","ts":"2026-03-18T00:42:32.742749Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-18T00:42:32.7502Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.194187ms"}
{"level":"info","ts":"2026-03-18T00:42:32.763786Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"}
{"level":"info","ts":"2026-03-18T00:42:32.763905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:42:32.763954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:42:32.763979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:42:32.76399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:42:32.764063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"warn","ts":"2026-03-18T00:42:32.776213Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:42:32.778931Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:42:32.780294Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-18T00:42:32.782835Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:42:32.782992Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-18T00:42:32.783103Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-18T00:42:32.783114Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-18T00:42:32.783257Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:42:32.787105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"info","ts":"2026-03-18T00:42:32.787697Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]}
{"level":"info","ts":"2026-03-18T00:42:32.790838Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-18T00:42:32.790967Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-03-18T00:42:32.791039Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-03-18T00:42:32.79115Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:42:32.791219Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:42:33.764787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:42:33.76491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:42:33.765007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"}
{"level":"info","ts":"2026-03-18T00:42:33.765097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:42:33.765165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-03-18T00:42:33.765281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:42:33.765354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-03-18T00:42:33.766367Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:42:33.766424Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:42:33.766617Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:42:33.766581Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:42:33.767218Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:42:33.767332Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:42:33.767662Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:42:33.767787Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:42:33.767827Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:42:33.770562Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-18T00:42:33.770637Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"}
{"level":"info","ts":"2026-03-18T00:42:37.719939Z","caller":"traceutil/trace.go:171","msg":"trace[1935596129] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"197.076456ms","start":"2026-03-18T00:42:37.522838Z","end":"2026-03-18T00:42:37.719914Z","steps":["trace[1935596129] 'process raft request'  (duration: 196.933125ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:39.081952Z","caller":"traceutil/trace.go:171","msg":"trace[2053934212] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"310.646417ms","start":"2026-03-18T00:42:38.771268Z","end":"2026-03-18T00:42:39.081915Z","steps":["trace[2053934212] 'process raft request'  (duration: 310.446116ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:39.082524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:38.771246Z","time spent":"310.819258ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:42:39.593266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521224888172658293,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T00:42:40.081345Z","caller":"traceutil/trace.go:171","msg":"trace[1362638413] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"995.220485ms","start":"2026-03-18T00:42:39.086105Z","end":"2026-03-18T00:42:40.081325Z","steps":["trace[1362638413] 'process raft request'  (duration: 995.114314ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.081466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.086095Z","time spent":"995.314105ms","remote":"127.0.0.1:53870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-controller-manager.189dc8c0e6b6f109\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-controller-manager.189dc8c0e6b6f109\" value_size:666 lease:2297852851317882037 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:42:40.588428Z","caller":"traceutil/trace.go:171","msg":"trace[323714979] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"1.419573664s","start":"2026-03-18T00:42:39.168833Z","end":"2026-03-18T00:42:40.588406Z","steps":["trace[323714979] 'process raft request'  (duration: 1.419525884s)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:40.588519Z","caller":"traceutil/trace.go:171","msg":"trace[666652333] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"1.499185421s","start":"2026-03-18T00:42:39.089281Z","end":"2026-03-18T00:42:40.588467Z","steps":["trace[666652333] 'process raft request'  (duration: 1.46567085s)","trace[666652333] 'compare'  (duration: 33.246409ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:42:40.588575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.168821Z","time spent":"1.419686905s","remote":"127.0.0.1:53978","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"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:5824 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:42:40.588715Z","caller":"traceutil/trace.go:171","msg":"trace[23525654] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:300; }","duration":"1.496125069s","start":"2026-03-18T00:42:39.092566Z","end":"2026-03-18T00:42:40.588691Z","steps":["trace[23525654] 'read index received'  (duration: 988.749429ms)","trace[23525654] 'applied index is now lower than readState.Index'  (duration: 507.3747ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:40.588825Z","caller":"traceutil/trace.go:171","msg":"trace[1813781365] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"1.419891216s","start":"2026-03-18T00:42:39.168925Z","end":"2026-03-18T00:42:40.588816Z","steps":["trace[1813781365] 'process raft request'  (duration: 1.419458843s)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:40.588838Z","caller":"traceutil/trace.go:171","msg":"trace[1552245488] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"1.420069047s","start":"2026-03-18T00:42:39.168757Z","end":"2026-03-18T00:42:40.588826Z","steps":["trace[1552245488] 'process raft request'  (duration: 1.419568404s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.588891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.16874Z","time spent":"1.420123897s","remote":"127.0.0.1:53978","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:42:40.58891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.168918Z","time spent":"1.419933686s","remote":"127.0.0.1:53978","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:42:40.58891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.089258Z","time spent":"1.499325891s","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:290 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-18T00:42:40.589024Z","caller":"traceutil/trace.go:171","msg":"trace[703690729] transaction","detail":"{read_only:false; number_of_response:0; response_revision:292; }","duration":"1.420081547s","start":"2026-03-18T00:42:39.168934Z","end":"2026-03-18T00:42:40.589016Z","steps":["trace[703690729] 'process raft request'  (duration: 1.419715075s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.589066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.168926Z","time spent":"1.420119557s","remote":"127.0.0.1:53978","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:42:40.589215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.496599832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:42:40.589283Z","caller":"traceutil/trace.go:171","msg":"trace[394838823] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:292; }","duration":"1.496726043s","start":"2026-03-18T00:42:39.09254Z","end":"2026-03-18T00:42:40.589267Z","steps":["trace[394838823] 'agreement among raft nodes before linearized reading'  (duration: 1.496588892s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.589298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.440759287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-18T00:42:40.589315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.092532Z","time spent":"1.496774833s","remote":"127.0.0.1:53996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" "}
{"level":"warn","ts":"2026-03-18T00:42:40.589326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.42056479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"}
{"level":"info","ts":"2026-03-18T00:42:40.589348Z","caller":"traceutil/trace.go:171","msg":"trace[248731709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:292; }","duration":"1.440839688s","start":"2026-03-18T00:42:39.148491Z","end":"2026-03-18T00:42:40.589331Z","steps":["trace[248731709] 'agreement among raft nodes before linearized reading'  (duration: 1.440723957s)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:40.589383Z","caller":"traceutil/trace.go:171","msg":"trace[944315479] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:292; }","duration":"1.420659701s","start":"2026-03-18T00:42:39.168707Z","end":"2026-03-18T00:42:40.589367Z","steps":["trace[944315479] 'agreement among raft nodes before linearized reading'  (duration: 1.420505929s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.589389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.148476Z","time spent":"1.44090479s","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T00:42:40.589412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.168688Z","time spent":"1.420719043s","remote":"127.0.0.1:53978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2942,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-03-18T00:42:40.589412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438870454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-18T00:42:40.589449Z","caller":"traceutil/trace.go:171","msg":"trace[516245552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:292; }","duration":"1.438920254s","start":"2026-03-18T00:42:39.150517Z","end":"2026-03-18T00:42:40.589437Z","steps":["trace[516245552] 'agreement among raft nodes before linearized reading'  (duration: 1.438857614s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.58948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.15051Z","time spent":"1.438962724s","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-18T00:42:40.58953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042865136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:42:40.589546Z","caller":"traceutil/trace.go:171","msg":"trace[579459752] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:292; }","duration":"1.042941746s","start":"2026-03-18T00:42:39.5466Z","end":"2026-03-18T00:42:40.589542Z","steps":["trace[579459752] 'agreement among raft nodes before linearized reading'  (duration: 1.042916025s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:40.589559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:39.546566Z","time spent":"1.042989816s","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-18T00:42:44.304173Z","caller":"traceutil/trace.go:171","msg":"trace[2042514938] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"109.70595ms","start":"2026-03-18T00:42:44.194449Z","end":"2026-03-18T00:42:44.304155Z","steps":["trace[2042514938] 'process raft request'  (duration: 109.601539ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:45.247904Z","caller":"traceutil/trace.go:171","msg":"trace[1046138524] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"102.872757ms","start":"2026-03-18T00:42:45.145008Z","end":"2026-03-18T00:42:45.247881Z","steps":["trace[1046138524] 'process raft request'  (duration: 102.741126ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:45.255096Z","caller":"traceutil/trace.go:171","msg":"trace[1841544784] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"107.79493ms","start":"2026-03-18T00:42:45.147268Z","end":"2026-03-18T00:42:45.255063Z","steps":["trace[1841544784] 'process raft request'  (duration: 107.440488ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:45.837392Z","caller":"traceutil/trace.go:171","msg":"trace[1476324464] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"135.289679ms","start":"2026-03-18T00:42:45.702057Z","end":"2026-03-18T00:42:45.837347Z","steps":["trace[1476324464] 'process raft request'  (duration: 83.244742ms)","trace[1476324464] 'compare'  (duration: 51.723265ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:45.83774Z","caller":"traceutil/trace.go:171","msg":"trace[1508794037] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"134.927786ms","start":"2026-03-18T00:42:45.702778Z","end":"2026-03-18T00:42:45.837706Z","steps":["trace[1508794037] 'process raft request'  (duration: 134.680615ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:45.837816Z","caller":"traceutil/trace.go:171","msg":"trace[152809465] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"135.533861ms","start":"2026-03-18T00:42:45.702241Z","end":"2026-03-18T00:42:45.837775Z","steps":["trace[152809465] 'process raft request'  (duration: 135.143838ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.050961Z","caller":"traceutil/trace.go:171","msg":"trace[2115392409] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"173.398448ms","start":"2026-03-18T00:42:45.877538Z","end":"2026-03-18T00:42:46.050937Z","steps":["trace[2115392409] 'process raft request'  (duration: 129.107977ms)","trace[2115392409] 'compare'  (duration: 44.17726ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:46.062274Z","caller":"traceutil/trace.go:171","msg":"trace[1563706473] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"142.104882ms","start":"2026-03-18T00:42:45.920139Z","end":"2026-03-18T00:42:46.062244Z","steps":["trace[1563706473] 'process raft request'  (duration: 142.005881ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.06252Z","caller":"traceutil/trace.go:171","msg":"trace[584908703] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"141.643689ms","start":"2026-03-18T00:42:45.92067Z","end":"2026-03-18T00:42:46.062314Z","steps":["trace[584908703] 'process raft request'  (duration: 141.540549ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.062646Z","caller":"traceutil/trace.go:171","msg":"trace[1560159927] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"133.134971ms","start":"2026-03-18T00:42:45.929448Z","end":"2026-03-18T00:42:46.062583Z","steps":["trace[1560159927] 'process raft request'  (duration: 132.823578ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.062966Z","caller":"traceutil/trace.go:171","msg":"trace[119205927] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"137.756993ms","start":"2026-03-18T00:42:45.924664Z","end":"2026-03-18T00:42:46.062421Z","steps":["trace[119205927] 'process raft request'  (duration: 137.575061ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.180266Z","caller":"traceutil/trace.go:171","msg":"trace[1309543355] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"113.446842ms","start":"2026-03-18T00:42:46.066784Z","end":"2026-03-18T00:42:46.180231Z","steps":["trace[1309543355] 'process raft request'  (duration: 91.681404ms)","trace[1309543355] 'compare'  (duration: 21.575657ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:46.180573Z","caller":"traceutil/trace.go:171","msg":"trace[1317653373] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"110.659913ms","start":"2026-03-18T00:42:46.069892Z","end":"2026-03-18T00:42:46.180552Z","steps":["trace[1317653373] 'process raft request'  (duration: 110.358412ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.180602Z","caller":"traceutil/trace.go:171","msg":"trace[2037988034] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"108.63395ms","start":"2026-03-18T00:42:46.071947Z","end":"2026-03-18T00:42:46.180581Z","steps":["trace[2037988034] 'process raft request'  (duration: 108.339198ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.180705Z","caller":"traceutil/trace.go:171","msg":"trace[1727297507] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"111.024895ms","start":"2026-03-18T00:42:46.06965Z","end":"2026-03-18T00:42:46.180675Z","steps":["trace[1727297507] 'process raft request'  (duration: 110.557812ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.18081Z","caller":"traceutil/trace.go:171","msg":"trace[1753324912] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"112.052073ms","start":"2026-03-18T00:42:46.068749Z","end":"2026-03-18T00:42:46.180801Z","steps":["trace[1753324912] 'process raft request'  (duration: 111.405599ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.773247Z","caller":"traceutil/trace.go:171","msg":"trace[1942534261] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"124.496398ms","start":"2026-03-18T00:42:46.648719Z","end":"2026-03-18T00:42:46.773215Z","steps":["trace[1942534261] 'process raft request'  (duration: 119.189601ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:46.773527Z","caller":"traceutil/trace.go:171","msg":"trace[847656956] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"120.316208ms","start":"2026-03-18T00:42:46.653192Z","end":"2026-03-18T00:42:46.773508Z","steps":["trace[847656956] 'process raft request'  (duration: 119.960956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:47.43002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.930123ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521224888172658558 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:1fe39cfe64ebbf7d>","response":"size:40"}
{"level":"info","ts":"2026-03-18T00:42:47.430098Z","caller":"traceutil/trace.go:171","msg":"trace[1325952215] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:412; }","duration":"244.202438ms","start":"2026-03-18T00:42:47.185884Z","end":"2026-03-18T00:42:47.430086Z","steps":["trace[1325952215] 'read index received'  (duration: 38.991303ms)","trace[1325952215] 'applied index is now lower than readState.Index'  (duration: 205.209795ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:42:47.430166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.288349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"}
{"level":"info","ts":"2026-03-18T00:42:47.430183Z","caller":"traceutil/trace.go:171","msg":"trace[416976003] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:398; }","duration":"244.40808ms","start":"2026-03-18T00:42:47.18577Z","end":"2026-03-18T00:42:47.430178Z","steps":["trace[416976003] 'agreement among raft nodes before linearized reading'  (duration: 244.3482ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:47.430184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:42:47.109728Z","time spent":"320.443403ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-18T00:42:47.69517Z","caller":"traceutil/trace.go:171","msg":"trace[196809094] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"186.42348ms","start":"2026-03-18T00:42:47.508716Z","end":"2026-03-18T00:42:47.695139Z","steps":["trace[196809094] 'process raft request'  (duration: 163.429744ms)","trace[196809094] 'compare'  (duration: 22.867175ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:50.810747Z","caller":"traceutil/trace.go:171","msg":"trace[909032395] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"107.452109ms","start":"2026-03-18T00:42:50.703273Z","end":"2026-03-18T00:42:50.810725Z","steps":["trace[909032395] 'read index received'  (duration: 107.217987ms)","trace[909032395] 'applied index is now lower than readState.Index'  (duration: 233.002µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:42:50.810925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.62848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-18T00:42:50.810968Z","caller":"traceutil/trace.go:171","msg":"trace[1453586537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:410; }","duration":"107.726221ms","start":"2026-03-18T00:42:50.703228Z","end":"2026-03-18T00:42:50.810954Z","steps":["trace[1453586537] 'agreement among raft nodes before linearized reading'  (duration: 107.637491ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:50.811087Z","caller":"traceutil/trace.go:171","msg":"trace[1635344091] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"195.840063ms","start":"2026-03-18T00:42:50.615028Z","end":"2026-03-18T00:42:50.810868Z","steps":["trace[1635344091] 'process raft request'  (duration: 195.544861ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:52.461814Z","caller":"traceutil/trace.go:171","msg":"trace[752794181] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"138.194229ms","start":"2026-03-18T00:42:52.323589Z","end":"2026-03-18T00:42:52.461783Z","steps":["trace[752794181] 'process raft request'  (duration: 137.996788ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:52.779245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.07847ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521224888172658615 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-6hk89\" mod_revision:378 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-6hk89\" value_size:3954 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-6hk89\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:42:52.779418Z","caller":"traceutil/trace.go:171","msg":"trace[1670178791] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"160.643945ms","start":"2026-03-18T00:42:52.618752Z","end":"2026-03-18T00:42:52.779396Z","steps":["trace[1670178791] 'process raft request'  (duration: 54.291313ms)","trace[1670178791] 'compare'  (duration: 105.949599ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:52.779591Z","caller":"traceutil/trace.go:171","msg":"trace[330716131] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"150.937362ms","start":"2026-03-18T00:42:52.628628Z","end":"2026-03-18T00:42:52.779565Z","steps":["trace[330716131] 'read index received'  (duration: 44.430339ms)","trace[330716131] 'applied index is now lower than readState.Index'  (duration: 106.504443ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:42:52.779742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.413462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"}
{"level":"info","ts":"2026-03-18T00:42:52.779776Z","caller":"traceutil/trace.go:171","msg":"trace[922599284] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:429; }","duration":"160.462383ms","start":"2026-03-18T00:42:52.619304Z","end":"2026-03-18T00:42:52.779767Z","steps":["trace[922599284] 'agreement among raft nodes before linearized reading'  (duration: 160.343002ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:52.779617Z","caller":"traceutil/trace.go:171","msg":"trace[382123393] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"143.584753ms","start":"2026-03-18T00:42:52.636019Z","end":"2026-03-18T00:42:52.779604Z","steps":["trace[382123393] 'process raft request'  (duration: 143.333561ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:53.015628Z","caller":"traceutil/trace.go:171","msg":"trace[2032730679] transaction","detail":"{read_only:false; number_of_response:1; response_revision:430; }","duration":"230.987581ms","start":"2026-03-18T00:42:52.784606Z","end":"2026-03-18T00:42:53.015593Z","steps":["trace[2032730679] 'process raft request'  (duration: 226.557602ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:53.015825Z","caller":"traceutil/trace.go:171","msg":"trace[1978408737] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"229.727733ms","start":"2026-03-18T00:42:52.786062Z","end":"2026-03-18T00:42:53.01579Z","steps":["trace[1978408737] 'process raft request'  (duration: 229.397032ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:53.016029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.770707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"}
{"level":"info","ts":"2026-03-18T00:42:53.016091Z","caller":"traceutil/trace.go:171","msg":"trace[1346816871] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:432; }","duration":"228.875237ms","start":"2026-03-18T00:42:52.787196Z","end":"2026-03-18T00:42:53.016071Z","steps":["trace[1346816871] 'agreement among raft nodes before linearized reading'  (duration: 228.493135ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:42:53.015641Z","caller":"traceutil/trace.go:171","msg":"trace[2082563614] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:445; }","duration":"228.384944ms","start":"2026-03-18T00:42:52.787231Z","end":"2026-03-18T00:42:53.015616Z","steps":["trace[2082563614] 'read index received'  (duration: 74.915697ms)","trace[2082563614] 'applied index is now lower than readState.Index'  (duration: 153.468167ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:42:53.015926Z","caller":"traceutil/trace.go:171","msg":"trace[1547334326] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"227.58144ms","start":"2026-03-18T00:42:52.78832Z","end":"2026-03-18T00:42:53.015901Z","steps":["trace[1547334326] 'process raft request'  (duration: 227.223718ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:53.016437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.157562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-18T00:42:53.016486Z","caller":"traceutil/trace.go:171","msg":"trace[428456193] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:432; }","duration":"188.242663ms","start":"2026-03-18T00:42:52.828228Z","end":"2026-03-18T00:42:53.01647Z","steps":["trace[428456193] 'agreement among raft nodes before linearized reading'  (duration: 188.151603ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:42:53.016631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.283566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-18T00:42:53.01667Z","caller":"traceutil/trace.go:171","msg":"trace[110428769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"187.337376ms","start":"2026-03-18T00:42:52.829321Z","end":"2026-03-18T00:42:53.016658Z","steps":["trace[110428769] 'agreement among raft nodes before linearized reading'  (duration: 187.262146ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:09.088609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521224888172658797,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T00:43:09.265766Z","caller":"traceutil/trace.go:171","msg":"trace[944005130] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:538; }","duration":"677.632498ms","start":"2026-03-18T00:43:08.588109Z","end":"2026-03-18T00:43:09.265741Z","steps":["trace[944005130] 'read index received'  (duration: 677.453547ms)","trace[944005130] 'applied index is now lower than readState.Index'  (duration: 178.051µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:09.265892Z","caller":"traceutil/trace.go:171","msg":"trace[561480769] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"824.087706ms","start":"2026-03-18T00:43:08.44178Z","end":"2026-03-18T00:43:09.265867Z","steps":["trace[561480769] 'process raft request'  (duration: 823.829774ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:09.265988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.855289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:43:09.266052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:08.441759Z","time spent":"824.201026ms","remote":"127.0.0.1:54056","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:461 > 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-18T00:43:09.266054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.541449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:43:09.26609Z","caller":"traceutil/trace.go:171","msg":"trace[500534558] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:519; }","duration":"678.00322ms","start":"2026-03-18T00:43:08.588065Z","end":"2026-03-18T00:43:09.266068Z","steps":["trace[500534558] 'agreement among raft nodes before linearized reading'  (duration: 677.849829ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:09.266149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.007225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-18T00:43:09.26617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:08.588048Z","time spent":"678.09241ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "}
{"level":"warn","ts":"2026-03-18T00:43:09.266235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.018781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-18T00:43:09.266264Z","caller":"traceutil/trace.go:171","msg":"trace[1293106161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"124.047201ms","start":"2026-03-18T00:43:09.142211Z","end":"2026-03-18T00:43:09.266258Z","steps":["trace[1293106161] 'agreement among raft nodes before linearized reading'  (duration: 124.00204ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:09.266102Z","caller":"traceutil/trace.go:171","msg":"trace[395924475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"230.623801ms","start":"2026-03-18T00:43:09.035463Z","end":"2026-03-18T00:43:09.266087Z","steps":["trace[395924475] 'agreement among raft nodes before linearized reading'  (duration: 230.55504ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:09.266186Z","caller":"traceutil/trace.go:171","msg":"trace[1852234236] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"106.076696ms","start":"2026-03-18T00:43:09.160098Z","end":"2026-03-18T00:43:09.266175Z","steps":["trace[1852234236] 'agreement among raft nodes before linearized reading'  (duration: 106.023896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:09.569224Z","caller":"traceutil/trace.go:171","msg":"trace[2019490354] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"298.258829ms","start":"2026-03-18T00:43:09.270937Z","end":"2026-03-18T00:43:09.569196Z","steps":["trace[2019490354] 'process raft request'  (duration: 267.302267ms)","trace[2019490354] 'compare'  (duration: 30.768991ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:09.576748Z","caller":"traceutil/trace.go:171","msg":"trace[1699457889] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"305.677313ms","start":"2026-03-18T00:43:09.271057Z","end":"2026-03-18T00:43:09.576735Z","steps":["trace[1699457889] 'process raft request'  (duration: 305.589423ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:09.576835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:09.271049Z","time spent":"305.732203ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:518 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:43:09.576947Z","caller":"traceutil/trace.go:171","msg":"trace[971261894] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"305.409731ms","start":"2026-03-18T00:43:09.271521Z","end":"2026-03-18T00:43:09.576931Z","steps":["trace[971261894] 'process raft request'  (duration: 305.355381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:09.576982Z","caller":"traceutil/trace.go:171","msg":"trace[375513665] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"305.549802ms","start":"2026-03-18T00:43:09.271407Z","end":"2026-03-18T00:43:09.576957Z","steps":["trace[375513665] 'process raft request'  (duration: 305.302361ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:09.577033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:09.27151Z","time spent":"305.480841ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:517 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-18T00:43:09.57712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:09.271347Z","time spent":"305.701293ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:516 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-18T00:43:13.420394Z","caller":"traceutil/trace.go:171","msg":"trace[1462825922] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"155.577242ms","start":"2026-03-18T00:43:13.264791Z","end":"2026-03-18T00:43:13.420368Z","steps":["trace[1462825922] 'process raft request'  (duration: 155.410001ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:13.903515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.997722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-18T00:43:13.903612Z","caller":"traceutil/trace.go:171","msg":"trace[51308605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"311.123883ms","start":"2026-03-18T00:43:13.592464Z","end":"2026-03-18T00:43:13.903588Z","steps":["trace[51308605] 'range keys from in-memory index tree'  (duration: 310.904472ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:13.90367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:13.592459Z","time spent":"311.197764ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T00:43:13.903877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.991316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-18T00:43:13.903924Z","caller":"traceutil/trace.go:171","msg":"trace[694467660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"315.090536ms","start":"2026-03-18T00:43:13.588822Z","end":"2026-03-18T00:43:13.903912Z","steps":["trace[694467660] 'range keys from in-memory index tree'  (duration: 314.872375ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:13.903957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:13.588797Z","time spent":"315.151737ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-18T00:43:13.903981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.625479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-18T00:43:13.903989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.566064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-18T00:43:13.904037Z","caller":"traceutil/trace.go:171","msg":"trace[2013775786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"320.738329ms","start":"2026-03-18T00:43:13.583285Z","end":"2026-03-18T00:43:13.904023Z","steps":["trace[2013775786] 'range keys from in-memory index tree'  (duration: 320.434617ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:13.904041Z","caller":"traceutil/trace.go:171","msg":"trace[1669560709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"314.638434ms","start":"2026-03-18T00:43:13.589393Z","end":"2026-03-18T00:43:13.904031Z","steps":["trace[1669560709] 'range keys from in-memory index tree'  (duration: 314.507944ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:13.904063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:13.583258Z","time spent":"320.799969ms","remote":"127.0.0.1:54056","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-18T00:43:13.904064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:13.589388Z","time spent":"314.670444ms","remote":"127.0.0.1:54056","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":"info","ts":"2026-03-18T00:43:14.135567Z","caller":"traceutil/trace.go:171","msg":"trace[1993783249] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"226.897693ms","start":"2026-03-18T00:43:13.908645Z","end":"2026-03-18T00:43:14.135543Z","steps":["trace[1993783249] 'process raft request'  (duration: 226.695002ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:14.13595Z","caller":"traceutil/trace.go:171","msg":"trace[1468297153] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"227.246394ms","start":"2026-03-18T00:43:13.908673Z","end":"2026-03-18T00:43:14.13592Z","steps":["trace[1468297153] 'process raft request'  (duration: 226.816811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:14.135982Z","caller":"traceutil/trace.go:171","msg":"trace[661933608] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"227.240864ms","start":"2026-03-18T00:43:13.908728Z","end":"2026-03-18T00:43:14.135969Z","steps":["trace[661933608] 'process raft request'  (duration: 227.048253ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:16.905779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.446225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-18T00:43:16.905847Z","caller":"traceutil/trace.go:171","msg":"trace[908710094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"765.577067ms","start":"2026-03-18T00:43:16.140253Z","end":"2026-03-18T00:43:16.90583Z","steps":["trace[908710094] 'range keys from in-memory index tree'  (duration: 765.249655ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:16.905877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:16.140231Z","time spent":"765.640157ms","remote":"127.0.0.1:54056","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-03-18T00:43:16.905842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.941083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-18T00:43:16.905881Z","caller":"traceutil/trace.go:171","msg":"trace[1126643754] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"196.264574ms","start":"2026-03-18T00:43:16.709586Z","end":"2026-03-18T00:43:16.90585Z","steps":["trace[1126643754] 'read index received'  (duration: 118.336217ms)","trace[1126643754] 'applied index is now lower than readState.Index'  (duration: 77.926407ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:16.905938Z","caller":"traceutil/trace.go:171","msg":"trace[653615577] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"765.077594ms","start":"2026-03-18T00:43:16.14083Z","end":"2026-03-18T00:43:16.905908Z","steps":["trace[653615577] 'range keys from in-memory index tree'  (duration: 764.756562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:16.905929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.648377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-18T00:43:16.905988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:16.14082Z","time spent":"765.158484ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-18T00:43:16.906085Z","caller":"traceutil/trace.go:171","msg":"trace[1126912007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"765.899668ms","start":"2026-03-18T00:43:16.140145Z","end":"2026-03-18T00:43:16.906045Z","steps":["trace[1126912007] 'range keys from in-memory index tree'  (duration: 765.366635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:16.906064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.461155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-18T00:43:16.906185Z","caller":"traceutil/trace.go:171","msg":"trace[212904580] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:559; }","duration":"196.618236ms","start":"2026-03-18T00:43:16.709544Z","end":"2026-03-18T00:43:16.906163Z","steps":["trace[212904580] 'agreement among raft nodes before linearized reading'  (duration: 196.391225ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:16.906488Z","caller":"traceutil/trace.go:171","msg":"trace[221005568] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"393.709666ms","start":"2026-03-18T00:43:16.512714Z","end":"2026-03-18T00:43:16.906424Z","steps":["trace[221005568] 'process raft request'  (duration: 315.133026ms)","trace[221005568] 'compare'  (duration: 77.446663ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:43:16.90659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:16.512682Z","time spent":"393.839016ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:513 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-18T00:43:16.907423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:16.140096Z","time spent":"767.269325ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-18T00:43:17.061622Z","caller":"traceutil/trace.go:171","msg":"trace[563153563] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"149.845357ms","start":"2026-03-18T00:43:16.911755Z","end":"2026-03-18T00:43:17.0616Z","steps":["trace[563153563] 'process raft request'  (duration: 149.811817ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:17.061666Z","caller":"traceutil/trace.go:171","msg":"trace[142369991] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"152.08732ms","start":"2026-03-18T00:43:16.909547Z","end":"2026-03-18T00:43:17.061634Z","steps":["trace[142369991] 'process raft request'  (duration: 151.838179ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:17.061752Z","caller":"traceutil/trace.go:171","msg":"trace[1489967837] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"151.235435ms","start":"2026-03-18T00:43:16.910471Z","end":"2026-03-18T00:43:17.061706Z","steps":["trace[1489967837] 'process raft request'  (duration: 151.061334ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:17.062471Z","caller":"traceutil/trace.go:171","msg":"trace[594577234] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"111.201096ms","start":"2026-03-18T00:43:16.951259Z","end":"2026-03-18T00:43:17.06246Z","steps":["trace[594577234] 'process raft request'  (duration: 110.998624ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:18.867196Z","caller":"traceutil/trace.go:171","msg":"trace[1411733911] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"465.133197ms","start":"2026-03-18T00:43:18.402035Z","end":"2026-03-18T00:43:18.867169Z","steps":["trace[1411733911] 'read index received'  (duration: 460.72321ms)","trace[1411733911] 'applied index is now lower than readState.Index'  (duration: 4.409027ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:18.867238Z","caller":"traceutil/trace.go:171","msg":"trace[1209390433] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"465.442038ms","start":"2026-03-18T00:43:18.401765Z","end":"2026-03-18T00:43:18.867207Z","steps":["trace[1209390433] 'process raft request'  (duration: 460.975671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:18.867346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.287537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:43:18.867389Z","caller":"traceutil/trace.go:171","msg":"trace[1818815081] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:579; }","duration":"465.389708ms","start":"2026-03-18T00:43:18.401985Z","end":"2026-03-18T00:43:18.867375Z","steps":["trace[1818815081] 'agreement among raft nodes before linearized reading'  (duration: 465.306407ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:18.867428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.401968Z","time spent":"465.452208ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "}
{"level":"warn","ts":"2026-03-18T00:43:18.867425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.401753Z","time spent":"465.557018ms","remote":"127.0.0.1:54056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:578 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:43:18.871959Z","caller":"traceutil/trace.go:171","msg":"trace[328338954] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"468.436594ms","start":"2026-03-18T00:43:18.403481Z","end":"2026-03-18T00:43:18.871917Z","steps":["trace[328338954] 'process raft request'  (duration: 468.219063ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:18.872038Z","caller":"traceutil/trace.go:171","msg":"trace[1924948745] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"467.54643ms","start":"2026-03-18T00:43:18.404477Z","end":"2026-03-18T00:43:18.872024Z","steps":["trace[1924948745] 'process raft request'  (duration: 467.350429ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:18.872058Z","caller":"traceutil/trace.go:171","msg":"trace[198364663] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"271.656925ms","start":"2026-03-18T00:43:18.600385Z","end":"2026-03-18T00:43:18.872042Z","steps":["trace[198364663] 'process raft request'  (duration: 271.510694ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:18.872026Z","caller":"traceutil/trace.go:171","msg":"trace[1125827461] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"462.706022ms","start":"2026-03-18T00:43:18.409283Z","end":"2026-03-18T00:43:18.871989Z","steps":["trace[1125827461] 'process raft request'  (duration: 462.578191ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:18.872087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.404468Z","time spent":"467.5973ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:4482 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:43:18.872109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.973323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:43:18.872143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.403464Z","time spent":"468.582856ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:43:18.872177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.409264Z","time spent":"462.841232ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:12154 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:43:18.872214Z","caller":"traceutil/trace.go:171","msg":"trace[861514905] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:584; }","duration":"470.113784ms","start":"2026-03-18T00:43:18.402075Z","end":"2026-03-18T00:43:18.872189Z","steps":["trace[861514905] 'agreement among raft nodes before linearized reading'  (duration: 469.876072ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:43:18.872265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:43:18.40207Z","time spent":"470.187124ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"info","ts":"2026-03-18T00:43:24.74694Z","caller":"traceutil/trace.go:171","msg":"trace[978556482] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"126.153736ms","start":"2026-03-18T00:43:24.620764Z","end":"2026-03-18T00:43:24.746918Z","steps":["trace[978556482] 'process raft request'  (duration: 124.080768ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:43:39.314559Z","caller":"traceutil/trace.go:171","msg":"trace[891379574] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"121.469278ms","start":"2026-03-18T00:43:39.193068Z","end":"2026-03-18T00:43:39.314537Z","steps":["trace[891379574] 'process raft request'  (duration: 49.858842ms)","trace[891379574] 'compare'  (duration: 71.524095ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:43:39.314868Z","caller":"traceutil/trace.go:171","msg":"trace[2137496680] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"121.694794ms","start":"2026-03-18T00:43:39.193124Z","end":"2026-03-18T00:43:39.314819Z","steps":["trace[2137496680] 'process raft request'  (duration: 121.588872ms)"],"step_count":1}