{"level":"warn","ts":"2026-04-29T01:19:02.780614Z","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-29T01:19:02.780705Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-29T01:19:02.780798Z","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-29T01:19:02.780811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]}
{"level":"info","ts":"2026-04-29T01:19:02.780832Z","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-29T01:19:02.781523Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]}
{"level":"info","ts":"2026-04-29T01:19:02.781647Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-29T01:19:02.785978Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.06789ms"}
{"level":"info","ts":"2026-04-29T01:19:02.79617Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"}
{"level":"info","ts":"2026-04-29T01:19:02.796329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"}
{"level":"info","ts":"2026-04-29T01:19:02.796353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"}
{"level":"info","ts":"2026-04-29T01:19:02.796372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-29T01:19:02.796409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"}
{"level":"info","ts":"2026-04-29T01:19:02.796514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"}
{"level":"warn","ts":"2026-04-29T01:19:02.803185Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-29T01:19:02.804961Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-29T01:19:02.806284Z","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-29T01:19:02.812747Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-29T01:19:02.81301Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-29T01:19:02.813184Z","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-29T01:19:02.813304Z","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-29T01:19:02.813334Z","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-29T01:19:02.815534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"}
{"level":"info","ts":"2026-04-29T01:19:02.815728Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]}
{"level":"info","ts":"2026-04-29T01:19:02.81754Z","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-29T01:19:02.81779Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"}
{"level":"info","ts":"2026-04-29T01:19:02.817838Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"}
{"level":"info","ts":"2026-04-29T01:19:02.817821Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-29T01:19:02.817865Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-29T01:19:03.597118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"}
{"level":"info","ts":"2026-04-29T01:19:03.597183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-29T01:19:03.59722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"}
{"level":"info","ts":"2026-04-29T01:19:03.597236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"}
{"level":"info","ts":"2026-04-29T01:19:03.597244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"}
{"level":"info","ts":"2026-04-29T01:19:03.597255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"}
{"level":"info","ts":"2026-04-29T01:19:03.59727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"}
{"level":"info","ts":"2026-04-29T01:19:03.598124Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-29T01:19:03.598131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-29T01:19:03.598158Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:19:03.598162Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-29T01:19:03.598347Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-29T01:19:03.598367Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-29T01:19:03.599224Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:19:03.599402Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:19:03.599476Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-29T01:19:03.601335Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"}
{"level":"info","ts":"2026-04-29T01:19:03.601751Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-29T01:19:05.204964Z","caller":"traceutil/trace.go:171","msg":"trace[1156332735] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"354.492662ms","start":"2026-04-29T01:19:04.850451Z","end":"2026-04-29T01:19:05.204944Z","steps":["trace[1156332735] 'read index received'  (duration: 60.232363ms)","trace[1156332735] 'applied index is now lower than readState.Index'  (duration: 294.259569ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:19:05.205065Z","caller":"traceutil/trace.go:171","msg":"trace[551810016] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"303.448644ms","start":"2026-04-29T01:19:04.901609Z","end":"2026-04-29T01:19:05.205058Z","steps":["trace[551810016] 'process raft request'  (duration: 303.280651ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:05.20508Z","caller":"traceutil/trace.go:171","msg":"trace[1665328835] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"303.458283ms","start":"2026-04-29T01:19:04.901584Z","end":"2026-04-29T01:19:05.205042Z","steps":["trace[1665328835] 'process raft request'  (duration: 303.287141ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:05.205155Z","caller":"traceutil/trace.go:171","msg":"trace[1534619692] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"306.267584ms","start":"2026-04-29T01:19:04.898857Z","end":"2026-04-29T01:19:05.205124Z","steps":["trace[1534619692] 'process raft request'  (duration: 305.96271ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:05.205203Z","caller":"traceutil/trace.go:171","msg":"trace[1002332946] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"303.92037ms","start":"2026-04-29T01:19:04.901273Z","end":"2026-04-29T01:19:05.205194Z","steps":["trace[1002332946] 'process raft request'  (duration: 303.577436ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.20542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.901579Z","time spent":"303.507154ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"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-29T01:19:05.205478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.901259Z","time spent":"304.125033ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"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-04-29T01:19:05.20554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.901562Z","time spent":"303.615025ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"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-04-29T01:19:05.205566Z","caller":"traceutil/trace.go:171","msg":"trace[629953464] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"361.373882ms","start":"2026-04-29T01:19:04.844127Z","end":"2026-04-29T01:19:05.205501Z","steps":["trace[629953464] 'process raft request'  (duration: 346.906952ms)","trace[629953464] 'compare'  (duration: 13.661818ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:19:05.205584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.09549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-29T01:19:05.205243Z","caller":"traceutil/trace.go:171","msg":"trace[1827821831] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"303.21869ms","start":"2026-04-29T01:19:04.902015Z","end":"2026-04-29T01:19:05.205233Z","steps":["trace[1827821831] 'process raft request'  (duration: 302.909076ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.205663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.898823Z","time spent":"306.383957ms","remote":"127.0.0.1:50174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"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-04-29T01:19:05.205678Z","caller":"traceutil/trace.go:171","msg":"trace[273617854] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"355.228712ms","start":"2026-04-29T01:19:04.850429Z","end":"2026-04-29T01:19:05.205657Z","steps":["trace[273617854] 'agreement among raft nodes before linearized reading'  (duration: 355.025169ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.205694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.902001Z","time spent":"303.663296ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"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-29T01:19:05.205718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.85042Z","time spent":"355.288293ms","remote":"127.0.0.1:50114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-04-29T01:19:05.205274Z","caller":"traceutil/trace.go:171","msg":"trace[482684768] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"303.603885ms","start":"2026-04-29T01:19:04.901661Z","end":"2026-04-29T01:19:05.205265Z","steps":["trace[482684768] 'process raft request'  (duration: 303.24647ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.205784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.901651Z","time spent":"304.111763ms","remote":"127.0.0.1:50242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"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-29T01:19:05.205983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.8441Z","time spent":"361.558064ms","remote":"127.0.0.1:49782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"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":"info","ts":"2026-04-29T01:19:05.211494Z","caller":"traceutil/trace.go:171","msg":"trace[1635802268] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"277.30085ms","start":"2026-04-29T01:19:04.934151Z","end":"2026-04-29T01:19:05.211452Z","steps":["trace[1635802268] 'process raft request'  (duration: 277.28005ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:05.211524Z","caller":"traceutil/trace.go:171","msg":"trace[1306339363] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"290.876969ms","start":"2026-04-29T01:19:04.920613Z","end":"2026-04-29T01:19:05.21149Z","steps":["trace[1306339363] 'process raft request'  (duration: 290.765137ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.211662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.514204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-29T01:19:05.211692Z","caller":"traceutil/trace.go:171","msg":"trace[376056785] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:0; response_revision:11; }","duration":"316.583195ms","start":"2026-04-29T01:19:04.895099Z","end":"2026-04-29T01:19:05.211683Z","steps":["trace[376056785] 'agreement among raft nodes before linearized reading'  (duration: 316.506303ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.211711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.895071Z","time spent":"316.635576ms","remote":"127.0.0.1:49736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.49\" "}
{"level":"warn","ts":"2026-04-29T01:19:05.211839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.261729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-29T01:19:05.211807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.718147ms","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-29T01:19:05.211863Z","caller":"traceutil/trace.go:171","msg":"trace[525069139] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"318.30735ms","start":"2026-04-29T01:19:04.89355Z","end":"2026-04-29T01:19:05.211858Z","steps":["trace[525069139] 'agreement among raft nodes before linearized reading'  (duration: 318.27201ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.21188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.893536Z","time spent":"318.34083ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-04-29T01:19:05.211806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.781785ms","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-04-29T01:19:05.211906Z","caller":"traceutil/trace.go:171","msg":"trace[41989560] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"316.813998ms","start":"2026-04-29T01:19:04.895053Z","end":"2026-04-29T01:19:05.211867Z","steps":["trace[41989560] 'agreement among raft nodes before linearized reading'  (duration: 316.568685ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.211946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.625576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-29T01:19:05.211949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.895036Z","time spent":"316.905029ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-04-29T01:19:05.212045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.422305ms","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-29T01:19:05.21192Z","caller":"traceutil/trace.go:171","msg":"trace[282633541] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"310.385464ms","start":"2026-04-29T01:19:04.901517Z","end":"2026-04-29T01:19:05.211902Z","steps":["trace[282633541] 'agreement among raft nodes before linearized reading'  (duration: 310.092439ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:05.212083Z","caller":"traceutil/trace.go:171","msg":"trace[139563466] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"230.490625ms","start":"2026-04-29T01:19:04.981584Z","end":"2026-04-29T01:19:05.212075Z","steps":["trace[139563466] 'agreement among raft nodes before linearized reading'  (duration: 230.422504ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.212148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:04.9015Z","time spent":"310.583477ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"info","ts":"2026-04-29T01:19:05.21199Z","caller":"traceutil/trace.go:171","msg":"trace[1459966837] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"230.747698ms","start":"2026-04-29T01:19:04.981231Z","end":"2026-04-29T01:19:05.211979Z","steps":["trace[1459966837] 'agreement among raft nodes before linearized reading'  (duration: 230.681067ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:05.212033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.300214ms","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-29T01:19:05.212277Z","caller":"traceutil/trace.go:171","msg":"trace[1393795868] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"265.557008ms","start":"2026-04-29T01:19:04.946708Z","end":"2026-04-29T01:19:05.212265Z","steps":["trace[1393795868] 'agreement among raft nodes before linearized reading'  (duration: 265.293404ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:12.999106Z","caller":"traceutil/trace.go:171","msg":"trace[354430820] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"122.277762ms","start":"2026-04-29T01:19:12.876799Z","end":"2026-04-29T01:19:12.999076Z","steps":["trace[354430820] 'process raft request'  (duration: 110.878493ms)","trace[354430820] 'compare'  (duration: 11.233007ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:19:13.268534Z","caller":"traceutil/trace.go:171","msg":"trace[1526993213] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"235.186658ms","start":"2026-04-29T01:19:13.033322Z","end":"2026-04-29T01:19:13.268509Z","steps":["trace[1526993213] 'read index received'  (duration: 179.442337ms)","trace[1526993213] 'applied index is now lower than readState.Index'  (duration: 55.743191ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:19:13.268619Z","caller":"traceutil/trace.go:171","msg":"trace[1741105472] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"237.169705ms","start":"2026-04-29T01:19:13.031407Z","end":"2026-04-29T01:19:13.268577Z","steps":["trace[1741105472] 'process raft request'  (duration: 181.329083ms)","trace[1741105472] 'compare'  (duration: 55.515358ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:19:13.268723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.379112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-04-29T01:19:13.268768Z","caller":"traceutil/trace.go:171","msg":"trace[1890930362] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:323; }","duration":"235.463413ms","start":"2026-04-29T01:19:13.033292Z","end":"2026-04-29T01:19:13.268756Z","steps":["trace[1890930362] 'agreement among raft nodes before linearized reading'  (duration: 235.34474ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:13.268732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.693717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"warn","ts":"2026-04-29T01:19:13.268844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.278136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-29T01:19:13.268878Z","caller":"traceutil/trace.go:171","msg":"trace[155245470] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:323; }","duration":"142.869589ms","start":"2026-04-29T01:19:13.12599Z","end":"2026-04-29T01:19:13.26886Z","steps":["trace[155245470] 'agreement among raft nodes before linearized reading'  (duration: 142.696767ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:13.268896Z","caller":"traceutil/trace.go:171","msg":"trace[204774829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:323; }","duration":"177.387578ms","start":"2026-04-29T01:19:13.091493Z","end":"2026-04-29T01:19:13.268881Z","steps":["trace[204774829] 'agreement among raft nodes before linearized reading'  (duration: 177.205766ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:13.26902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.863888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-04-29T01:19:13.269156Z","caller":"traceutil/trace.go:171","msg":"trace[301738903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:323; }","duration":"192.101252ms","start":"2026-04-29T01:19:13.077037Z","end":"2026-04-29T01:19:13.269138Z","steps":["trace[301738903] 'agreement among raft nodes before linearized reading'  (duration: 191.617084ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:33.92084Z","caller":"traceutil/trace.go:171","msg":"trace[283753938] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"123.995515ms","start":"2026-04-29T01:19:33.796808Z","end":"2026-04-29T01:19:33.920804Z","steps":["trace[283753938] 'process raft request'  (duration: 113.259928ms)","trace[283753938] 'compare'  (duration: 10.344199ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:19:33.921636Z","caller":"traceutil/trace.go:171","msg":"trace[1087456019] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"124.582381ms","start":"2026-04-29T01:19:33.797013Z","end":"2026-04-29T01:19:33.921595Z","steps":["trace[1087456019] 'process raft request'  (duration: 124.279568ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:39.929154Z","caller":"traceutil/trace.go:171","msg":"trace[310678302] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"118.336489ms","start":"2026-04-29T01:19:39.810789Z","end":"2026-04-29T01:19:39.929125Z","steps":["trace[310678302] 'process raft request'  (duration: 118.198833ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:40.293774Z","caller":"traceutil/trace.go:171","msg":"trace[1400477464] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"444.277879ms","start":"2026-04-29T01:19:39.849475Z","end":"2026-04-29T01:19:40.293753Z","steps":["trace[1400477464] 'process raft request'  (duration: 439.862842ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:40.293891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:39.849446Z","time spent":"444.386933ms","remote":"127.0.0.1:49808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:585 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036025 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-29T01:19:40.294065Z","caller":"traceutil/trace.go:171","msg":"trace[1319781638] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"383.52833ms","start":"2026-04-29T01:19:39.910508Z","end":"2026-04-29T01:19:40.294036Z","steps":["trace[1319781638] 'process raft request'  (duration: 383.201877ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:40.29418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:39.910482Z","time spent":"383.642505ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:451 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-29T01:19:40.294378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.883235ms","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-29T01:19:40.294443Z","caller":"traceutil/trace.go:171","msg":"trace[895908585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"290.976419ms","start":"2026-04-29T01:19:40.003453Z","end":"2026-04-29T01:19:40.294429Z","steps":["trace[895908585] 'agreement among raft nodes before linearized reading'  (duration: 290.838953ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:40.294838Z","caller":"traceutil/trace.go:171","msg":"trace[1908514133] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"290.646465ms","start":"2026-04-29T01:19:40.003499Z","end":"2026-04-29T01:19:40.294145Z","steps":["trace[1908514133] 'read index received'  (duration: 284.814149ms)","trace[1908514133] 'applied index is now lower than readState.Index'  (duration: 5.828156ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-29T01:19:40.295039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.810324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n8nz2\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-04-29T01:19:40.295075Z","caller":"traceutil/trace.go:171","msg":"trace[848536746] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n8nz2; range_end:; response_count:1; response_revision:592; }","duration":"277.924198ms","start":"2026-04-29T01:19:40.01714Z","end":"2026-04-29T01:19:40.295064Z","steps":["trace[848536746] 'agreement among raft nodes before linearized reading'  (duration: 277.796643ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:40.412267Z","caller":"traceutil/trace.go:171","msg":"trace[559388290] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"114.421645ms","start":"2026-04-29T01:19:40.297818Z","end":"2026-04-29T01:19:40.412239Z","steps":["trace[559388290] 'process raft request'  (duration: 71.282156ms)","trace[559388290] 'compare'  (duration: 42.92697ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:19:40.442569Z","caller":"traceutil/trace.go:171","msg":"trace[1477469230] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"136.330589ms","start":"2026-04-29T01:19:40.306209Z","end":"2026-04-29T01:19:40.442539Z","steps":["trace[1477469230] 'process raft request'  (duration: 136.10715ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:19:40.96003Z","caller":"traceutil/trace.go:171","msg":"trace[569863616] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"105.961817ms","start":"2026-04-29T01:19:40.854035Z","end":"2026-04-29T01:19:40.959997Z","steps":["trace[569863616] 'process raft request'  (duration: 105.056169ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:55.836505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.134296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-29T01:19:55.836636Z","caller":"traceutil/trace.go:171","msg":"trace[1404046382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"316.319613ms","start":"2026-04-29T01:19:55.520285Z","end":"2026-04-29T01:19:55.836605Z","steps":["trace[1404046382] 'range keys from in-memory index tree'  (duration: 315.852007ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:19:55.836737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:19:55.520265Z","time spent":"316.460799ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-29T01:21:09.057972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.215498ms","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-29T01:21:09.05808Z","caller":"traceutil/trace.go:171","msg":"trace[350427428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1830; }","duration":"207.388392ms","start":"2026-04-29T01:21:08.850673Z","end":"2026-04-29T01:21:09.058061Z","steps":["trace[350427428] 'range keys from in-memory index tree'  (duration: 206.973554ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:21:09.058138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.263792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-29T01:21:09.058242Z","caller":"traceutil/trace.go:171","msg":"trace[807947948] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1830; }","duration":"176.403806ms","start":"2026-04-29T01:21:08.881817Z","end":"2026-04-29T01:21:09.05822Z","steps":["trace[807947948] 'count revisions from in-memory index tree'  (duration: 176.177851ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:21:22.435022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.470177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-04-29T01:21:22.43511Z","caller":"traceutil/trace.go:171","msg":"trace[1525919986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1945; }","duration":"162.59759ms","start":"2026-04-29T01:21:22.272493Z","end":"2026-04-29T01:21:22.43509Z","steps":["trace[1525919986] 'range keys from in-memory index tree'  (duration: 162.231253ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:21:44.277978Z","caller":"traceutil/trace.go:171","msg":"trace[2091180743] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"105.468023ms","start":"2026-04-29T01:21:44.172483Z","end":"2026-04-29T01:21:44.277951Z","steps":["trace[2091180743] 'process raft request'  (duration: 54.377147ms)","trace[2091180743] 'compare'  (duration: 50.968194ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:21:44.846938Z","caller":"traceutil/trace.go:171","msg":"trace[1369564153] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"227.825044ms","start":"2026-04-29T01:21:44.619083Z","end":"2026-04-29T01:21:44.846908Z","steps":["trace[1369564153] 'process raft request'  (duration: 227.62119ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:21:44.869731Z","caller":"traceutil/trace.go:171","msg":"trace[107037020] linearizableReadLoop","detail":"{readStateIndex:2167; appliedIndex:2166; }","duration":"244.172828ms","start":"2026-04-29T01:21:44.625505Z","end":"2026-04-29T01:21:44.869678Z","steps":["trace[107037020] 'read index received'  (duration: 221.396909ms)","trace[107037020] 'applied index is now lower than readState.Index'  (duration: 22.774299ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:21:44.869769Z","caller":"traceutil/trace.go:171","msg":"trace[568951612] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"250.439469ms","start":"2026-04-29T01:21:44.619294Z","end":"2026-04-29T01:21:44.869734Z","steps":["trace[568951612] 'process raft request'  (duration: 250.069282ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:21:44.870031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.511434ms","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-04-29T01:21:44.870116Z","caller":"traceutil/trace.go:171","msg":"trace[1929383782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2085; }","duration":"244.606526ms","start":"2026-04-29T01:21:44.625488Z","end":"2026-04-29T01:21:44.870094Z","steps":["trace[1929383782] 'agreement among raft nodes before linearized reading'  (duration: 244.381441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:21:45.701126Z","caller":"traceutil/trace.go:171","msg":"trace[514188999] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"119.547048ms","start":"2026-04-29T01:21:45.581551Z","end":"2026-04-29T01:21:45.701098Z","steps":["trace[514188999] 'process raft request'  (duration: 119.335344ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:21:45.85769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.766134ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17256278468185726141 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2080 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-29T01:21:45.857922Z","caller":"traceutil/trace.go:171","msg":"trace[1280072633] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"150.85199ms","start":"2026-04-29T01:21:45.707041Z","end":"2026-04-29T01:21:45.857893Z","steps":["trace[1280072633] 'process raft request'  (duration: 18.616917ms)","trace[1280072633] 'compare'  (duration: 131.622811ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:27:13.781942Z","caller":"traceutil/trace.go:171","msg":"trace[2133682512] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"285.709193ms","start":"2026-04-29T01:27:13.496204Z","end":"2026-04-29T01:27:13.781913Z","steps":["trace[2133682512] 'process raft request'  (duration: 217.961989ms)","trace[2133682512] 'compare'  (duration: 67.616561ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:27:13.819616Z","caller":"traceutil/trace.go:171","msg":"trace[794371289] linearizableReadLoop","detail":"{readStateIndex:4885; appliedIndex:4883; }","duration":"229.184606ms","start":"2026-04-29T01:27:13.590403Z","end":"2026-04-29T01:27:13.819587Z","steps":["trace[794371289] 'read index received'  (duration: 123.899714ms)","trace[794371289] 'applied index is now lower than readState.Index'  (duration: 105.283802ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:27:13.819738Z","caller":"traceutil/trace.go:171","msg":"trace[1986535452] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"224.873541ms","start":"2026-04-29T01:27:13.594854Z","end":"2026-04-29T01:27:13.819728Z","steps":["trace[1986535452] 'process raft request'  (duration: 224.670086ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:27:13.819811Z","caller":"traceutil/trace.go:171","msg":"trace[1746355434] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"291.108022ms","start":"2026-04-29T01:27:13.528685Z","end":"2026-04-29T01:27:13.819793Z","steps":["trace[1746355434] 'process raft request'  (duration: 290.668283ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:27:13.81997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.550024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:27:13.820011Z","caller":"traceutil/trace.go:171","msg":"trace[892102936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4705; }","duration":"229.626866ms","start":"2026-04-29T01:27:13.590375Z","end":"2026-04-29T01:27:13.820001Z","steps":["trace[892102936] 'agreement among raft nodes before linearized reading'  (duration: 229.550594ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:27:13.827609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.333916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2196580"}
{"level":"info","ts":"2026-04-29T01:27:13.827705Z","caller":"traceutil/trace.go:171","msg":"trace[107839444] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4705; }","duration":"111.472229ms","start":"2026-04-29T01:27:13.7162Z","end":"2026-04-29T01:27:13.827672Z","steps":["trace[107839444] 'agreement among raft nodes before linearized reading'  (duration: 103.899532ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:27:14.250471Z","caller":"traceutil/trace.go:171","msg":"trace[1887130268] linearizableReadLoop","detail":"{readStateIndex:4888; appliedIndex:4887; }","duration":"137.948768ms","start":"2026-04-29T01:27:14.112498Z","end":"2026-04-29T01:27:14.250446Z","steps":["trace[1887130268] 'read index received'  (duration: 2.092376ms)","trace[1887130268] 'applied index is now lower than readState.Index'  (duration: 135.855462ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:27:14.250765Z","caller":"traceutil/trace.go:171","msg":"trace[499802480] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"140.841273ms","start":"2026-04-29T01:27:14.109904Z","end":"2026-04-29T01:27:14.250745Z","steps":["trace[499802480] 'process raft request'  (duration: 140.395783ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:27:14.250892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.381768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81ae4860-d55e-4d13-bc5c-5d7f13e9e8d9\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-04-29T01:27:14.251405Z","caller":"traceutil/trace.go:171","msg":"trace[996264475] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81ae4860-d55e-4d13-bc5c-5d7f13e9e8d9; range_end:; response_count:1; response_revision:4707; }","duration":"138.91573ms","start":"2026-04-29T01:27:14.112474Z","end":"2026-04-29T01:27:14.251389Z","steps":["trace[996264475] 'agreement among raft nodes before linearized reading'  (duration: 138.338397ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:27:26.834337Z","caller":"traceutil/trace.go:171","msg":"trace[103327420] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"146.849072ms","start":"2026-04-29T01:27:26.687326Z","end":"2026-04-29T01:27:26.834175Z","steps":["trace[103327420] 'process raft request'  (duration: 146.73049ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:27:26.855471Z","caller":"traceutil/trace.go:171","msg":"trace[1241190679] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5070; }","duration":"107.992771ms","start":"2026-04-29T01:27:26.747459Z","end":"2026-04-29T01:27:26.855452Z","steps":["trace[1241190679] 'read index received'  (duration: 86.74657ms)","trace[1241190679] 'applied index is now lower than readState.Index'  (duration: 21.245351ms)"],"step_count":2}
{"level":"info","ts":"2026-04-29T01:27:26.855564Z","caller":"traceutil/trace.go:171","msg":"trace[1168477751] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"167.884259ms","start":"2026-04-29T01:27:26.68767Z","end":"2026-04-29T01:27:26.855554Z","steps":["trace[1168477751] 'process raft request'  (duration: 167.688235ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-29T01:27:26.855808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.310577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-29T01:27:26.855978Z","caller":"traceutil/trace.go:171","msg":"trace[157932659] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4885; }","duration":"108.472641ms","start":"2026-04-29T01:27:26.747416Z","end":"2026-04-29T01:27:26.855889Z","steps":["trace[157932659] 'agreement among raft nodes before linearized reading'  (duration: 108.245026ms)"],"step_count":1}
{"level":"info","ts":"2026-04-29T01:29:03.630222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2934}
{"level":"info","ts":"2026-04-29T01:29:03.702943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2934,"took":"71.091154ms","hash":2300435161,"current-db-size-bytes":53522432,"current-db-size":"54 MB","current-db-size-in-use-bytes":29532160,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-29T01:29:03.703041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2300435161,"revision":2934,"compact-revision":-1}
{"level":"info","ts":"2026-04-29T01:34:03.63564Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5655}
{"level":"info","ts":"2026-04-29T01:34:03.756282Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5655,"took":"119.118058ms","hash":3738151047,"current-db-size-bytes":53522432,"current-db-size":"54 MB","current-db-size-in-use-bytes":18190336,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-29T01:34:03.756339Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3738151047,"revision":5655,"compact-revision":2934}