{"level":"warn","ts":"2026-04-26T10:01:41.528239Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-26T10:01:41.528342Z","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-04-26T10:01:41.528423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-26T10:01:41.52844Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]}
{"level":"info","ts":"2026-04-26T10:01:41.528472Z","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-04-26T10:01:41.529117Z","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-04-26T10:01:41.529202Z","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-04-26T10:01:41.537447Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.51277ms"}
{"level":"info","ts":"2026-04-26T10:01:41.550302Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"}
{"level":"info","ts":"2026-04-26T10:01:41.550421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-26T10:01:41.550447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"}
{"level":"info","ts":"2026-04-26T10:01:41.550471Z","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-04-26T10:01:41.550484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"}
{"level":"info","ts":"2026-04-26T10:01:41.550526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"warn","ts":"2026-04-26T10:01:41.557906Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-26T10:01:41.559831Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-26T10:01:41.561815Z","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-04-26T10:01:41.564239Z","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-04-26T10:01:41.564472Z","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-04-26T10:01:41.564561Z","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-04-26T10:01:41.564639Z","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-04-26T10:01:41.56465Z","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-04-26T10:01:41.565488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"}
{"level":"info","ts":"2026-04-26T10:01:41.565626Z","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-04-26T10:01:41.567485Z","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-04-26T10:01:41.567578Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-04-26T10:01:41.567603Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"}
{"level":"info","ts":"2026-04-26T10:01:41.567943Z","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-04-26T10:01:41.568053Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-26T10:01:42.25078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-26T10:01:42.250832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-26T10:01:42.25105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"}
{"level":"info","ts":"2026-04-26T10:01:42.251082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"}
{"level":"info","ts":"2026-04-26T10:01:42.251094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-04-26T10:01:42.251114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"}
{"level":"info","ts":"2026-04-26T10:01:42.251164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"}
{"level":"info","ts":"2026-04-26T10:01:42.25211Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-26T10:01:42.253545Z","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-04-26T10:01:42.253637Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-26T10:01:42.253664Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-26T10:01:42.253705Z","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-04-26T10:01:42.254166Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-26T10:01:42.254198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-26T10:01:42.25642Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-26T10:01:42.256473Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-26T10:01:42.257124Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-26T10:01:42.258027Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"}
{"level":"info","ts":"2026-04-26T10:01:43.952306Z","caller":"traceutil/trace.go:171","msg":"trace[1743081570] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"304.714794ms","start":"2026-04-26T10:01:43.647567Z","end":"2026-04-26T10:01:43.952282Z","steps":["trace[1743081570] 'read index received'  (duration: 304.552013ms)","trace[1743081570] 'applied index is now lower than readState.Index'  (duration: 162.171µs)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:01:43.952396Z","caller":"traceutil/trace.go:171","msg":"trace[1949531082] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"305.865713ms","start":"2026-04-26T10:01:43.646493Z","end":"2026-04-26T10:01:43.952359Z","steps":["trace[1949531082] 'process raft request'  (duration: 305.602641ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:43.952482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.896036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:43.952513Z","caller":"traceutil/trace.go:171","msg":"trace[1879680389] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"304.962327ms","start":"2026-04-26T10:01:43.647541Z","end":"2026-04-26T10:01:43.952503Z","steps":["trace[1879680389] 'agreement among raft nodes before linearized reading'  (duration: 304.860086ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:43.952543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.647533Z","time spent":"305.004267ms","remote":"127.0.0.1:58886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":26,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-04-26T10:01:43.95312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.646479Z","time spent":"306.012545ms","remote":"127.0.0.1:58780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-04-26T10:01:44.453272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225759378747009,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-26T10:01:44.622696Z","caller":"traceutil/trace.go:171","msg":"trace[672850626] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"670.302304ms","start":"2026-04-26T10:01:43.952379Z","end":"2026-04-26T10:01:44.622682Z","steps":["trace[672850626] 'read index received'  (duration: 669.984162ms)","trace[672850626] 'applied index is now lower than readState.Index'  (duration: 317.502µs)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:01:44.622712Z","caller":"traceutil/trace.go:171","msg":"trace[2077527365] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"903.807853ms","start":"2026-04-26T10:01:43.718885Z","end":"2026-04-26T10:01:44.622693Z","steps":["trace[2077527365] 'process raft request'  (duration: 903.542121ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:44.622771Z","caller":"traceutil/trace.go:171","msg":"trace[219032979] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"902.699913ms","start":"2026-04-26T10:01:43.720066Z","end":"2026-04-26T10:01:44.622766Z","steps":["trace[219032979] 'process raft request'  (duration: 902.451701ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.622814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720047Z","time spent":"902.739583ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.622821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.71886Z","time spent":"903.896793ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.62289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.239615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.622928Z","caller":"traceutil/trace.go:171","msg":"trace[341576058] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"824.289745ms","start":"2026-04-26T10:01:43.798628Z","end":"2026-04-26T10:01:44.622917Z","steps":["trace[341576058] 'agreement among raft nodes before linearized reading'  (duration: 824.204465ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.622949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.79862Z","time spent":"824.324615ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-04-26T10:01:44.622995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.479116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.623016Z","caller":"traceutil/trace.go:171","msg":"trace[623746661] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"824.541537ms","start":"2026-04-26T10:01:43.798469Z","end":"2026-04-26T10:01:44.62301Z","steps":["trace[623746661] 'agreement among raft nodes before linearized reading'  (duration: 824.470366ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.798449Z","time spent":"824.581477ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-04-26T10:01:44.623048Z","caller":"traceutil/trace.go:171","msg":"trace[1119043524] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"902.831544ms","start":"2026-04-26T10:01:43.72021Z","end":"2026-04-26T10:01:44.623042Z","steps":["trace[1119043524] 'process raft request'  (duration: 902.350251ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720191Z","time spent":"902.877855ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.623116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.708419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.623132Z","caller":"traceutil/trace.go:171","msg":"trace[1336656046] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"824.760009ms","start":"2026-04-26T10:01:43.798367Z","end":"2026-04-26T10:01:44.623127Z","steps":["trace[1336656046] 'agreement among raft nodes before linearized reading'  (duration: 824.736549ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:44.623125Z","caller":"traceutil/trace.go:171","msg":"trace[1249060996] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"902.811245ms","start":"2026-04-26T10:01:43.720302Z","end":"2026-04-26T10:01:44.623113Z","steps":["trace[1249060996] 'process raft request'  (duration: 902.27418ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.798348Z","time spent":"824.796751ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-04-26T10:01:44.623172Z","caller":"traceutil/trace.go:171","msg":"trace[856461875] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"895.302099ms","start":"2026-04-26T10:01:43.727864Z","end":"2026-04-26T10:01:44.623166Z","steps":["trace[856461875] 'process raft request'  (duration: 894.768764ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.727846Z","time spent":"895.33914ms","remote":"127.0.0.1:58936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-jkpt5\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-jkpt5\" value_size:791 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.623196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720292Z","time spent":"902.860395ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.623234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.69914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.62325Z","caller":"traceutil/trace.go:171","msg":"trace[643318743] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"852.737112ms","start":"2026-04-26T10:01:43.770508Z","end":"2026-04-26T10:01:44.623245Z","steps":["trace[643318743] 'agreement among raft nodes before linearized reading'  (duration: 852.712791ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.770499Z","time spent":"852.765372ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-04-26T10:01:44.623258Z","caller":"traceutil/trace.go:171","msg":"trace[464576152] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"902.687833ms","start":"2026-04-26T10:01:43.720538Z","end":"2026-04-26T10:01:44.623226Z","steps":["trace[464576152] 'process raft request'  (duration: 902.055378ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:44.623318Z","caller":"traceutil/trace.go:171","msg":"trace[1237742511] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"889.362538ms","start":"2026-04-26T10:01:43.733949Z","end":"2026-04-26T10:01:44.623312Z","steps":["trace[1237742511] 'process raft request'  (duration: 888.703392ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.136257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-26T10:01:44.623347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.73394Z","time spent":"889.394539ms","remote":"127.0.0.1:58886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"info","ts":"2026-04-26T10:01:44.623359Z","caller":"traceutil/trace.go:171","msg":"trace[1738053537] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"903.197347ms","start":"2026-04-26T10:01:43.720156Z","end":"2026-04-26T10:01:44.623353Z","steps":["trace[1738053537] 'agreement among raft nodes before linearized reading'  (duration: 903.168747ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720126Z","time spent":"903.244917ms","remote":"127.0.0.1:58786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-04-26T10:01:44.623383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720525Z","time spent":"902.804184ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"warn","ts":"2026-04-26T10:01:44.623422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.552408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.623476Z","caller":"traceutil/trace.go:171","msg":"trace[796171877] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"905.634579ms","start":"2026-04-26T10:01:43.717829Z","end":"2026-04-26T10:01:44.623464Z","steps":["trace[796171877] 'agreement among raft nodes before linearized reading'  (duration: 905.566129ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.717815Z","time spent":"905.684179ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-04-26T10:01:44.623599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.908926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-26T10:01:44.623619Z","caller":"traceutil/trace.go:171","msg":"trace[2023288042] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"975.949326ms","start":"2026-04-26T10:01:43.647664Z","end":"2026-04-26T10:01:44.623613Z","steps":["trace[2023288042] 'agreement among raft nodes before linearized reading'  (duration: 975.918416ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.801157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-26T10:01:44.623635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.647647Z","time spent":"975.984236ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-04-26T10:01:44.623639Z","caller":"traceutil/trace.go:171","msg":"trace[860042529] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"656.856267ms","start":"2026-04-26T10:01:43.966778Z","end":"2026-04-26T10:01:44.623634Z","steps":["trace[860042529] 'agreement among raft nodes before linearized reading'  (duration: 656.822207ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.966756Z","time spent":"656.896347ms","remote":"127.0.0.1:59100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-04-26T10:01:44.623218Z","caller":"traceutil/trace.go:171","msg":"trace[601645162] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"902.632263ms","start":"2026-04-26T10:01:43.720526Z","end":"2026-04-26T10:01:44.623158Z","steps":["trace[601645162] 'process raft request'  (duration: 902.084468ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.789818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-26T10:01:44.623756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.720503Z","time spent":"903.187287ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-04-26T10:01:44.623778Z","caller":"traceutil/trace.go:171","msg":"trace[709334728] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:0; response_revision:10; }","duration":"906.88079ms","start":"2026-04-26T10:01:43.71689Z","end":"2026-04-26T10:01:44.623771Z","steps":["trace[709334728] 'agreement among raft nodes before linearized reading'  (duration: 906.809449ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:44.623796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:01:43.71685Z","time spent":"906.94203ms","remote":"127.0.0.1:58752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.223\" "}
{"level":"info","ts":"2026-04-26T10:01:51.677655Z","caller":"traceutil/trace.go:171","msg":"trace[1744702173] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"132.416568ms","start":"2026-04-26T10:01:51.545215Z","end":"2026-04-26T10:01:51.677631Z","steps":["trace[1744702173] 'process raft request'  (duration: 73.332069ms)","trace[1744702173] 'compare'  (duration: 58.583306ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:01:51.677997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.706654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-04-26T10:01:51.678047Z","caller":"traceutil/trace.go:171","msg":"trace[639912013] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:352; }","duration":"113.794014ms","start":"2026-04-26T10:01:51.56424Z","end":"2026-04-26T10:01:51.678034Z","steps":["trace[639912013] 'agreement among raft nodes before linearized reading'  (duration: 113.708554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:51.678379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.226555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:2205"}
{"level":"info","ts":"2026-04-26T10:01:51.678482Z","caller":"traceutil/trace.go:171","msg":"trace[216016808] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:352; }","duration":"133.356206ms","start":"2026-04-26T10:01:51.5451Z","end":"2026-04-26T10:01:51.678456Z","steps":["trace[216016808] 'agreement among raft nodes before linearized reading'  (duration: 133.011124ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:52.015282Z","caller":"traceutil/trace.go:171","msg":"trace[1256797570] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"188.518595ms","start":"2026-04-26T10:01:51.826732Z","end":"2026-04-26T10:01:52.015251Z","steps":["trace[1256797570] 'process raft request'  (duration: 121.759361ms)","trace[1256797570] 'compare'  (duration: 66.44681ms)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:01:52.015425Z","caller":"traceutil/trace.go:171","msg":"trace[1735118233] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:379; }","duration":"164.875108ms","start":"2026-04-26T10:01:51.850517Z","end":"2026-04-26T10:01:52.015392Z","steps":["trace[1735118233] 'read index received'  (duration: 98.053263ms)","trace[1735118233] 'applied index is now lower than readState.Index'  (duration: 66.820465ms)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:01:52.015581Z","caller":"traceutil/trace.go:171","msg":"trace[177128815] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"186.668849ms","start":"2026-04-26T10:01:51.828902Z","end":"2026-04-26T10:01:52.01557Z","steps":["trace[177128815] 'process raft request'  (duration: 186.265105ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:52.015797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.364559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"}
{"level":"info","ts":"2026-04-26T10:01:52.015884Z","caller":"traceutil/trace.go:171","msg":"trace[1061928987] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:372; }","duration":"190.48404ms","start":"2026-04-26T10:01:51.825365Z","end":"2026-04-26T10:01:52.015849Z","steps":["trace[1061928987] 'agreement among raft nodes before linearized reading'  (duration: 190.219978ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:52.023583Z","caller":"traceutil/trace.go:171","msg":"trace[1848190013] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"156.347196ms","start":"2026-04-26T10:01:51.867214Z","end":"2026-04-26T10:01:52.023561Z","steps":["trace[1848190013] 'process raft request'  (duration: 155.932074ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:52.023994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.507208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4017"}
{"level":"info","ts":"2026-04-26T10:01:52.024073Z","caller":"traceutil/trace.go:171","msg":"trace[2026920934] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"156.587309ms","start":"2026-04-26T10:01:51.867463Z","end":"2026-04-26T10:01:52.02405Z","steps":["trace[2026920934] 'agreement among raft nodes before linearized reading'  (duration: 156.498148ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:52.02425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.137941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-04-26T10:01:52.024355Z","caller":"traceutil/trace.go:171","msg":"trace[221922951] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:373; }","duration":"158.282614ms","start":"2026-04-26T10:01:51.866056Z","end":"2026-04-26T10:01:52.024338Z","steps":["trace[221922951] 'agreement among raft nodes before linearized reading'  (duration: 158.157652ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:01:52.284393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.301524ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521225759378747728 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b.18a9dfe734c5784f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b.18a9dfe734c5784f\" value_size:622 lease:2297853722523971556 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-26T10:01:52.284686Z","caller":"traceutil/trace.go:171","msg":"trace[1708222057] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:388; }","duration":"190.480893ms","start":"2026-04-26T10:01:52.094185Z","end":"2026-04-26T10:01:52.284666Z","steps":["trace[1708222057] 'read index received'  (duration: 6.586375ms)","trace[1708222057] 'applied index is now lower than readState.Index'  (duration: 183.890788ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:01:52.284857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.662585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"}
{"level":"info","ts":"2026-04-26T10:01:52.284902Z","caller":"traceutil/trace.go:171","msg":"trace[1952247794] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:383; }","duration":"190.743547ms","start":"2026-04-26T10:01:52.094148Z","end":"2026-04-26T10:01:52.284891Z","steps":["trace[1952247794] 'agreement among raft nodes before linearized reading'  (duration: 190.617056ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:52.284825Z","caller":"traceutil/trace.go:171","msg":"trace[1259449595] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"189.813849ms","start":"2026-04-26T10:01:52.094961Z","end":"2026-04-26T10:01:52.284774Z","steps":["trace[1259449595] 'process raft request'  (duration: 189.573406ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:52.284875Z","caller":"traceutil/trace.go:171","msg":"trace[259149576] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"189.507965ms","start":"2026-04-26T10:01:52.095326Z","end":"2026-04-26T10:01:52.284834Z","steps":["trace[259149576] 'process raft request'  (duration: 189.287643ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:01:52.285333Z","caller":"traceutil/trace.go:171","msg":"trace[39088848] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"190.736455ms","start":"2026-04-26T10:01:52.093942Z","end":"2026-04-26T10:01:52.284678Z","steps":["trace[39088848] 'process raft request'  (duration: 69.865847ms)","trace[39088848] 'compare'  (duration: 120.113552ms)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:02:07.60241Z","caller":"traceutil/trace.go:171","msg":"trace[1111752569] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"220.536234ms","start":"2026-04-26T10:02:07.381814Z","end":"2026-04-26T10:02:07.60235Z","steps":["trace[1111752569] 'process raft request'  (duration: 137.749347ms)","trace[1111752569] 'compare'  (duration: 82.516176ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:02:10.516611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.053021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"}
{"level":"info","ts":"2026-04-26T10:02:10.516713Z","caller":"traceutil/trace.go:171","msg":"trace[1047329002] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:601; }","duration":"439.186347ms","start":"2026-04-26T10:02:10.077501Z","end":"2026-04-26T10:02:10.516688Z","steps":["trace[1047329002] 'range keys from in-memory index tree'  (duration: 438.886583ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:10.516769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:10.077487Z","time spent":"439.267131ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "}
{"level":"info","ts":"2026-04-26T10:02:10.517138Z","caller":"traceutil/trace.go:171","msg":"trace[1531362162] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"156.323656ms","start":"2026-04-26T10:02:10.360794Z","end":"2026-04-26T10:02:10.517118Z","steps":["trace[1531362162] 'process raft request'  (duration: 155.941258ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:02:10.517176Z","caller":"traceutil/trace.go:171","msg":"trace[1771874439] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"363.677397ms","start":"2026-04-26T10:02:10.153473Z","end":"2026-04-26T10:02:10.51715Z","steps":["trace[1771874439] 'read index received'  (duration: 352.208349ms)","trace[1771874439] 'applied index is now lower than readState.Index'  (duration: 11.465697ms)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:02:10.517176Z","caller":"traceutil/trace.go:171","msg":"trace[1801446314] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"438.350209ms","start":"2026-04-26T10:02:10.078799Z","end":"2026-04-26T10:02:10.517149Z","steps":["trace[1801446314] 'process raft request'  (duration: 426.919362ms)","trace[1801446314] 'compare'  (duration: 10.660681ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:02:10.517283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:10.078771Z","time spent":"438.448744ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" mod_revision:596 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" value_size:569989 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-26T10:02:10.517333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.873065ms","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-04-26T10:02:10.517339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.685147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-26T10:02:10.517364Z","caller":"traceutil/trace.go:171","msg":"trace[1664427877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"363.95512ms","start":"2026-04-26T10:02:10.153401Z","end":"2026-04-26T10:02:10.517356Z","steps":["trace[1664427877] 'agreement among raft nodes before linearized reading'  (duration: 363.847395ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:10.517384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:10.153368Z","time spent":"364.010542ms","remote":"127.0.0.1:58946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-26T10:02:10.517394Z","caller":"traceutil/trace.go:171","msg":"trace[1974258853] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:603; }","duration":"358.763801ms","start":"2026-04-26T10:02:10.158612Z","end":"2026-04-26T10:02:10.517376Z","steps":["trace[1974258853] 'agreement among raft nodes before linearized reading'  (duration: 358.657956ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:10.517438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:10.158601Z","time spent":"358.824313ms","remote":"127.0.0.1:58764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "}
{"level":"warn","ts":"2026-04-26T10:02:10.51755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.447041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-spp77\" ","response":"range_response_count:1 size:4888"}
{"level":"info","ts":"2026-04-26T10:02:10.517647Z","caller":"traceutil/trace.go:171","msg":"trace[1865185306] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-spp77; range_end:; response_count:1; response_revision:603; }","duration":"245.571587ms","start":"2026-04-26T10:02:10.272048Z","end":"2026-04-26T10:02:10.51762Z","steps":["trace[1865185306] 'agreement among raft nodes before linearized reading'  (duration: 245.328477ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:11.326238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.380628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-04-26T10:02:11.326298Z","caller":"traceutil/trace.go:171","msg":"trace[448431656] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:617; }","duration":"168.494023ms","start":"2026-04-26T10:02:11.157791Z","end":"2026-04-26T10:02:11.326285Z","steps":["trace[448431656] 'range keys from in-memory index tree'  (duration: 168.252793ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:02:17.465783Z","caller":"traceutil/trace.go:171","msg":"trace[131974734] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"166.426971ms","start":"2026-04-26T10:02:17.299332Z","end":"2026-04-26T10:02:17.465759Z","steps":["trace[131974734] 'process raft request'  (duration: 166.307126ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:18.469639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225759378748270,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-26T10:02:18.521338Z","caller":"traceutil/trace.go:171","msg":"trace[943511409] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"552.177521ms","start":"2026-04-26T10:02:17.969139Z","end":"2026-04-26T10:02:18.521317Z","steps":["trace[943511409] 'read index received'  (duration: 551.997834ms)","trace[943511409] 'applied index is now lower than readState.Index'  (duration: 178.957µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:02:18.521549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.387712ms","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-04-26T10:02:18.521593Z","caller":"traceutil/trace.go:171","msg":"trace[1206826566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"552.464325ms","start":"2026-04-26T10:02:17.969108Z","end":"2026-04-26T10:02:18.521572Z","steps":["trace[1206826566] 'agreement among raft nodes before linearized reading'  (duration: 552.285197ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:18.521626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:17.969092Z","time spent":"552.525486ms","remote":"127.0.0.1:58946","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-04-26T10:02:18.522042Z","caller":"traceutil/trace.go:171","msg":"trace[2020024725] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"603.989166ms","start":"2026-04-26T10:02:17.918036Z","end":"2026-04-26T10:02:18.522025Z","steps":["trace[2020024725] 'process raft request'  (duration: 603.161291ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:18.522219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:17.91801Z","time spent":"604.084611ms","remote":"127.0.0.1:58886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4791,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:649 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4757 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-04-26T10:02:18.684742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.434586ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11521225759378748273 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:660 > 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-04-26T10:02:18.685269Z","caller":"traceutil/trace.go:171","msg":"trace[1492046306] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"156.62571ms","start":"2026-04-26T10:02:18.528624Z","end":"2026-04-26T10:02:18.68525Z","steps":["trace[1492046306] 'process raft request'  (duration: 44.586868ms)","trace[1492046306] 'compare'  (duration: 111.309672ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:02:20.138422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.812598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-26T10:02:20.138537Z","caller":"traceutil/trace.go:171","msg":"trace[1196052068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"709.990595ms","start":"2026-04-26T10:02:19.428526Z","end":"2026-04-26T10:02:20.138516Z","steps":["trace[1196052068] 'range keys from in-memory index tree'  (duration: 709.731304ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:20.138619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:19.428502Z","time spent":"710.071878ms","remote":"127.0.0.1:58712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-26T10:02:20.138793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043894271s","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-04-26T10:02:20.13888Z","caller":"traceutil/trace.go:171","msg":"trace[633676660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"1.044026547s","start":"2026-04-26T10:02:19.094833Z","end":"2026-04-26T10:02:20.138859Z","steps":["trace[633676660] 'range keys from in-memory index tree'  (duration: 1.043666192s)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:20.13892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:19.094811Z","time spent":"1.04409978s","remote":"127.0.0.1:58946","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-04-26T10:02:20.139259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.450459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-26T10:02:20.139354Z","caller":"traceutil/trace.go:171","msg":"trace[2143681075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"543.598485ms","start":"2026-04-26T10:02:19.595733Z","end":"2026-04-26T10:02:20.139332Z","steps":["trace[2143681075] 'range keys from in-memory index tree'  (duration: 543.287843ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:20.139358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.952085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-04-26T10:02:20.139404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:19.59571Z","time spent":"543.683529ms","remote":"127.0.0.1:58728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-26T10:02:20.139447Z","caller":"traceutil/trace.go:171","msg":"trace[1145698790] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:680; }","duration":"626.099522ms","start":"2026-04-26T10:02:19.513321Z","end":"2026-04-26T10:02:20.13942Z","steps":["trace[1145698790] 'range keys from in-memory index tree'  (duration: 625.279998ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:02:20.139513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:02:19.513301Z","time spent":"626.199346ms","remote":"127.0.0.1:58946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-26T10:02:24.712184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.245819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-26T10:02:24.712285Z","caller":"traceutil/trace.go:171","msg":"trace[2070712289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:712; }","duration":"117.402634ms","start":"2026-04-26T10:02:24.594862Z","end":"2026-04-26T10:02:24.712265Z","steps":["trace[2070712289] 'range keys from in-memory index tree'  (duration: 117.181197ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:02:26.395146Z","caller":"traceutil/trace.go:171","msg":"trace[1676059155] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"131.335058ms","start":"2026-04-26T10:02:26.263795Z","end":"2026-04-26T10:02:26.39513Z","steps":["trace[1676059155] 'process raft request'  (duration: 130.396042ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:02:26.401684Z","caller":"traceutil/trace.go:171","msg":"trace[957124474] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"134.982157ms","start":"2026-04-26T10:02:26.266691Z","end":"2026-04-26T10:02:26.401673Z","steps":["trace[957124474] 'process raft request'  (duration: 134.710427ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:02:36.340718Z","caller":"traceutil/trace.go:171","msg":"trace[255034350] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"290.484386ms","start":"2026-04-26T10:02:36.050208Z","end":"2026-04-26T10:02:36.340693Z","steps":["trace[255034350] 'process raft request'  (duration: 290.219767ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:03:18.813885Z","caller":"traceutil/trace.go:171","msg":"trace[1798820537] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1132; }","duration":"179.355019ms","start":"2026-04-26T10:03:18.634506Z","end":"2026-04-26T10:03:18.813861Z","steps":["trace[1798820537] 'read index received'  (duration: 179.198584ms)","trace[1798820537] 'applied index is now lower than readState.Index'  (duration: 155.345µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-26T10:03:18.814105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.590865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-26T10:03:18.814175Z","caller":"traceutil/trace.go:171","msg":"trace[1648147366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1096; }","duration":"179.725037ms","start":"2026-04-26T10:03:18.634439Z","end":"2026-04-26T10:03:18.814164Z","steps":["trace[1648147366] 'agreement among raft nodes before linearized reading'  (duration: 179.521633ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:03:18.814194Z","caller":"traceutil/trace.go:171","msg":"trace[741187547] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"190.171221ms","start":"2026-04-26T10:03:18.624004Z","end":"2026-04-26T10:03:18.814175Z","steps":["trace[741187547] 'process raft request'  (duration: 189.705179ms)"],"step_count":1}
{"level":"info","ts":"2026-04-26T10:03:43.405312Z","caller":"traceutil/trace.go:171","msg":"trace[464848167] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"104.028344ms","start":"2026-04-26T10:03:43.301262Z","end":"2026-04-26T10:03:43.40529Z","steps":["trace[464848167] 'read index received'  (duration: 103.85609ms)","trace[464848167] 'applied index is now lower than readState.Index'  (duration: 170.534µs)"],"step_count":2}
{"level":"info","ts":"2026-04-26T10:03:43.405382Z","caller":"traceutil/trace.go:171","msg":"trace[411042036] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"111.865586ms","start":"2026-04-26T10:03:43.293484Z","end":"2026-04-26T10:03:43.40535Z","steps":["trace[411042036] 'process raft request'  (duration: 111.657601ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-26T10:03:43.405505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.219127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" ","response":"range_response_count:1 size:715"}
{"level":"info","ts":"2026-04-26T10:03:43.405571Z","caller":"traceutil/trace.go:171","msg":"trace[426415169] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1188; }","duration":"104.318679ms","start":"2026-04-26T10:03:43.301237Z","end":"2026-04-26T10:03:43.405556Z","steps":["trace[426415169] 'agreement among raft nodes before linearized reading'  (duration: 104.144646ms)"],"step_count":1}