{"level":"warn","ts":"2026-10-09T05:12:14.765972Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-09T05:12:14.766062Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-10-09T05:12:14.766124Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-09T05:12:14.766139Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-10-09T05:12:14.766158Z","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-10-09T05:12:14.7669Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]}
{"level":"info","ts":"2026-10-09T05:12:14.766983Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-10-09T05:12:14.772495Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.294943ms"}
{"level":"info","ts":"2026-10-09T05:12:14.782149Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"}
{"level":"info","ts":"2026-10-09T05:12:14.782232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"}
{"level":"info","ts":"2026-10-09T05:12:14.782254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"}
{"level":"info","ts":"2026-10-09T05:12:14.782266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-09T05:12:14.78228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"}
{"level":"info","ts":"2026-10-09T05:12:14.782332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"warn","ts":"2026-10-09T05:12:14.789051Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-09T05:12:14.790304Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-09T05:12:14.791797Z","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-10-09T05:12:14.793901Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-09T05:12:14.80042Z","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-10-09T05:12:14.800443Z","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-10-09T05:12:14.800526Z","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-10-09T05:12:14.800601Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-10-09T05:12:14.800658Z","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-10-09T05:12:14.800662Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"}
{"level":"info","ts":"2026-10-09T05:12:14.800771Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-09T05:12:14.800849Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-09T05:12:14.800846Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-09T05:12:14.801376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"}
{"level":"info","ts":"2026-10-09T05:12:14.801492Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]}
{"level":"info","ts":"2026-10-09T05:12:15.583104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"}
{"level":"info","ts":"2026-10-09T05:12:15.583193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-09T05:12:15.583252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"}
{"level":"info","ts":"2026-10-09T05:12:15.583283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"}
{"level":"info","ts":"2026-10-09T05:12:15.5833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-10-09T05:12:15.583315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"}
{"level":"info","ts":"2026-10-09T05:12:15.583332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"}
{"level":"info","ts":"2026-10-09T05:12:15.585282Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-09T05:12:15.585287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-09T05:12:15.58534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-09T05:12:15.585314Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T05:12:15.585546Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-09T05:12:15.585577Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-09T05:12:15.586577Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T05:12:15.586718Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T05:12:15.586763Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-09T05:12:15.587527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-09T05:12:15.608143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"}
{"level":"info","ts":"2026-10-09T05:12:30.498029Z","caller":"traceutil/trace.go:171","msg":"trace[2044195782] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"149.01567ms","start":"2026-10-09T05:12:30.348986Z","end":"2026-10-09T05:12:30.498002Z","steps":["trace[2044195782] 'process raft request'  (duration: 148.825775ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:12:59.4025Z","caller":"traceutil/trace.go:171","msg":"trace[390075193] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"113.111424ms","start":"2026-10-09T05:12:59.289371Z","end":"2026-10-09T05:12:59.402482Z","steps":["trace[390075193] 'process raft request'  (duration: 113.008611ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:13:00.682934Z","caller":"traceutil/trace.go:171","msg":"trace[745282721] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"119.266975ms","start":"2026-10-09T05:13:00.563623Z","end":"2026-10-09T05:13:00.68289Z","steps":["trace[745282721] 'process raft request'  (duration: 109.835968ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:13:05.822246Z","caller":"traceutil/trace.go:171","msg":"trace[1633676192] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"138.472256ms","start":"2026-10-09T05:13:05.683747Z","end":"2026-10-09T05:13:05.822219Z","steps":["trace[1633676192] 'process raft request'  (duration: 138.023837ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:13:06.197869Z","caller":"traceutil/trace.go:171","msg":"trace[2017778735] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"155.181653ms","start":"2026-10-09T05:13:06.042664Z","end":"2026-10-09T05:13:06.197846Z","steps":["trace[2017778735] 'read index received'  (duration: 28.351518ms)","trace[2017778735] 'applied index is now lower than readState.Index'  (duration: 126.829215ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:13:06.197975Z","caller":"traceutil/trace.go:171","msg":"trace[1978272337] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"184.403679ms","start":"2026-10-09T05:13:06.013545Z","end":"2026-10-09T05:13:06.197949Z","steps":["trace[1978272337] 'process raft request'  (duration: 161.349236ms)","trace[1978272337] 'compare'  (duration: 22.811878ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:13:06.20331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.633353ms","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-10-09T05:13:06.203704Z","caller":"traceutil/trace.go:171","msg":"trace[1546824932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"161.079981ms","start":"2026-10-09T05:13:06.042603Z","end":"2026-10-09T05:13:06.203683Z","steps":["trace[1546824932] 'agreement among raft nodes before linearized reading'  (duration: 155.421617ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:13:06.661488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.997459ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555609071963784041 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:627 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T05:13:06.661605Z","caller":"traceutil/trace.go:171","msg":"trace[16802356] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"453.517117ms","start":"2026-10-09T05:13:06.20807Z","end":"2026-10-09T05:13:06.661588Z","steps":["trace[16802356] 'process raft request'  (duration: 122.836854ms)","trace[16802356] 'compare'  (duration: 329.860646ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:13:06.661667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:13:06.208046Z","time spent":"453.591018ms","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:627 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-09T05:13:06.685844Z","caller":"traceutil/trace.go:171","msg":"trace[285578525] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"136.934507ms","start":"2026-10-09T05:13:06.548829Z","end":"2026-10-09T05:13:06.685763Z","steps":["trace[285578525] 'read index received'  (duration: 125.722742ms)","trace[285578525] 'applied index is now lower than readState.Index'  (duration: 11.209415ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:13:06.68616Z","caller":"traceutil/trace.go:171","msg":"trace[959394251] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"313.672711ms","start":"2026-10-09T05:13:06.372455Z","end":"2026-10-09T05:13:06.686128Z","steps":["trace[959394251] 'process raft request'  (duration: 302.968096ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:13:06.686215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.150631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-09T05:13:06.686268Z","caller":"traceutil/trace.go:171","msg":"trace[1071358421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"137.475687ms","start":"2026-10-09T05:13:06.548775Z","end":"2026-10-09T05:13:06.686251Z","steps":["trace[1071358421] 'agreement among raft nodes before linearized reading'  (duration: 137.150151ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:13:06.686303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:13:06.372425Z","time spent":"313.810164ms","remote":"127.0.0.1:48692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:636 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036021 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-10-09T05:13:21.785654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.881019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-09T05:13:21.785771Z","caller":"traceutil/trace.go:171","msg":"trace[1963607025] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:814; }","duration":"227.048671ms","start":"2026-10-09T05:13:21.558695Z","end":"2026-10-09T05:13:21.785744Z","steps":["trace[1963607025] 'count revisions from in-memory index tree'  (duration: 226.787437ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:14:39.166938Z","caller":"traceutil/trace.go:171","msg":"trace[1257850043] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"108.765161ms","start":"2026-10-09T05:14:39.058139Z","end":"2026-10-09T05:14:39.166904Z","steps":["trace[1257850043] 'process raft request'  (duration: 91.415028ms)","trace[1257850043] 'compare'  (duration: 17.202991ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:14:39.586006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.844161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-37d34690-4044-4dc7-b3a0-e6123e32582f\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-10-09T05:14:39.586084Z","caller":"traceutil/trace.go:171","msg":"trace[607521047] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-37d34690-4044-4dc7-b3a0-e6123e32582f; range_end:; response_count:1; response_revision:1879; }","duration":"108.975403ms","start":"2026-10-09T05:14:39.477089Z","end":"2026-10-09T05:14:39.586065Z","steps":["trace[607521047] 'range keys from in-memory index tree'  (duration: 108.647987ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:14:40.259244Z","caller":"traceutil/trace.go:171","msg":"trace[1363484283] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"122.113426ms","start":"2026-10-09T05:14:40.137102Z","end":"2026-10-09T05:14:40.259215Z","steps":["trace[1363484283] 'process raft request'  (duration: 102.388231ms)","trace[1363484283] 'compare'  (duration: 19.318969ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:15:03.585848Z","caller":"traceutil/trace.go:171","msg":"trace[649154361] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"136.210564ms","start":"2026-10-09T05:15:03.449612Z","end":"2026-10-09T05:15:03.585823Z","steps":["trace[649154361] 'process raft request'  (duration: 136.051902ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:15:03.597512Z","caller":"traceutil/trace.go:171","msg":"trace[920551160] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"109.583143ms","start":"2026-10-09T05:15:03.487895Z","end":"2026-10-09T05:15:03.597478Z","steps":["trace[920551160] 'process raft request'  (duration: 109.35683ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:15:09.01055Z","caller":"traceutil/trace.go:171","msg":"trace[154081977] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"129.311751ms","start":"2026-10-09T05:15:08.881213Z","end":"2026-10-09T05:15:09.010525Z","steps":["trace[154081977] 'process raft request'  (duration: 129.163799ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:15:09.480683Z","caller":"traceutil/trace.go:171","msg":"trace[351687247] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"108.268592ms","start":"2026-10-09T05:15:09.372396Z","end":"2026-10-09T05:15:09.480665Z","steps":["trace[351687247] 'process raft request'  (duration: 103.044936ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:15:09.806815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.369202ms","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-10-09T05:15:09.80701Z","caller":"traceutil/trace.go:171","msg":"trace[903252113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2101; }","duration":"156.608655ms","start":"2026-10-09T05:15:09.650377Z","end":"2026-10-09T05:15:09.806985Z","steps":["trace[903252113] 'range keys from in-memory index tree'  (duration: 156.166738ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:15:10.475738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.431874ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555609071963787021 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2094 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T05:15:10.475885Z","caller":"traceutil/trace.go:171","msg":"trace[1087749449] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2182; }","duration":"133.252485ms","start":"2026-10-09T05:15:10.342608Z","end":"2026-10-09T05:15:10.475861Z","steps":["trace[1087749449] 'read index received'  (duration: 27.561408ms)","trace[1087749449] 'applied index is now lower than readState.Index'  (duration: 105.689877ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:15:10.475922Z","caller":"traceutil/trace.go:171","msg":"trace[1063177849] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"237.877319ms","start":"2026-10-09T05:15:10.238012Z","end":"2026-10-09T05:15:10.475889Z","steps":["trace[1063177849] 'process raft request'  (duration: 132.155812ms)","trace[1063177849] 'compare'  (duration: 105.294542ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:15:10.476053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.448797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-10-09T05:15:10.476108Z","caller":"traceutil/trace.go:171","msg":"trace[650239895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2104; }","duration":"133.544649ms","start":"2026-10-09T05:15:10.342546Z","end":"2026-10-09T05:15:10.476091Z","steps":["trace[650239895] 'agreement among raft nodes before linearized reading'  (duration: 133.369187ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:15:10.479447Z","caller":"traceutil/trace.go:171","msg":"trace[197553996] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"114.454557ms","start":"2026-10-09T05:15:10.364972Z","end":"2026-10-09T05:15:10.479427Z","steps":["trace[197553996] 'process raft request'  (duration: 114.351936ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:16:18.853204Z","caller":"traceutil/trace.go:171","msg":"trace[694311641] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"180.062292ms","start":"2026-10-09T05:16:18.673055Z","end":"2026-10-09T05:16:18.853118Z","steps":["trace[694311641] 'process raft request'  (duration: 179.877715ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:16:18.861646Z","caller":"traceutil/trace.go:171","msg":"trace[714918825] transaction","detail":"{read_only:false; response_revision:2577; number_of_response:1; }","duration":"107.954688ms","start":"2026-10-09T05:16:18.753681Z","end":"2026-10-09T05:16:18.861636Z","steps":["trace[714918825] 'process raft request'  (duration: 107.6964ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:16:51.195051Z","caller":"traceutil/trace.go:171","msg":"trace[703230020] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2856; }","duration":"179.20451ms","start":"2026-10-09T05:16:51.015798Z","end":"2026-10-09T05:16:51.195002Z","steps":["trace[703230020] 'read index received'  (duration: 98.469848ms)","trace[703230020] 'applied index is now lower than readState.Index'  (duration: 80.733822ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:16:51.19535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.524619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"info","ts":"2026-10-09T05:16:51.195395Z","caller":"traceutil/trace.go:171","msg":"trace[2117149893] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2755; }","duration":"179.611372ms","start":"2026-10-09T05:16:51.015767Z","end":"2026-10-09T05:16:51.195378Z","steps":["trace[2117149893] 'agreement among raft nodes before linearized reading'  (duration: 179.356714ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:16:51.195552Z","caller":"traceutil/trace.go:171","msg":"trace[567615229] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"180.89846ms","start":"2026-10-09T05:16:51.014474Z","end":"2026-10-09T05:16:51.195373Z","steps":["trace[567615229] 'process raft request'  (duration: 99.933341ms)","trace[567615229] 'compare'  (duration: 80.475234ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:16:51.415701Z","caller":"traceutil/trace.go:171","msg":"trace[561123469] linearizableReadLoop","detail":"{readStateIndex:2858; appliedIndex:2857; }","duration":"151.978282ms","start":"2026-10-09T05:16:51.263691Z","end":"2026-10-09T05:16:51.415669Z","steps":["trace[561123469] 'read index received'  (duration: 115.78284ms)","trace[561123469] 'applied index is now lower than readState.Index'  (duration: 36.192072ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:16:51.415766Z","caller":"traceutil/trace.go:171","msg":"trace[771796705] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"155.28029ms","start":"2026-10-09T05:16:51.260452Z","end":"2026-10-09T05:16:51.415733Z","steps":["trace[771796705] 'process raft request'  (duration: 119.020486ms)","trace[771796705] 'compare'  (duration: 35.685027ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:16:51.416161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.450727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-10-09T05:16:51.417519Z","caller":"traceutil/trace.go:171","msg":"trace[1911150492] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2757; }","duration":"153.834178ms","start":"2026-10-09T05:16:51.263661Z","end":"2026-10-09T05:16:51.417496Z","steps":["trace[1911150492] 'agreement among raft nodes before linearized reading'  (duration: 152.167288ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:16:51.568079Z","caller":"traceutil/trace.go:171","msg":"trace[181813518] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"145.905953ms","start":"2026-10-09T05:16:51.422141Z","end":"2026-10-09T05:16:51.568046Z","steps":["trace[181813518] 'process raft request'  (duration: 126.088396ms)","trace[181813518] 'compare'  (duration: 19.610021ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:21:22.411032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.064851ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555609071963794132 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4867 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-09T05:21:22.411132Z","caller":"traceutil/trace.go:171","msg":"trace[679154390] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"256.548632ms","start":"2026-10-09T05:21:22.154566Z","end":"2026-10-09T05:21:22.411115Z","steps":["trace[679154390] 'process raft request'  (duration: 129.327648ms)","trace[679154390] 'compare'  (duration: 126.916549ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:21:22.832763Z","caller":"traceutil/trace.go:171","msg":"trace[384634313] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5120; }","duration":"175.371057ms","start":"2026-10-09T05:21:22.657364Z","end":"2026-10-09T05:21:22.832735Z","steps":["trace[384634313] 'read index received'  (duration: 175.080512ms)","trace[384634313] 'applied index is now lower than readState.Index'  (duration: 289.105µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:21:22.83282Z","caller":"traceutil/trace.go:171","msg":"trace[872030266] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"179.884824ms","start":"2026-10-09T05:21:22.652903Z","end":"2026-10-09T05:21:22.832788Z","steps":["trace[872030266] 'process raft request'  (duration: 179.66388ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:21:22.832993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.58678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-09T05:21:22.833036Z","caller":"traceutil/trace.go:171","msg":"trace[20658320] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4939; }","duration":"175.699193ms","start":"2026-10-09T05:21:22.657323Z","end":"2026-10-09T05:21:22.833023Z","steps":["trace[20658320] 'agreement among raft nodes before linearized reading'  (duration: 175.51453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:21:36.176051Z","caller":"traceutil/trace.go:171","msg":"trace[1555862804] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"221.917896ms","start":"2026-10-09T05:21:35.95411Z","end":"2026-10-09T05:21:36.176028Z","steps":["trace[1555862804] 'process raft request'  (duration: 221.775093ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:21:36.176187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.934253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-09T05:21:36.176247Z","caller":"traceutil/trace.go:171","msg":"trace[419534775] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:5120; }","duration":"149.042696ms","start":"2026-10-09T05:21:36.027189Z","end":"2026-10-09T05:21:36.176231Z","steps":["trace[419534775] 'agreement among raft nodes before linearized reading'  (duration: 148.912643ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:21:36.176052Z","caller":"traceutil/trace.go:171","msg":"trace[438863721] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5310; }","duration":"148.800231ms","start":"2026-10-09T05:21:36.027227Z","end":"2026-10-09T05:21:36.176027Z","steps":["trace[438863721] 'read index received'  (duration: 148.7893ms)","trace[438863721] 'applied index is now lower than readState.Index'  (duration: 9.071µs)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:21:36.595038Z","caller":"traceutil/trace.go:171","msg":"trace[2029008964] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"143.841678ms","start":"2026-10-09T05:21:36.451171Z","end":"2026-10-09T05:21:36.595013Z","steps":["trace[2029008964] 'process raft request'  (duration: 122.001691ms)","trace[2029008964] 'compare'  (duration: 21.598153ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:21:36.595015Z","caller":"traceutil/trace.go:171","msg":"trace[1384973042] linearizableReadLoop","detail":"{readStateIndex:5314; appliedIndex:5313; }","duration":"101.596571ms","start":"2026-10-09T05:21:36.493398Z","end":"2026-10-09T05:21:36.594995Z","steps":["trace[1384973042] 'read index received'  (duration: 79.760715ms)","trace[1384973042] 'applied index is now lower than readState.Index'  (duration: 21.834776ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-09T05:21:36.595589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.18292ms","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-10-09T05:21:36.595694Z","caller":"traceutil/trace.go:171","msg":"trace[882261522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5124; }","duration":"102.364613ms","start":"2026-10-09T05:21:36.493313Z","end":"2026-10-09T05:21:36.595678Z","steps":["trace[882261522] 'agreement among raft nodes before linearized reading'  (duration: 101.951507ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:21:36.612911Z","caller":"traceutil/trace.go:171","msg":"trace[681983723] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"104.919406ms","start":"2026-10-09T05:21:36.507968Z","end":"2026-10-09T05:21:36.612888Z","steps":["trace[681983723] 'process raft request'  (duration: 104.800634ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:22:15.619566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2885}
{"level":"info","ts":"2026-10-09T05:22:15.711721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2885,"took":"90.918645ms","hash":2894043888,"current-db-size-bytes":53403648,"current-db-size":"53 MB","current-db-size-in-use-bytes":28626944,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-09T05:22:15.711803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2894043888,"revision":2885,"compact-revision":-1}
{"level":"info","ts":"2026-10-09T05:22:23.900069Z","caller":"traceutil/trace.go:171","msg":"trace[196100112] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"202.834318ms","start":"2026-10-09T05:22:23.697211Z","end":"2026-10-09T05:22:23.900045Z","steps":["trace[196100112] 'process raft request'  (duration: 202.649025ms)"],"step_count":1}
{"level":"info","ts":"2026-10-09T05:25:25.940523Z","caller":"traceutil/trace.go:171","msg":"trace[1404669425] transaction","detail":"{read_only:false; response_revision:6834; number_of_response:1; }","duration":"106.070062ms","start":"2026-10-09T05:25:25.83443Z","end":"2026-10-09T05:25:25.9405Z","steps":["trace[1404669425] 'process raft request'  (duration: 105.786763ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-09T05:25:26.184309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.05116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8555609071963798934 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:6825 > 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-10-09T05:25:26.184413Z","caller":"traceutil/trace.go:171","msg":"trace[1810831900] transaction","detail":"{read_only:false; response_revision:6835; number_of_response:1; }","duration":"239.585928ms","start":"2026-10-09T05:25:25.944808Z","end":"2026-10-09T05:25:26.184394Z","steps":["trace[1810831900] 'process raft request'  (duration: 84.361232ms)","trace[1810831900] 'compare'  (duration: 154.596566ms)"],"step_count":2}
{"level":"info","ts":"2026-10-09T05:27:15.626067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5478}
{"level":"info","ts":"2026-10-09T05:27:15.704588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5478,"took":"77.001771ms","hash":1752983680,"current-db-size-bytes":53403648,"current-db-size":"53 MB","current-db-size-in-use-bytes":18489344,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-10-09T05:27:15.704653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1752983680,"revision":5478,"compact-revision":2885}