{"level":"warn","ts":"2026-05-05T12:46:47.285423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T12:46:47.285592Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.57: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.19.213.57:2380","--initial-cluster=instance=https://199.19.213.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.57: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-05-05T12:46:47.286147Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T12:46:47.286187Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.57:2380"]}
{"level":"info","ts":"2026-05-05T12:46:47.287814Z","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-05-05T12:46:47.289369Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"]}
{"level":"info","ts":"2026-05-05T12:46:47.28976Z","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.19.213.57:2380"],"listen-peer-urls":["https://199.19.213.57:2380"],"advertise-client-urls":["https://199.19.213.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.57: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-05-05T12:46:47.297042Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.031709ms"}
{"level":"info","ts":"2026-05-05T12:46:47.306074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ef5ef2a9544a39ef","cluster-id":"58d35553a3d286c0"}
{"level":"info","ts":"2026-05-05T12:46:47.306232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T12:46:47.306273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became follower at term 0"}
{"level":"info","ts":"2026-05-05T12:46:47.306295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ef5ef2a9544a39ef [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T12:46:47.306318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became follower at term 1"}
{"level":"info","ts":"2026-05-05T12:46:47.306394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=(17248490431953123823)"}
{"level":"warn","ts":"2026-05-05T12:46:47.313833Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T12:46:47.315887Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T12:46:47.317042Z","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-05-05T12:46:47.321627Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ef5ef2a9544a39ef","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T12:46:47.321926Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ef5ef2a9544a39ef","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T12:46:47.322549Z","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-05-05T12:46:47.322638Z","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-05-05T12:46:47.322669Z","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-05-05T12:46:47.323183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef switched to configuration voters=(17248490431953123823)"}
{"level":"info","ts":"2026-05-05T12:46:47.323358Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"58d35553a3d286c0","local-member-id":"ef5ef2a9544a39ef","added-peer-id":"ef5ef2a9544a39ef","added-peer-peer-urls":["https://199.19.213.57:2380"]}
{"level":"info","ts":"2026-05-05T12:46:47.330904Z","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-05-05T12:46:47.331036Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.57:2380"}
{"level":"info","ts":"2026-05-05T12:46:47.331075Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.57:2380"}
{"level":"info","ts":"2026-05-05T12:46:47.33202Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ef5ef2a9544a39ef","initial-advertise-peer-urls":["https://199.19.213.57:2380"],"listen-peer-urls":["https://199.19.213.57:2380"],"advertise-client-urls":["https://199.19.213.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T12:46:47.332053Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T12:46:47.806841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T12:46:47.806916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T12:46:47.806945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef received MsgPreVoteResp from ef5ef2a9544a39ef at term 1"}
{"level":"info","ts":"2026-05-05T12:46:47.806961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became candidate at term 2"}
{"level":"info","ts":"2026-05-05T12:46:47.806968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef received MsgVoteResp from ef5ef2a9544a39ef at term 2"}
{"level":"info","ts":"2026-05-05T12:46:47.806978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ef5ef2a9544a39ef became leader at term 2"}
{"level":"info","ts":"2026-05-05T12:46:47.806987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ef5ef2a9544a39ef elected leader ef5ef2a9544a39ef at term 2"}
{"level":"info","ts":"2026-05-05T12:46:47.807909Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T12:46:47.807981Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T12:46:47.808083Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ef5ef2a9544a39ef","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.57:2379]}","request-path":"/0/members/ef5ef2a9544a39ef/attributes","cluster-id":"58d35553a3d286c0","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T12:46:47.807924Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T12:46:47.80852Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T12:46:47.808639Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T12:46:47.808745Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"58d35553a3d286c0","local-member-id":"ef5ef2a9544a39ef","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T12:46:47.808852Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T12:46:47.808889Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T12:46:47.812947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.57:2379"}
{"level":"info","ts":"2026-05-05T12:46:47.813979Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T12:46:49.350356Z","caller":"traceutil/trace.go:171","msg":"trace[1982891788] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"228.008436ms","start":"2026-05-05T12:46:49.122323Z","end":"2026-05-05T12:46:49.350331Z","steps":["trace[1982891788] 'read index received'  (duration: 227.865616ms)","trace[1982891788] 'applied index is now lower than readState.Index'  (duration: 141.55µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:46:49.350439Z","caller":"traceutil/trace.go:171","msg":"trace[1779770694] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"230.484367ms","start":"2026-05-05T12:46:49.119873Z","end":"2026-05-05T12:46:49.350357Z","steps":["trace[1779770694] 'process raft request'  (duration: 230.248728ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.350575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.217605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.350687Z","caller":"traceutil/trace.go:171","msg":"trace[1416390429] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"228.381424ms","start":"2026-05-05T12:46:49.122282Z","end":"2026-05-05T12:46:49.350664Z","steps":["trace[1416390429] 'agreement among raft nodes before linearized reading'  (duration: 228.151605ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.564505Z","caller":"traceutil/trace.go:171","msg":"trace[101394560] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"365.554993ms","start":"2026-05-05T12:46:49.198896Z","end":"2026-05-05T12:46:49.564451Z","steps":["trace[101394560] 'process raft request'  (duration: 365.281063ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.564567Z","caller":"traceutil/trace.go:171","msg":"trace[419597158] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"214.105708ms","start":"2026-05-05T12:46:49.350429Z","end":"2026-05-05T12:46:49.564535Z","steps":["trace[419597158] 'read index received'  (duration: 213.748738ms)","trace[419597158] 'applied index is now lower than readState.Index'  (duration: 356.1µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T12:46:49.56475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.01197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.56479Z","caller":"traceutil/trace.go:171","msg":"trace[1222003196] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"432.1036ms","start":"2026-05-05T12:46:49.132676Z","end":"2026-05-05T12:46:49.56478Z","steps":["trace[1222003196] 'agreement among raft nodes before linearized reading'  (duration: 431.97504ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.565153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.198866Z","time spent":"365.734732ms","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-05-05T12:46:49.565251Z","caller":"traceutil/trace.go:171","msg":"trace[359246249] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"360.708631ms","start":"2026-05-05T12:46:49.204517Z","end":"2026-05-05T12:46:49.565225Z","steps":["trace[359246249] 'process raft request'  (duration: 359.931444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.565105Z","caller":"traceutil/trace.go:171","msg":"trace[1121813940] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"361.706997ms","start":"2026-05-05T12:46:49.203313Z","end":"2026-05-05T12:46:49.565019Z","steps":["trace[1121813940] 'process raft request'  (duration: 361.094519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.565263Z","caller":"traceutil/trace.go:171","msg":"trace[1425093672] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"361.962415ms","start":"2026-05-05T12:46:49.203191Z","end":"2026-05-05T12:46:49.565154Z","steps":["trace[1425093672] 'process raft request'  (duration: 361.238088ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.56539Z","caller":"traceutil/trace.go:171","msg":"trace[830847906] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"362.291264ms","start":"2026-05-05T12:46:49.203091Z","end":"2026-05-05T12:46:49.565382Z","steps":["trace[830847906] 'process raft request'  (duration: 361.296138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.565422Z","caller":"traceutil/trace.go:171","msg":"trace[1038755525] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"355.829548ms","start":"2026-05-05T12:46:49.209581Z","end":"2026-05-05T12:46:49.565411Z","steps":["trace[1038755525] 'process raft request'  (duration: 354.888242ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.565459Z","caller":"traceutil/trace.go:171","msg":"trace[1487043857] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"362.673764ms","start":"2026-05-05T12:46:49.202779Z","end":"2026-05-05T12:46:49.565453Z","steps":["trace[1487043857] 'process raft request'  (duration: 361.572398ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.565475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.209563Z","time spent":"355.889128ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3124 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T12:46:49.565497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.202755Z","time spent":"362.727213ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"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-05-05T12:46:49.565364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.203297Z","time spent":"362.016335ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"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-05-05T12:46:49.565432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.203078Z","time spent":"362.338304ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"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":"info","ts":"2026-05-05T12:46:49.565663Z","caller":"traceutil/trace.go:171","msg":"trace[135349247] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"355.597319ms","start":"2026-05-05T12:46:49.210045Z","end":"2026-05-05T12:46:49.565642Z","steps":["trace[135349247] 'process raft request'  (duration: 354.458004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.565637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.203183Z","time spent":"362.370724ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"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":"warn","ts":"2026-05-05T12:46:49.565776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.749099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.565804Z","caller":"traceutil/trace.go:171","msg":"trace[338497745] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"292.80967ms","start":"2026-05-05T12:46:49.272986Z","end":"2026-05-05T12:46:49.565796Z","steps":["trace[338497745] 'agreement among raft nodes before linearized reading'  (duration: 292.77645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.565589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.232548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.565845Z","caller":"traceutil/trace.go:171","msg":"trace[1445134134] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"315.512136ms","start":"2026-05-05T12:46:49.250323Z","end":"2026-05-05T12:46:49.565836Z","steps":["trace[1445134134] 'agreement among raft nodes before linearized reading'  (duration: 315.178568ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.56588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.2503Z","time spent":"315.572426ms","remote":"127.0.0.1:36250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-05T12:46:49.565357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.204488Z","time spent":"360.80608ms","remote":"127.0.0.1:36646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"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-05-05T12:46:49.565953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.413957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.565981Z","caller":"traceutil/trace.go:171","msg":"trace[466521752] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"293.441957ms","start":"2026-05-05T12:46:49.272532Z","end":"2026-05-05T12:46:49.565974Z","steps":["trace[466521752] 'agreement among raft nodes before linearized reading'  (duration: 293.405797ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.565744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.210032Z","time spent":"355.662599ms","remote":"127.0.0.1:36404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-q4wvm\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-q4wvm\" value_size:795 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T12:46:49.56631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.621371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.566337Z","caller":"traceutil/trace.go:171","msg":"trace[1348294853] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"368.64751ms","start":"2026-05-05T12:46:49.197683Z","end":"2026-05-05T12:46:49.56633Z","steps":["trace[1348294853] 'agreement among raft nodes before linearized reading'  (duration: 368.607351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.566355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.197652Z","time spent":"368.69826ms","remote":"127.0.0.1:36250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-05T12:46:49.566399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.635457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-05T12:46:49.566448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.468492ms","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":"info","ts":"2026-05-05T12:46:49.566473Z","caller":"traceutil/trace.go:171","msg":"trace[15000998] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"365.525512ms","start":"2026-05-05T12:46:49.200939Z","end":"2026-05-05T12:46:49.566464Z","steps":["trace[15000998] 'agreement among raft nodes before linearized reading'  (duration: 365.489412ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.566429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.951636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.57\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-05T12:46:49.566489Z","caller":"traceutil/trace.go:171","msg":"trace[2126727657] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"391.785177ms","start":"2026-05-05T12:46:49.174683Z","end":"2026-05-05T12:46:49.566468Z","steps":["trace[2126727657] 'agreement among raft nodes before linearized reading'  (duration: 391.620408ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:46:49.56655Z","caller":"traceutil/trace.go:171","msg":"trace[1676941911] range","detail":"{range_begin:/registry/masterleases/199.19.213.57; range_end:; response_count:0; response_revision:10; }","duration":"370.095016ms","start":"2026-05-05T12:46:49.196423Z","end":"2026-05-05T12:46:49.566518Z","steps":["trace[1676941911] 'agreement among raft nodes before linearized reading'  (duration: 369.873497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:46:49.566632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.196358Z","time spent":"370.261615ms","remote":"127.0.0.1:36164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.57\" "}
{"level":"warn","ts":"2026-05-05T12:46:49.566559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.17464Z","time spent":"391.903597ms","remote":"127.0.0.1:36250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-05T12:46:49.5665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.200914Z","time spent":"365.578342ms","remote":"127.0.0.1:36226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-05-05T12:46:49.564824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:46:49.132656Z","time spent":"432.162459ms","remote":"127.0.0.1:36536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-05-05T12:46:49.568721Z","caller":"traceutil/trace.go:171","msg":"trace[1530293249] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"216.934076ms","start":"2026-05-05T12:46:49.351765Z","end":"2026-05-05T12:46:49.568699Z","steps":["trace[1530293249] 'process raft request'  (duration: 214.888843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:47:19.342587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.092042ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4174729068832099991 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3013 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T12:47:19.34281Z","caller":"traceutil/trace.go:171","msg":"trace[265449321] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"118.009315ms","start":"2026-05-05T12:47:19.224787Z","end":"2026-05-05T12:47:19.342797Z","steps":["trace[265449321] 'process raft request'  (duration: 117.90557ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:47:19.342958Z","caller":"traceutil/trace.go:171","msg":"trace[1022907042] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"128.521669ms","start":"2026-05-05T12:47:19.214426Z","end":"2026-05-05T12:47:19.342948Z","steps":["trace[1022907042] 'process raft request'  (duration: 13.873433ms)","trace[1022907042] 'compare'  (duration: 113.858662ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:47:23.264588Z","caller":"traceutil/trace.go:171","msg":"trace[728336015] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"135.96868ms","start":"2026-05-05T12:47:23.12859Z","end":"2026-05-05T12:47:23.264559Z","steps":["trace[728336015] 'process raft request'  (duration: 135.267963ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:47:25.565825Z","caller":"traceutil/trace.go:171","msg":"trace[1931819516] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"142.8523ms","start":"2026-05-05T12:47:25.422944Z","end":"2026-05-05T12:47:25.565796Z","steps":["trace[1931819516] 'process raft request'  (duration: 142.728595ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:47:25.684658Z","caller":"traceutil/trace.go:171","msg":"trace[1501038628] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"261.445362ms","start":"2026-05-05T12:47:25.423176Z","end":"2026-05-05T12:47:25.684621Z","steps":["trace[1501038628] 'process raft request'  (duration: 257.990551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:47:25.684928Z","caller":"traceutil/trace.go:171","msg":"trace[596666352] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"261.478843ms","start":"2026-05-05T12:47:25.423422Z","end":"2026-05-05T12:47:25.6849Z","steps":["trace[596666352] 'process raft request'  (duration: 261.12335ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:47:25.68512Z","caller":"traceutil/trace.go:171","msg":"trace[1511260060] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"260.495227ms","start":"2026-05-05T12:47:25.424601Z","end":"2026-05-05T12:47:25.685096Z","steps":["trace[1511260060] 'process raft request'  (duration: 260.183035ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:01.118426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.751262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.57\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-05T12:49:01.118564Z","caller":"traceutil/trace.go:171","msg":"trace[304230999] range","detail":"{range_begin:/registry/masterleases/199.19.213.57; range_end:; response_count:1; response_revision:1862; }","duration":"126.969184ms","start":"2026-05-05T12:49:00.99157Z","end":"2026-05-05T12:49:01.118539Z","steps":["trace[304230999] 'range keys from in-memory index tree'  (duration: 126.435869ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:01.340352Z","caller":"traceutil/trace.go:171","msg":"trace[673884149] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1927; }","duration":"127.371187ms","start":"2026-05-05T12:49:01.212962Z","end":"2026-05-05T12:49:01.340333Z","steps":["trace[673884149] 'read index received'  (duration: 127.253206ms)","trace[673884149] 'applied index is now lower than readState.Index'  (duration: 117.221µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T12:49:01.340502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.531048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4d5cb343-e5d4-4b3b-aadd-4cc17511691c\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-05T12:49:01.340526Z","caller":"traceutil/trace.go:171","msg":"trace[1701127825] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4d5cb343-e5d4-4b3b-aadd-4cc17511691c; range_end:; response_count:1; response_revision:1862; }","duration":"127.59898ms","start":"2026-05-05T12:49:01.21292Z","end":"2026-05-05T12:49:01.340519Z","steps":["trace[1701127825] 'agreement among raft nodes before linearized reading'  (duration: 127.482688ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:01.736446Z","caller":"traceutil/trace.go:171","msg":"trace[1964075531] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"270.450632ms","start":"2026-05-05T12:49:01.46597Z","end":"2026-05-05T12:49:01.73642Z","steps":["trace[1964075531] 'read index received'  (duration: 270.31635ms)","trace[1964075531] 'applied index is now lower than readState.Index'  (duration: 133.211µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:49:01.7366Z","caller":"traceutil/trace.go:171","msg":"trace[1776180632] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"272.255757ms","start":"2026-05-05T12:49:01.464307Z","end":"2026-05-05T12:49:01.736562Z","steps":["trace[1776180632] 'process raft request'  (duration: 271.906184ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:01.736919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.027826ms","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-05-05T12:49:01.736884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.463329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T12:49:01.736977Z","caller":"traceutil/trace.go:171","msg":"trace[1591942028] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1866; }","duration":"255.153437ms","start":"2026-05-05T12:49:01.481811Z","end":"2026-05-05T12:49:01.736965Z","steps":["trace[1591942028] 'agreement among raft nodes before linearized reading'  (duration: 254.833114ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:01.737057Z","caller":"traceutil/trace.go:171","msg":"trace[1207571183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1866; }","duration":"118.6938ms","start":"2026-05-05T12:49:01.61829Z","end":"2026-05-05T12:49:01.736984Z","steps":["trace[1207571183] 'agreement among raft nodes before linearized reading'  (duration: 118.436378ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:01.736952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.887325ms","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-05-05T12:49:01.737634Z","caller":"traceutil/trace.go:171","msg":"trace[1428977637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1866; }","duration":"271.537221ms","start":"2026-05-05T12:49:01.465937Z","end":"2026-05-05T12:49:01.737474Z","steps":["trace[1428977637] 'agreement among raft nodes before linearized reading'  (duration: 270.695014ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:18.512832Z","caller":"traceutil/trace.go:171","msg":"trace[1700550835] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"142.331452ms","start":"2026-05-05T12:49:18.370414Z","end":"2026-05-05T12:49:18.512746Z","steps":["trace[1700550835] 'process raft request'  (duration: 142.185077ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:41.717614Z","caller":"traceutil/trace.go:171","msg":"trace[846238017] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"155.895642ms","start":"2026-05-05T12:49:41.561697Z","end":"2026-05-05T12:49:41.717593Z","steps":["trace[846238017] 'process raft request'  (duration: 155.760668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:42.024516Z","caller":"traceutil/trace.go:171","msg":"trace[327506975] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"151.888625ms","start":"2026-05-05T12:49:41.872607Z","end":"2026-05-05T12:49:42.024496Z","steps":["trace[327506975] 'process raft request'  (duration: 151.506414ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:42.096981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.342349ms","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-05-05T12:49:42.097046Z","caller":"traceutil/trace.go:171","msg":"trace[1981979613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"143.546055ms","start":"2026-05-05T12:49:41.953486Z","end":"2026-05-05T12:49:42.097032Z","steps":["trace[1981979613] 'agreement among raft nodes before linearized reading'  (duration: 142.858205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:42.561488Z","caller":"traceutil/trace.go:171","msg":"trace[1700803407] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"146.811096ms","start":"2026-05-05T12:49:42.414654Z","end":"2026-05-05T12:49:42.561465Z","steps":["trace[1700803407] 'read index received'  (duration: 146.577619ms)","trace[1700803407] 'applied index is now lower than readState.Index'  (duration: 232.427µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:49:42.561615Z","caller":"traceutil/trace.go:171","msg":"trace[368598912] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"230.074961ms","start":"2026-05-05T12:49:42.331513Z","end":"2026-05-05T12:49:42.561588Z","steps":["trace[368598912] 'process raft request'  (duration: 229.768792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:42.561744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.069023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-05T12:49:42.561799Z","caller":"traceutil/trace.go:171","msg":"trace[881950514] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"147.166956ms","start":"2026-05-05T12:49:42.414612Z","end":"2026-05-05T12:49:42.561779Z","steps":["trace[881950514] 'agreement among raft nodes before linearized reading'  (duration: 146.941519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:49:42.991997Z","caller":"traceutil/trace.go:171","msg":"trace[1565887833] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2213; }","duration":"232.584305ms","start":"2026-05-05T12:49:42.759387Z","end":"2026-05-05T12:49:42.991971Z","steps":["trace[1565887833] 'read index received'  (duration: 232.377439ms)","trace[1565887833] 'applied index is now lower than readState.Index'  (duration: 205.316µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:49:42.992169Z","caller":"traceutil/trace.go:171","msg":"trace[254478453] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"375.947579ms","start":"2026-05-05T12:49:42.616149Z","end":"2026-05-05T12:49:42.992097Z","steps":["trace[254478453] 'process raft request'  (duration: 375.65199ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:42.992299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.893244ms","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-05-05T12:49:42.992354Z","caller":"traceutil/trace.go:171","msg":"trace[1458590028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2140; }","duration":"232.995317ms","start":"2026-05-05T12:49:42.759344Z","end":"2026-05-05T12:49:42.992339Z","steps":["trace[1458590028] 'agreement among raft nodes before linearized reading'  (duration: 232.77182ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:42.992374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.693412ms","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-05-05T12:49:42.992433Z","caller":"traceutil/trace.go:171","msg":"trace[1118528626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2140; }","duration":"196.803406ms","start":"2026-05-05T12:49:42.79561Z","end":"2026-05-05T12:49:42.992413Z","steps":["trace[1118528626] 'agreement among raft nodes before linearized reading'  (duration: 196.617231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:49:42.992468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T12:49:42.616132Z","time spent":"376.117634ms","remote":"127.0.0.1:36418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2130 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-05T12:49:42.992505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.571626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T12:49:42.992701Z","caller":"traceutil/trace.go:171","msg":"trace[1873319003] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:2140; }","duration":"101.67568ms","start":"2026-05-05T12:49:42.890872Z","end":"2026-05-05T12:49:42.992548Z","steps":["trace[1873319003] 'agreement among raft nodes before linearized reading'  (duration: 101.578477ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:51:03.970118Z","caller":"traceutil/trace.go:171","msg":"trace[390637992] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"158.49984ms","start":"2026-05-05T12:51:03.811601Z","end":"2026-05-05T12:51:03.9701Z","steps":["trace[390637992] 'process raft request'  (duration: 158.365698ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:54:07.471151Z","caller":"traceutil/trace.go:171","msg":"trace[1451663917] transaction","detail":"{read_only:false; response_revision:3797; number_of_response:1; }","duration":"119.754136ms","start":"2026-05-05T12:54:07.351358Z","end":"2026-05-05T12:54:07.471112Z","steps":["trace[1451663917] 'process raft request'  (duration: 50.923077ms)","trace[1451663917] 'compare'  (duration: 68.364983ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:54:59.047728Z","caller":"traceutil/trace.go:171","msg":"trace[1044095618] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"130.790953ms","start":"2026-05-05T12:54:58.91692Z","end":"2026-05-05T12:54:59.047711Z","steps":["trace[1044095618] 'process raft request'  (duration: 130.68797ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:54:59.056635Z","caller":"traceutil/trace.go:171","msg":"trace[1413215947] transaction","detail":"{read_only:false; response_revision:4565; number_of_response:1; }","duration":"139.45344ms","start":"2026-05-05T12:54:58.917159Z","end":"2026-05-05T12:54:59.056613Z","steps":["trace[1413215947] 'process raft request'  (duration: 138.879765ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:55:01.173882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.69229ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4174729068832109216 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:39ef9df82d3c329f>","response":"size:40"}
{"level":"info","ts":"2026-05-05T12:55:01.174038Z","caller":"traceutil/trace.go:171","msg":"trace[1729955277] linearizableReadLoop","detail":"{readStateIndex:4778; appliedIndex:4777; }","duration":"160.076906ms","start":"2026-05-05T12:55:01.013869Z","end":"2026-05-05T12:55:01.173946Z","steps":["trace[1729955277] 'read index received'  (duration: 57.51921ms)","trace[1729955277] 'applied index is now lower than readState.Index'  (duration: 102.556766ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T12:55:01.174162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.285062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-05-05T12:55:01.174177Z","caller":"traceutil/trace.go:171","msg":"trace[234266677] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4610; }","duration":"160.335853ms","start":"2026-05-05T12:55:01.013836Z","end":"2026-05-05T12:55:01.174172Z","steps":["trace[234266677] 'agreement among raft nodes before linearized reading'  (duration: 160.22001ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:01.188684Z","caller":"traceutil/trace.go:171","msg":"trace[1820509572] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"127.589769ms","start":"2026-05-05T12:55:01.061076Z","end":"2026-05-05T12:55:01.188666Z","steps":["trace[1820509572] 'process raft request'  (duration: 127.550778ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:01.189085Z","caller":"traceutil/trace.go:171","msg":"trace[724451618] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"165.175923ms","start":"2026-05-05T12:55:01.0239Z","end":"2026-05-05T12:55:01.189076Z","steps":["trace[724451618] 'process raft request'  (duration: 164.589838ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:07.473851Z","caller":"traceutil/trace.go:171","msg":"trace[363505369] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"103.066958ms","start":"2026-05-05T12:55:07.370755Z","end":"2026-05-05T12:55:07.473822Z","steps":["trace[363505369] 'process raft request'  (duration: 102.831082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:55:08.248813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.431181ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4174729068832109576 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-q7wlm\" mod_revision:4179 > success:<request_put:<key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-q7wlm\" value_size:1785 >> failure:<request_range:<key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-q7wlm\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T12:55:08.248915Z","caller":"traceutil/trace.go:171","msg":"trace[1394354177] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4928; }","duration":"160.73812ms","start":"2026-05-05T12:55:08.088161Z","end":"2026-05-05T12:55:08.248899Z","steps":["trace[1394354177] 'read index received'  (duration: 46.307869ms)","trace[1394354177] 'applied index is now lower than readState.Index'  (duration: 114.429071ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:55:08.248953Z","caller":"traceutil/trace.go:171","msg":"trace[1279837133] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"161.117781ms","start":"2026-05-05T12:55:08.087795Z","end":"2026-05-05T12:55:08.248913Z","steps":["trace[1279837133] 'process raft request'  (duration: 46.505785ms)","trace[1279837133] 'compare'  (duration: 114.219815ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T12:55:08.249084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.922046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16231"}
{"level":"info","ts":"2026-05-05T12:55:08.249123Z","caller":"traceutil/trace.go:171","msg":"trace[1885843792] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4759; }","duration":"160.998938ms","start":"2026-05-05T12:55:08.088114Z","end":"2026-05-05T12:55:08.249113Z","steps":["trace[1885843792] 'agreement among raft nodes before linearized reading'  (duration: 160.849394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:08.250263Z","caller":"traceutil/trace.go:171","msg":"trace[264511873] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"158.280716ms","start":"2026-05-05T12:55:08.091964Z","end":"2026-05-05T12:55:08.250244Z","steps":["trace[264511873] 'process raft request'  (duration: 158.120052ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:08.250306Z","caller":"traceutil/trace.go:171","msg":"trace[1264098572] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"151.99308ms","start":"2026-05-05T12:55:08.098298Z","end":"2026-05-05T12:55:08.250291Z","steps":["trace[1264098572] 'process raft request'  (duration: 151.874176ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:08.250556Z","caller":"traceutil/trace.go:171","msg":"trace[1368955002] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"150.904649ms","start":"2026-05-05T12:55:08.099641Z","end":"2026-05-05T12:55:08.250545Z","steps":["trace[1368955002] 'process raft request'  (duration: 150.577321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:55:08.250586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.211305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-05T12:55:08.250672Z","caller":"traceutil/trace.go:171","msg":"trace[1337472030] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4762; }","duration":"152.348109ms","start":"2026-05-05T12:55:08.0983Z","end":"2026-05-05T12:55:08.250648Z","steps":["trace[1337472030] 'agreement among raft nodes before linearized reading'  (duration: 152.115313ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:22.064453Z","caller":"traceutil/trace.go:171","msg":"trace[1443818913] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5120; }","duration":"155.550743ms","start":"2026-05-05T12:55:21.908875Z","end":"2026-05-05T12:55:22.064426Z","steps":["trace[1443818913] 'read index received'  (duration: 155.321948ms)","trace[1443818913] 'applied index is now lower than readState.Index'  (duration: 227.815µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:55:22.064584Z","caller":"traceutil/trace.go:171","msg":"trace[596731436] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"227.798846ms","start":"2026-05-05T12:55:21.836774Z","end":"2026-05-05T12:55:22.064573Z","steps":["trace[596731436] 'process raft request'  (duration: 227.488118ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:55:22.064818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.928303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-05T12:55:22.064861Z","caller":"traceutil/trace.go:171","msg":"trace[57760489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4945; }","duration":"156.026165ms","start":"2026-05-05T12:55:21.908824Z","end":"2026-05-05T12:55:22.06485Z","steps":["trace[57760489] 'agreement among raft nodes before linearized reading'  (duration: 155.881651ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T12:55:22.064994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.501938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T12:55:22.065104Z","caller":"traceutil/trace.go:171","msg":"trace[1325802681] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4945; }","duration":"141.673492ms","start":"2026-05-05T12:55:21.923407Z","end":"2026-05-05T12:55:22.065081Z","steps":["trace[1325802681] 'agreement among raft nodes before linearized reading'  (duration: 141.481387ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:53.863306Z","caller":"traceutil/trace.go:171","msg":"trace[1921188972] linearizableReadLoop","detail":"{readStateIndex:5423; appliedIndex:5422; }","duration":"100.113094ms","start":"2026-05-05T12:55:53.763161Z","end":"2026-05-05T12:55:53.863274Z","steps":["trace[1921188972] 'read index received'  (duration: 34.916661ms)","trace[1921188972] 'applied index is now lower than readState.Index'  (duration: 65.194983ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T12:55:53.863491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.310339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T12:55:53.863528Z","caller":"traceutil/trace.go:171","msg":"trace[1290646664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5239; }","duration":"100.395591ms","start":"2026-05-05T12:55:53.763123Z","end":"2026-05-05T12:55:53.863519Z","steps":["trace[1290646664] 'agreement among raft nodes before linearized reading'  (duration: 100.276488ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T12:55:53.863543Z","caller":"traceutil/trace.go:171","msg":"trace[1546870989] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"198.396346ms","start":"2026-05-05T12:55:53.665114Z","end":"2026-05-05T12:55:53.86351Z","steps":["trace[1546870989] 'process raft request'  (duration: 133.041838ms)","trace[1546870989] 'compare'  (duration: 64.847556ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:56:29.413558Z","caller":"traceutil/trace.go:171","msg":"trace[139009455] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"261.433244ms","start":"2026-05-05T12:56:29.152095Z","end":"2026-05-05T12:56:29.413528Z","steps":["trace[139009455] 'process raft request'  (duration: 197.72777ms)","trace[139009455] 'compare'  (duration: 63.429408ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T12:56:47.838622Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2921}
{"level":"info","ts":"2026-05-05T12:56:47.924933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2921,"took":"84.82131ms","hash":2976710231,"current-db-size-bytes":53571584,"current-db-size":"54 MB","current-db-size-in-use-bytes":29646848,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-05T12:56:47.925Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2976710231,"revision":2921,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T13:01:47.844908Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5652}
{"level":"info","ts":"2026-05-05T13:01:47.931062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5652,"took":"84.833325ms","hash":1271941098,"current-db-size-bytes":53571584,"current-db-size":"54 MB","current-db-size-in-use-bytes":18219008,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-05T13:01:47.93112Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1271941098,"revision":5652,"compact-revision":2921}