{"level":"warn","ts":"2026-09-22T02:09:46.579375Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-22T02:09:46.579502Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.208: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://162.253.55.208:2380","--initial-cluster=instance=https://162.253.55.208:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.208:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.208: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-09-22T02:09:46.579607Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-22T02:09:46.579622Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.208:2380"]}
{"level":"info","ts":"2026-09-22T02:09:46.579649Z","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-09-22T02:09:46.58037Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"]}
{"level":"info","ts":"2026-09-22T02:09:46.580477Z","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://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.208: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-09-22T02:09:46.582754Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.071249ms"}
{"level":"info","ts":"2026-09-22T02:09:46.588895Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5019b1666ea94ec4","cluster-id":"5aff54f2fc6d3e3d"}
{"level":"info","ts":"2026-09-22T02:09:46.58897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-22T02:09:46.589018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 0"}
{"level":"info","ts":"2026-09-22T02:09:46.589031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5019b1666ea94ec4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-22T02:09:46.58905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 1"}
{"level":"info","ts":"2026-09-22T02:09:46.589096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"}
{"level":"warn","ts":"2026-09-22T02:09:46.598976Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-22T02:09:46.600263Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-22T02:09:46.601524Z","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-09-22T02:09:46.603281Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5019b1666ea94ec4","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-22T02:09:46.604549Z","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-09-22T02:09:46.604816Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5019b1666ea94ec4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-22T02:09:46.604912Z","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-09-22T02:09:46.604927Z","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-09-22T02:09:46.605708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"}
{"level":"info","ts":"2026-09-22T02:09:46.605826Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","added-peer-id":"5019b1666ea94ec4","added-peer-peer-urls":["https://162.253.55.208:2380"]}
{"level":"info","ts":"2026-09-22T02:09:46.608117Z","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-09-22T02:09:46.608277Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.208:2380"}
{"level":"info","ts":"2026-09-22T02:09:46.608316Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.208:2380"}
{"level":"info","ts":"2026-09-22T02:09:46.608464Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5019b1666ea94ec4","initial-advertise-peer-urls":["https://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-22T02:09:46.608519Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-22T02:09:47.389953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-22T02:09:47.390176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-22T02:09:47.390252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgPreVoteResp from 5019b1666ea94ec4 at term 1"}
{"level":"info","ts":"2026-09-22T02:09:47.390324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became candidate at term 2"}
{"level":"info","ts":"2026-09-22T02:09:47.390408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgVoteResp from 5019b1666ea94ec4 at term 2"}
{"level":"info","ts":"2026-09-22T02:09:47.390473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became leader at term 2"}
{"level":"info","ts":"2026-09-22T02:09:47.390537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5019b1666ea94ec4 elected leader 5019b1666ea94ec4 at term 2"}
{"level":"info","ts":"2026-09-22T02:09:47.391705Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5019b1666ea94ec4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.208:2379]}","request-path":"/0/members/5019b1666ea94ec4/attributes","cluster-id":"5aff54f2fc6d3e3d","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-22T02:09:47.391802Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T02:09:47.391744Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-22T02:09:47.391759Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-22T02:09:47.392848Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T02:09:47.393018Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T02:09:47.393047Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-22T02:09:47.394093Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-22T02:09:47.394116Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-22T02:09:47.395499Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.208:2379"}
{"level":"info","ts":"2026-09-22T02:09:47.396531Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-22T02:09:50.186683Z","caller":"traceutil/trace.go:171","msg":"trace[909610557] transaction","detail":"{read_only:false; response_revision:131; number_of_response:1; }","duration":"116.505652ms","start":"2026-09-22T02:09:50.070118Z","end":"2026-09-22T02:09:50.186623Z","steps":["trace[909610557] 'process raft request'  (duration: 112.823571ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:53.610148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.424474ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5675838206421524369 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:253 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4252 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-22T02:09:53.610395Z","caller":"traceutil/trace.go:171","msg":"trace[1514177274] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"330.341738ms","start":"2026-09-22T02:09:53.280014Z","end":"2026-09-22T02:09:53.610355Z","steps":["trace[1514177274] 'process raft request'  (duration: 330.268106ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:09:53.610421Z","caller":"traceutil/trace.go:171","msg":"trace[1996479274] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:298; }","duration":"449.240774ms","start":"2026-09-22T02:09:53.161116Z","end":"2026-09-22T02:09:53.610357Z","steps":["trace[1996479274] 'read index received'  (duration: 172.606415ms)","trace[1996479274] 'applied index is now lower than readState.Index'  (duration: 276.632499ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:09:53.610477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.279977Z","time spent":"330.457739ms","remote":"127.0.0.1:33134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":170,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/kube-proxy\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/kube-proxy\" value_size:115 >> failure:<>"}
{"level":"warn","ts":"2026-09-22T02:09:53.610649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.68899ms","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-09-22T02:09:53.61068Z","caller":"traceutil/trace.go:171","msg":"trace[1228334583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:293; }","duration":"193.746571ms","start":"2026-09-22T02:09:53.416923Z","end":"2026-09-22T02:09:53.61067Z","steps":["trace[1228334583] 'agreement among raft nodes before linearized reading'  (duration: 193.69926ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:53.61066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.943623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"}
{"level":"info","ts":"2026-09-22T02:09:53.610761Z","caller":"traceutil/trace.go:171","msg":"trace[871975986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:293; }","duration":"421.066945ms","start":"2026-09-22T02:09:53.189678Z","end":"2026-09-22T02:09:53.610745Z","steps":["trace[871975986] 'agreement among raft nodes before linearized reading'  (duration: 420.919612ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:53.61083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.189667Z","time spent":"421.151717ms","remote":"127.0.0.1:33134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "}
{"level":"warn","ts":"2026-09-22T02:09:53.61072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.584451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:09:53.611004Z","caller":"traceutil/trace.go:171","msg":"trace[2082683795] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:293; }","duration":"449.856206ms","start":"2026-09-22T02:09:53.161099Z","end":"2026-09-22T02:09:53.610955Z","steps":["trace[2082683795] 'agreement among raft nodes before linearized reading'  (duration: 449.496129ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:53.611073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.161038Z","time spent":"450.018539ms","remote":"127.0.0.1:33064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "}
{"level":"info","ts":"2026-09-22T02:09:53.611485Z","caller":"traceutil/trace.go:171","msg":"trace[2054967048] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"466.817242ms","start":"2026-09-22T02:09:53.144635Z","end":"2026-09-22T02:09:53.611453Z","steps":["trace[2054967048] 'process raft request'  (duration: 189.217745ms)","trace[2054967048] 'compare'  (duration: 274.984687ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:09:53.611642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.144615Z","time spent":"466.951034ms","remote":"127.0.0.1:33104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4286,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:253 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4252 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-09-22T02:09:54.113582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.58436ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5675838206421524373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" value_size:362 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-22T02:09:54.113717Z","caller":"traceutil/trace.go:171","msg":"trace[77231749] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"499.272812ms","start":"2026-09-22T02:09:53.61442Z","end":"2026-09-22T02:09:54.113693Z","steps":["trace[77231749] 'process raft request'  (duration: 308.500418ms)","trace[77231749] 'compare'  (duration: 190.404207ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:09:54.113773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.614393Z","time spent":"499.359644ms","remote":"127.0.0.1:33308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" value_size:362 >> failure:<>"}
{"level":"info","ts":"2026-09-22T02:09:54.114309Z","caller":"traceutil/trace.go:171","msg":"trace[1819146086] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"499.648649ms","start":"2026-09-22T02:09:53.614646Z","end":"2026-09-22T02:09:54.114295Z","steps":["trace[1819146086] 'process raft request'  (duration: 499.431285ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.614632Z","time spent":"499.720331ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"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":"info","ts":"2026-09-22T02:09:54.114453Z","caller":"traceutil/trace.go:171","msg":"trace[2083617013] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"499.69824ms","start":"2026-09-22T02:09:53.614717Z","end":"2026-09-22T02:09:54.114415Z","steps":["trace[2083617013] 'process raft request'  (duration: 499.487766ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:09:54.114493Z","caller":"traceutil/trace.go:171","msg":"trace[1288717362] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"499.633041ms","start":"2026-09-22T02:09:53.614786Z","end":"2026-09-22T02:09:54.114419Z","steps":["trace[1288717362] 'process raft request'  (duration: 499.502988ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:09:54.114477Z","caller":"traceutil/trace.go:171","msg":"trace[1800998682] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:300; }","duration":"498.760033ms","start":"2026-09-22T02:09:53.615683Z","end":"2026-09-22T02:09:54.114443Z","steps":["trace[1800998682] 'read index received'  (duration: 307.256064ms)","trace[1800998682] 'applied index is now lower than readState.Index'  (duration: 191.502659ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:09:54.114578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.614772Z","time spent":"499.772183ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"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":"info","ts":"2026-09-22T02:09:54.114613Z","caller":"traceutil/trace.go:171","msg":"trace[43859990] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"499.754363ms","start":"2026-09-22T02:09:53.614848Z","end":"2026-09-22T02:09:54.114602Z","steps":["trace[43859990] 'process raft request'  (duration: 499.472428ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.61471Z","time spent":"499.830673ms","remote":"127.0.0.1:33202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<>"}
{"level":"info","ts":"2026-09-22T02:09:54.114685Z","caller":"traceutil/trace.go:171","msg":"trace[1352904305] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"499.776513ms","start":"2026-09-22T02:09:53.614898Z","end":"2026-09-22T02:09:54.114675Z","steps":["trace[1352904305] 'process raft request'  (duration: 499.454897ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.614889Z","time spent":"499.817574ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"info","ts":"2026-09-22T02:09:54.114719Z","caller":"traceutil/trace.go:171","msg":"trace[1364872640] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"499.285734ms","start":"2026-09-22T02:09:53.615402Z","end":"2026-09-22T02:09:54.114688Z","steps":["trace[1364872640] 'process raft request'  (duration: 499.006918ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.61484Z","time spent":"499.803754ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":38,"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-09-22T02:09:54.114771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.813355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-22T02:09:54.114818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.615375Z","time spent":"499.397785ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-09-22T02:09:54.114792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.076289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"}
{"level":"info","ts":"2026-09-22T02:09:54.114846Z","caller":"traceutil/trace.go:171","msg":"trace[1326433193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:300; }","duration":"474.923886ms","start":"2026-09-22T02:09:53.639904Z","end":"2026-09-22T02:09:54.114828Z","steps":["trace[1326433193] 'agreement among raft nodes before linearized reading'  (duration: 474.756033ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.631131ms","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-09-22T02:09:54.114911Z","caller":"traceutil/trace.go:171","msg":"trace[2021807388] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:300; }","duration":"499.235782ms","start":"2026-09-22T02:09:53.615645Z","end":"2026-09-22T02:09:54.114881Z","steps":["trace[2021807388] 'agreement among raft nodes before linearized reading'  (duration: 498.961847ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.639892Z","time spent":"475.015878ms","remote":"127.0.0.1:33202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-22T02:09:54.11495Z","caller":"traceutil/trace.go:171","msg":"trace[2014121884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:300; }","duration":"274.711662ms","start":"2026-09-22T02:09:53.840227Z","end":"2026-09-22T02:09:54.114939Z","steps":["trace[2014121884] 'agreement among raft nodes before linearized reading'  (duration: 274.64334ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:09:54.114963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:53.615633Z","time spent":"499.320454ms","remote":"127.0.0.1:33134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "}
{"level":"info","ts":"2026-09-22T02:10:26.042136Z","caller":"traceutil/trace.go:171","msg":"trace[1874422848] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"112.624387ms","start":"2026-09-22T02:10:25.929474Z","end":"2026-09-22T02:10:26.042098Z","steps":["trace[1874422848] 'process raft request'  (duration: 112.175169ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:26.04221Z","caller":"traceutil/trace.go:171","msg":"trace[543930397] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"100.74317ms","start":"2026-09-22T02:10:25.94145Z","end":"2026-09-22T02:10:26.042193Z","steps":["trace[543930397] 'process raft request'  (duration: 100.418493ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:26.34277Z","caller":"traceutil/trace.go:171","msg":"trace[1324127598] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"251.324914ms","start":"2026-09-22T02:10:26.0914Z","end":"2026-09-22T02:10:26.342725Z","steps":["trace[1324127598] 'process raft request'  (duration: 248.907227ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:26.342884Z","caller":"traceutil/trace.go:171","msg":"trace[1672172042] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"214.01083ms","start":"2026-09-22T02:10:26.128842Z","end":"2026-09-22T02:10:26.342852Z","steps":["trace[1672172042] 'read index received'  (duration: 211.478742ms)","trace[1672172042] 'applied index is now lower than readState.Index'  (duration: 2.529758ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:10:26.34313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.247265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:10:26.343239Z","caller":"traceutil/trace.go:171","msg":"trace[2032698275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"214.416637ms","start":"2026-09-22T02:10:26.128797Z","end":"2026-09-22T02:10:26.343213Z","steps":["trace[2032698275] 'agreement among raft nodes before linearized reading'  (duration: 214.192353ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:26.35148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.852259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"}
{"level":"info","ts":"2026-09-22T02:10:26.351611Z","caller":"traceutil/trace.go:171","msg":"trace[1004011438] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:531; }","duration":"199.065003ms","start":"2026-09-22T02:10:26.15252Z","end":"2026-09-22T02:10:26.351585Z","steps":["trace[1004011438] 'agreement among raft nodes before linearized reading'  (duration: 198.426171ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:33.777759Z","caller":"traceutil/trace.go:171","msg":"trace[2019032814] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"182.075256ms","start":"2026-09-22T02:10:33.595641Z","end":"2026-09-22T02:10:33.777716Z","steps":["trace[2019032814] 'process raft request'  (duration: 181.237411ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:33.783704Z","caller":"traceutil/trace.go:171","msg":"trace[2129624240] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"173.684425ms","start":"2026-09-22T02:10:33.609645Z","end":"2026-09-22T02:10:33.783329Z","steps":["trace[2129624240] 'process raft request'  (duration: 173.516932ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:34.016791Z","caller":"traceutil/trace.go:171","msg":"trace[14897021] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"161.499513ms","start":"2026-09-22T02:10:33.855264Z","end":"2026-09-22T02:10:34.016764Z","steps":["trace[14897021] 'process raft request'  (duration: 159.049696ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:34.893501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5675838206421525066,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-22T02:10:34.957198Z","caller":"traceutil/trace.go:171","msg":"trace[1725737534] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"753.566696ms","start":"2026-09-22T02:10:34.203601Z","end":"2026-09-22T02:10:34.957168Z","steps":["trace[1725737534] 'process raft request'  (duration: 753.341981ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:34.957457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:34.203558Z","time spent":"753.732879ms","remote":"127.0.0.1:33116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-dpggf\" mod_revision:531 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-dpggf\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-dpggf\" > >"}
{"level":"info","ts":"2026-09-22T02:10:35.012325Z","caller":"traceutil/trace.go:171","msg":"trace[258331677] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"619.172311ms","start":"2026-09-22T02:10:34.393121Z","end":"2026-09-22T02:10:35.012293Z","steps":["trace[258331677] 'read index received'  (duration: 564.367905ms)","trace[258331677] 'applied index is now lower than readState.Index'  (duration: 54.803176ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T02:10:35.012859Z","caller":"traceutil/trace.go:171","msg":"trace[1751070594] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"527.138983ms","start":"2026-09-22T02:10:34.485538Z","end":"2026-09-22T02:10:35.012677Z","steps":["trace[1751070594] 'process raft request'  (duration: 524.659206ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:35.01307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:34.485501Z","time spent":"527.407849ms","remote":"127.0.0.1:33014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:640 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036181 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-09-22T02:10:35.013647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.503647ms","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-09-22T02:10:35.013691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.712471ms","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-09-22T02:10:35.013755Z","caller":"traceutil/trace.go:171","msg":"trace[1430584587] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:644; }","duration":"620.65629ms","start":"2026-09-22T02:10:34.393059Z","end":"2026-09-22T02:10:35.013716Z","steps":["trace[1430584587] 'agreement among raft nodes before linearized reading'  (duration: 620.371584ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:35.013755Z","caller":"traceutil/trace.go:171","msg":"trace[1430947203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:644; }","duration":"619.794373ms","start":"2026-09-22T02:10:34.393937Z","end":"2026-09-22T02:10:35.013732Z","steps":["trace[1430947203] 'agreement among raft nodes before linearized reading'  (duration: 619.401525ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:35.013738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.003415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-22T02:10:35.0138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:34.39304Z","time spent":"620.748841ms","remote":"127.0.0.1:33202","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-09-22T02:10:35.013926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:34.393927Z","time spent":"619.873624ms","remote":"127.0.0.1:33202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-22T02:10:35.013954Z","caller":"traceutil/trace.go:171","msg":"trace[697882768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:644; }","duration":"599.196239ms","start":"2026-09-22T02:10:34.414623Z","end":"2026-09-22T02:10:35.01382Z","steps":["trace[697882768] 'agreement among raft nodes before linearized reading'  (duration: 598.806441ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:10:35.014052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:34.414591Z","time spent":"599.440214ms","remote":"127.0.0.1:33202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-22T02:10:36.48756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.059714ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5675838206421525127 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/deployments/kube-system/cilium-operator\" mod_revision:530 > success:<request_put:<key:\"/registry/deployments/kube-system/cilium-operator\" value_size:4637 >> failure:<request_range:<key:\"/registry/deployments/kube-system/cilium-operator\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-22T02:10:36.48853Z","caller":"traceutil/trace.go:171","msg":"trace[1122680263] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"173.071954ms","start":"2026-09-22T02:10:36.315414Z","end":"2026-09-22T02:10:36.488486Z","steps":["trace[1122680263] 'process raft request'  (duration: 54.911218ms)","trace[1122680263] 'compare'  (duration: 116.85759ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T02:10:36.497239Z","caller":"traceutil/trace.go:171","msg":"trace[1256711046] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"114.655299ms","start":"2026-09-22T02:10:36.382525Z","end":"2026-09-22T02:10:36.49718Z","steps":["trace[1256711046] 'process raft request'  (duration: 114.530436ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:40.408536Z","caller":"traceutil/trace.go:171","msg":"trace[1749056915] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"102.363645ms","start":"2026-09-22T02:10:40.306141Z","end":"2026-09-22T02:10:40.408504Z","steps":["trace[1749056915] 'process raft request'  (duration: 94.934372ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:10:51.574991Z","caller":"traceutil/trace.go:171","msg":"trace[892082422] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"200.667431ms","start":"2026-09-22T02:10:51.374282Z","end":"2026-09-22T02:10:51.574949Z","steps":["trace[892082422] 'process raft request'  (duration: 200.389035ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:35.533139Z","caller":"traceutil/trace.go:171","msg":"trace[898237165] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"162.332779ms","start":"2026-09-22T02:11:35.370773Z","end":"2026-09-22T02:11:35.533106Z","steps":["trace[898237165] 'read index received'  (duration: 162.135265ms)","trace[898237165] 'applied index is now lower than readState.Index'  (duration: 196.124µs)"],"step_count":2}
{"level":"info","ts":"2026-09-22T02:11:35.53371Z","caller":"traceutil/trace.go:171","msg":"trace[1668365244] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"166.164693ms","start":"2026-09-22T02:11:35.367481Z","end":"2026-09-22T02:11:35.533645Z","steps":["trace[1668365244] 'process raft request'  (duration: 165.371287ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:35.534204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.4185ms","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-09-22T02:11:35.534251Z","caller":"traceutil/trace.go:171","msg":"trace[387733930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1104; }","duration":"163.495562ms","start":"2026-09-22T02:11:35.370736Z","end":"2026-09-22T02:11:35.534231Z","steps":["trace[387733930] 'agreement among raft nodes before linearized reading'  (duration: 162.486412ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:35.540058Z","caller":"traceutil/trace.go:171","msg":"trace[1738795636] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"110.220935ms","start":"2026-09-22T02:11:35.429764Z","end":"2026-09-22T02:11:35.539985Z","steps":["trace[1738795636] 'process raft request'  (duration: 104.650899ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:35.540092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.797473ms","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-09-22T02:11:35.540158Z","caller":"traceutil/trace.go:171","msg":"trace[836543310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"147.892565ms","start":"2026-09-22T02:11:35.392234Z","end":"2026-09-22T02:11:35.540127Z","steps":["trace[836543310] 'agreement among raft nodes before linearized reading'  (duration: 147.632199ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:35.54038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.426775ms","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-09-22T02:11:35.540439Z","caller":"traceutil/trace.go:171","msg":"trace[1386671673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"146.517876ms","start":"2026-09-22T02:11:35.393891Z","end":"2026-09-22T02:11:35.540409Z","steps":["trace[1386671673] 'agreement among raft nodes before linearized reading'  (duration: 146.343604ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:57.297605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.383775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:11:57.297716Z","caller":"traceutil/trace.go:171","msg":"trace[1191611600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1212; }","duration":"168.569578ms","start":"2026-09-22T02:11:57.129123Z","end":"2026-09-22T02:11:57.297693Z","steps":["trace[1191611600] 'range keys from in-memory index tree'  (duration: 168.226982ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:57.817182Z","caller":"traceutil/trace.go:171","msg":"trace[1460336978] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"116.568486ms","start":"2026-09-22T02:11:57.700577Z","end":"2026-09-22T02:11:57.817146Z","steps":["trace[1460336978] 'process raft request'  (duration: 55.627742ms)","trace[1460336978] 'compare'  (duration: 60.76479ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:11:57.913221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.207595ms","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-09-22T02:11:57.913299Z","caller":"traceutil/trace.go:171","msg":"trace[1342679029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1215; }","duration":"175.316737ms","start":"2026-09-22T02:11:57.737963Z","end":"2026-09-22T02:11:57.91328Z","steps":["trace[1342679029] 'agreement among raft nodes before linearized reading'  (duration: 175.079273ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:57.913699Z","caller":"traceutil/trace.go:171","msg":"trace[549124385] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"175.662434ms","start":"2026-09-22T02:11:57.738023Z","end":"2026-09-22T02:11:57.913685Z","steps":["trace[549124385] 'process raft request'  (duration: 174.838218ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:58.097453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.665299ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5675838206421526322 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1206 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-22T02:11:58.097671Z","caller":"traceutil/trace.go:171","msg":"trace[69883574] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1262; }","duration":"184.646035ms","start":"2026-09-22T02:11:57.913001Z","end":"2026-09-22T02:11:58.097647Z","steps":["trace[69883574] 'read index received'  (duration: 14.586938ms)","trace[69883574] 'applied index is now lower than readState.Index'  (duration: 170.056907ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T02:11:58.097784Z","caller":"traceutil/trace.go:171","msg":"trace[1355736618] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"275.851037ms","start":"2026-09-22T02:11:57.82188Z","end":"2026-09-22T02:11:58.097731Z","steps":["trace[1355736618] 'process raft request'  (duration: 105.759789ms)","trace[1355736618] 'compare'  (duration: 169.519076ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:11:58.098019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.264928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:11:58.098088Z","caller":"traceutil/trace.go:171","msg":"trace[1387194115] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1217; }","duration":"228.389301ms","start":"2026-09-22T02:11:57.869674Z","end":"2026-09-22T02:11:58.098063Z","steps":["trace[1387194115] 'agreement among raft nodes before linearized reading'  (duration: 228.039764ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:58.098082Z","caller":"traceutil/trace.go:171","msg":"trace[602833006] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"179.444987ms","start":"2026-09-22T02:11:57.918594Z","end":"2026-09-22T02:11:58.098039Z","steps":["trace[602833006] 'process raft request'  (duration: 178.983888ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:58.098551Z","caller":"traceutil/trace.go:171","msg":"trace[1165502726] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"178.791874ms","start":"2026-09-22T02:11:57.91972Z","end":"2026-09-22T02:11:58.098512Z","steps":["trace[1165502726] 'process raft request'  (duration: 178.207522ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:58.384005Z","caller":"traceutil/trace.go:171","msg":"trace[1453376186] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1265; }","duration":"254.319805ms","start":"2026-09-22T02:11:58.129634Z","end":"2026-09-22T02:11:58.383954Z","steps":["trace[1453376186] 'read index received'  (duration: 27.76707ms)","trace[1453376186] 'applied index is now lower than readState.Index'  (duration: 226.551285ms)"],"step_count":2}
{"level":"info","ts":"2026-09-22T02:11:58.384183Z","caller":"traceutil/trace.go:171","msg":"trace[1986803593] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"277.307524ms","start":"2026-09-22T02:11:58.106829Z","end":"2026-09-22T02:11:58.384137Z","steps":["trace[1986803593] 'process raft request'  (duration: 276.957758ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:11:58.384197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.540939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:11:58.384235Z","caller":"traceutil/trace.go:171","msg":"trace[1968837504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1220; }","duration":"254.60457ms","start":"2026-09-22T02:11:58.12962Z","end":"2026-09-22T02:11:58.384225Z","steps":["trace[1968837504] 'agreement among raft nodes before linearized reading'  (duration: 254.458917ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:58.388734Z","caller":"traceutil/trace.go:171","msg":"trace[1291531513] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"204.30133ms","start":"2026-09-22T02:11:58.184353Z","end":"2026-09-22T02:11:58.388655Z","steps":["trace[1291531513] 'process raft request'  (duration: 203.838281ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:11:58.519935Z","caller":"traceutil/trace.go:171","msg":"trace[2093478612] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"124.469706ms","start":"2026-09-22T02:11:58.395422Z","end":"2026-09-22T02:11:58.519892Z","steps":["trace[2093478612] 'process raft request'  (duration: 109.53966ms)","trace[2093478612] 'compare'  (duration: 14.523838ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:11:58.874068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.916196ms","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-09-22T02:11:58.874161Z","caller":"traceutil/trace.go:171","msg":"trace[1778868902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1223; }","duration":"125.088149ms","start":"2026-09-22T02:11:58.749052Z","end":"2026-09-22T02:11:58.87414Z","steps":["trace[1778868902] 'range keys from in-memory index tree'  (duration: 124.59389ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:12:09.094836Z","caller":"traceutil/trace.go:171","msg":"trace[902529193] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"106.914101ms","start":"2026-09-22T02:12:08.987877Z","end":"2026-09-22T02:12:09.094791Z","steps":["trace[902529193] 'process raft request'  (duration: 106.684497ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-22T02:12:09.328432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.555716ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5675838206421526468 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1264 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-22T02:12:09.328604Z","caller":"traceutil/trace.go:171","msg":"trace[1355166147] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1336; }","duration":"199.439098ms","start":"2026-09-22T02:12:09.129135Z","end":"2026-09-22T02:12:09.328574Z","steps":["trace[1355166147] 'read index received'  (duration: 17.554756ms)","trace[1355166147] 'applied index is now lower than readState.Index'  (duration: 181.858742ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:12:09.328699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.56889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:12:09.328736Z","caller":"traceutil/trace.go:171","msg":"trace[1070045872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1288; }","duration":"199.655361ms","start":"2026-09-22T02:12:09.129067Z","end":"2026-09-22T02:12:09.328722Z","steps":["trace[1070045872] 'agreement among raft nodes before linearized reading'  (duration: 199.57636ms)"],"step_count":1}
{"level":"info","ts":"2026-09-22T02:12:09.328732Z","caller":"traceutil/trace.go:171","msg":"trace[1977853289] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"228.687765ms","start":"2026-09-22T02:12:09.100004Z","end":"2026-09-22T02:12:09.328691Z","steps":["trace[1977853289] 'process raft request'  (duration: 46.751652ms)","trace[1977853289] 'compare'  (duration: 181.26448ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-22T02:12:09.66886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.951273ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-22T02:12:09.669068Z","caller":"traceutil/trace.go:171","msg":"trace[1998040457] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1288; }","duration":"216.198607ms","start":"2026-09-22T02:12:09.452841Z","end":"2026-09-22T02:12:09.669039Z","steps":["trace[1998040457] 'range keys from in-memory index tree'  (duration: 215.920912ms)"],"step_count":1}