{"level":"warn","ts":"2026-10-07T03:39:33.370055Z","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-07T03:39:33.370127Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.92:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.92:2380","--initial-cluster=instance=https://162.253.55.92:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.92:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.92: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-07T03:39:33.370184Z","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-07T03:39:33.370193Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.92:2380"]}
{"level":"info","ts":"2026-10-07T03:39:33.37021Z","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-07T03:39:33.370849Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"]}
{"level":"info","ts":"2026-10-07T03:39:33.370969Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.92: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-07T03:39:33.578332Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"207.130455ms"}
{"level":"info","ts":"2026-10-07T03:39:33.696036Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39a4f14f6507253d","cluster-id":"22d06cab78b8ace5"}
{"level":"info","ts":"2026-10-07T03:39:33.696141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=()"}
{"level":"info","ts":"2026-10-07T03:39:33.696177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 0"}
{"level":"info","ts":"2026-10-07T03:39:33.696196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39a4f14f6507253d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-07T03:39:33.696209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 1"}
{"level":"info","ts":"2026-10-07T03:39:33.69626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"}
{"level":"warn","ts":"2026-10-07T03:39:33.701701Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-07T03:39:33.706428Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-07T03:39:33.709032Z","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-07T03:39:33.712179Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39a4f14f6507253d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-07T03:39:33.713687Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39a4f14f6507253d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-07T03:39:33.713961Z","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-07T03:39:33.714096Z","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-07T03:39:33.714307Z","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-07T03:39:33.716813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"}
{"level":"info","ts":"2026-10-07T03:39:33.717274Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","added-peer-id":"39a4f14f6507253d","added-peer-peer-urls":["https://162.253.55.92:2380"]}
{"level":"info","ts":"2026-10-07T03:39:33.718007Z","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-07T03:39:33.718308Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39a4f14f6507253d","initial-advertise-peer-urls":["https://162.253.55.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-07T03:39:33.718365Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-07T03:39:33.718369Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.92:2380"}
{"level":"info","ts":"2026-10-07T03:39:33.718461Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.92:2380"}
{"level":"info","ts":"2026-10-07T03:39:34.696746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d is starting a new election at term 1"}
{"level":"info","ts":"2026-10-07T03:39:34.696792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-07T03:39:34.696822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgPreVoteResp from 39a4f14f6507253d at term 1"}
{"level":"info","ts":"2026-10-07T03:39:34.696844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became candidate at term 2"}
{"level":"info","ts":"2026-10-07T03:39:34.696851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgVoteResp from 39a4f14f6507253d at term 2"}
{"level":"info","ts":"2026-10-07T03:39:34.696861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became leader at term 2"}
{"level":"info","ts":"2026-10-07T03:39:34.696886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39a4f14f6507253d elected leader 39a4f14f6507253d at term 2"}
{"level":"info","ts":"2026-10-07T03:39:34.698455Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-07T03:39:34.699832Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39a4f14f6507253d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.92:2379]}","request-path":"/0/members/39a4f14f6507253d/attributes","cluster-id":"22d06cab78b8ace5","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-07T03:39:34.699994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-07T03:39:34.700018Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-07T03:39:34.700644Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-07T03:39:34.700741Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-07T03:39:34.700777Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-07T03:39:34.702709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-07T03:39:34.703081Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.92:2379"}
{"level":"info","ts":"2026-10-07T03:39:34.711135Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-07T03:39:34.711222Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-07T03:39:59.338978Z","caller":"traceutil/trace.go:171","msg":"trace[908568459] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"101.977899ms","start":"2026-10-07T03:39:59.236974Z","end":"2026-10-07T03:39:59.338952Z","steps":["trace[908568459] 'process raft request'  (duration: 101.876987ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:40:23.900712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.686962ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2683478062165640541 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:630 > 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-07T03:40:23.900862Z","caller":"traceutil/trace.go:171","msg":"trace[315033854] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"276.551135ms","start":"2026-10-07T03:40:23.624293Z","end":"2026-10-07T03:40:23.900844Z","steps":["trace[315033854] 'read index received'  (duration: 37.541µs)","trace[315033854] 'applied index is now lower than readState.Index'  (duration: 276.512203ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:40:23.901095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.792949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jh7bq\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-10-07T03:40:23.901135Z","caller":"traceutil/trace.go:171","msg":"trace[863751798] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jh7bq; range_end:; response_count:1; response_revision:645; }","duration":"276.87099ms","start":"2026-10-07T03:40:23.624253Z","end":"2026-10-07T03:40:23.901124Z","steps":["trace[863751798] 'agreement among raft nodes before linearized reading'  (duration: 276.649216ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:40:23.901429Z","caller":"traceutil/trace.go:171","msg":"trace[987575142] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"443.335695ms","start":"2026-10-07T03:40:23.457585Z","end":"2026-10-07T03:40:23.900921Z","steps":["trace[987575142] 'process raft request'  (duration: 96.834618ms)","trace[987575142] 'compare'  (duration: 345.521769ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:40:23.90176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:40:23.457573Z","time spent":"443.995587ms","remote":"127.0.0.1:48608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:630 > 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\" > >"}
{"level":"info","ts":"2026-10-07T03:40:24.412531Z","caller":"traceutil/trace.go:171","msg":"trace[1286691782] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"412.311219ms","start":"2026-10-07T03:40:24.000173Z","end":"2026-10-07T03:40:24.412484Z","steps":["trace[1286691782] 'process raft request'  (duration: 391.671358ms)","trace[1286691782] 'compare'  (duration: 20.384767ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:40:24.412696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:40:24.000148Z","time spent":"412.476973ms","remote":"127.0.0.1:48870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-10-07T03:40:36.947171Z","caller":"traceutil/trace.go:171","msg":"trace[1690569931] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"124.41208ms","start":"2026-10-07T03:40:36.822731Z","end":"2026-10-07T03:40:36.947143Z","steps":["trace[1690569931] 'process raft request'  (duration: 124.133125ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:40:40.125185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.987493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-10-07T03:40:40.125267Z","caller":"traceutil/trace.go:171","msg":"trace[1343235267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:813; }","duration":"147.123155ms","start":"2026-10-07T03:40:39.978124Z","end":"2026-10-07T03:40:40.125247Z","steps":["trace[1343235267] 'range keys from in-memory index tree'  (duration: 146.82185ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:40:40.125187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.81627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-07T03:40:40.125354Z","caller":"traceutil/trace.go:171","msg":"trace[1398281607] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:813; }","duration":"259.036684ms","start":"2026-10-07T03:40:39.866292Z","end":"2026-10-07T03:40:40.125328Z","steps":["trace[1398281607] 'count revisions from in-memory index tree'  (duration: 258.670917ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:41:10.065119Z","caller":"traceutil/trace.go:171","msg":"trace[1314808962] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"114.776088ms","start":"2026-10-07T03:41:09.950323Z","end":"2026-10-07T03:41:10.065099Z","steps":["trace[1314808962] 'read index received'  (duration: 114.625316ms)","trace[1314808962] 'applied index is now lower than readState.Index'  (duration: 149.912µs)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:41:10.065193Z","caller":"traceutil/trace.go:171","msg":"trace[1499819342] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"119.636099ms","start":"2026-10-07T03:41:09.945523Z","end":"2026-10-07T03:41:10.065159Z","steps":["trace[1499819342] 'process raft request'  (duration: 119.461827ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:10.065246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.911961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-07T03:41:10.065352Z","caller":"traceutil/trace.go:171","msg":"trace[31086092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"115.093254ms","start":"2026-10-07T03:41:09.950247Z","end":"2026-10-07T03:41:10.06534Z","steps":["trace[31086092] 'agreement among raft nodes before linearized reading'  (duration: 114.953962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:41:58.688069Z","caller":"traceutil/trace.go:171","msg":"trace[1903251729] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"313.128505ms","start":"2026-10-07T03:41:58.374913Z","end":"2026-10-07T03:41:58.688042Z","steps":["trace[1903251729] 'process raft request'  (duration: 312.986713ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:58.688228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:41:58.374882Z","time spent":"313.264796ms","remote":"127.0.0.1:48608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1835 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-07T03:41:58.688516Z","caller":"traceutil/trace.go:171","msg":"trace[1534391482] linearizableReadLoop","detail":"{readStateIndex:1970; appliedIndex:1970; }","duration":"313.130726ms","start":"2026-10-07T03:41:58.37534Z","end":"2026-10-07T03:41:58.688471Z","steps":["trace[1534391482] 'read index received'  (duration: 313.112866ms)","trace[1534391482] 'applied index is now lower than readState.Index'  (duration: 14.76µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:41:58.688869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.460869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18dc2258c4261e5b\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-10-07T03:41:58.689138Z","caller":"traceutil/trace.go:171","msg":"trace[1627851647] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18dc2258c4261e5b; range_end:; response_count:1; response_revision:1895; }","duration":"313.611091ms","start":"2026-10-07T03:41:58.375318Z","end":"2026-10-07T03:41:58.688929Z","steps":["trace[1627851647] 'agreement among raft nodes before linearized reading'  (duration: 313.306888ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:58.689248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T03:41:58.375308Z","time spent":"313.924255ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1004,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18dc2258c4261e5b\" "}
{"level":"info","ts":"2026-10-07T03:41:58.70665Z","caller":"traceutil/trace.go:171","msg":"trace[2108269772] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"296.304094ms","start":"2026-10-07T03:41:58.410321Z","end":"2026-10-07T03:41:58.706625Z","steps":["trace[2108269772] 'process raft request'  (duration: 296.135682ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:58.706813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.614357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-10-07T03:41:58.706893Z","caller":"traceutil/trace.go:171","msg":"trace[33786351] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1896; }","duration":"149.741918ms","start":"2026-10-07T03:41:58.557132Z","end":"2026-10-07T03:41:58.706874Z","steps":["trace[33786351] 'agreement among raft nodes before linearized reading'  (duration: 149.542406ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:58.706929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.106364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5745bcd6-f5c3-4448-918d-06717853c4ce\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-10-07T03:41:58.707031Z","caller":"traceutil/trace.go:171","msg":"trace[1355349153] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5745bcd6-f5c3-4448-918d-06717853c4ce; range_end:; response_count:1; response_revision:1896; }","duration":"230.215875ms","start":"2026-10-07T03:41:58.476797Z","end":"2026-10-07T03:41:58.707013Z","steps":["trace[1355349153] 'agreement among raft nodes before linearized reading'  (duration: 229.932101ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:41:58.707129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.631002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-07T03:41:58.7072Z","caller":"traceutil/trace.go:171","msg":"trace[2086026759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1896; }","duration":"238.169039ms","start":"2026-10-07T03:41:58.468996Z","end":"2026-10-07T03:41:58.707165Z","steps":["trace[2086026759] 'agreement among raft nodes before linearized reading'  (duration: 237.614292ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:42:10.904787Z","caller":"traceutil/trace.go:171","msg":"trace[622640596] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"133.95989ms","start":"2026-10-07T03:42:10.770801Z","end":"2026-10-07T03:42:10.904761Z","steps":["trace[622640596] 'process raft request'  (duration: 133.800998ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:42:26.80506Z","caller":"traceutil/trace.go:171","msg":"trace[2101345738] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"125.154427ms","start":"2026-10-07T03:42:26.679886Z","end":"2026-10-07T03:42:26.80504Z","steps":["trace[2101345738] 'process raft request'  (duration: 125.045085ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:42:32.515117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.269969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"}
{"level":"info","ts":"2026-10-07T03:42:32.515228Z","caller":"traceutil/trace.go:171","msg":"trace[1628470665] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2132; }","duration":"117.411971ms","start":"2026-10-07T03:42:32.397775Z","end":"2026-10-07T03:42:32.515187Z","steps":["trace[1628470665] 'range keys from in-memory index tree'  (duration: 117.129838ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:42:33.423079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.378317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2683478062165643561 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2125 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-07T03:42:33.423455Z","caller":"traceutil/trace.go:171","msg":"trace[1645827746] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"185.82662ms","start":"2026-10-07T03:42:33.237588Z","end":"2026-10-07T03:42:33.423415Z","steps":["trace[1645827746] 'process raft request'  (duration: 41.029667ms)","trace[1645827746] 'compare'  (duration: 144.263736ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:42:33.725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.188455ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2683478062165643563 > lease_revoke:<id:253da11471efd054>","response":"size:27"}
{"level":"info","ts":"2026-10-07T03:42:33.725128Z","caller":"traceutil/trace.go:171","msg":"trace[371043406] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"217.044162ms","start":"2026-10-07T03:42:33.508062Z","end":"2026-10-07T03:42:33.725106Z","steps":["trace[371043406] 'read index received'  (duration: 41.687674ms)","trace[371043406] 'applied index is now lower than readState.Index'  (duration: 175.354898ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:42:33.725531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.455218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-10-07T03:42:33.72561Z","caller":"traceutil/trace.go:171","msg":"trace[1309335569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2138; }","duration":"217.578689ms","start":"2026-10-07T03:42:33.508011Z","end":"2026-10-07T03:42:33.72559Z","steps":["trace[1309335569] 'agreement among raft nodes before linearized reading'  (duration: 217.329316ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:42:33.726201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.157911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-10-07T03:42:33.726233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.472955ms","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-07T03:42:33.7263Z","caller":"traceutil/trace.go:171","msg":"trace[467113291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2138; }","duration":"108.254092ms","start":"2026-10-07T03:42:33.617986Z","end":"2026-10-07T03:42:33.72624Z","steps":["trace[467113291] 'agreement among raft nodes before linearized reading'  (duration: 108.08304ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:42:33.72642Z","caller":"traceutil/trace.go:171","msg":"trace[1056156754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2138; }","duration":"100.679668ms","start":"2026-10-07T03:42:33.625727Z","end":"2026-10-07T03:42:33.726407Z","steps":["trace[1056156754] 'agreement among raft nodes before linearized reading'  (duration: 100.406784ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:42:33.87011Z","caller":"traceutil/trace.go:171","msg":"trace[437072959] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"132.771322ms","start":"2026-10-07T03:42:33.737318Z","end":"2026-10-07T03:42:33.87009Z","steps":["trace[437072959] 'process raft request'  (duration: 132.719802ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:42:33.870581Z","caller":"traceutil/trace.go:171","msg":"trace[1077988052] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"133.40752ms","start":"2026-10-07T03:42:33.737159Z","end":"2026-10-07T03:42:33.870567Z","steps":["trace[1077988052] 'process raft request'  (duration: 120.534578ms)","trace[1077988052] 'compare'  (duration: 12.093012ms)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:44:11.041585Z","caller":"traceutil/trace.go:171","msg":"trace[1867303046] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"121.865863ms","start":"2026-10-07T03:44:10.91967Z","end":"2026-10-07T03:44:11.041536Z","steps":["trace[1867303046] 'process raft request'  (duration: 121.289252ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:35.345528Z","caller":"traceutil/trace.go:171","msg":"trace[1898144436] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5007; }","duration":"130.597004ms","start":"2026-10-07T03:48:35.214905Z","end":"2026-10-07T03:48:35.345502Z","steps":["trace[1898144436] 'read index received'  (duration: 130.472372ms)","trace[1898144436] 'applied index is now lower than readState.Index'  (duration: 123.702µs)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:48:35.345641Z","caller":"traceutil/trace.go:171","msg":"trace[1848171353] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"172.346667ms","start":"2026-10-07T03:48:35.173248Z","end":"2026-10-07T03:48:35.345594Z","steps":["trace[1848171353] 'process raft request'  (duration: 172.101303ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:48:35.345751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.840698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"}
{"level":"info","ts":"2026-10-07T03:48:35.345796Z","caller":"traceutil/trace.go:171","msg":"trace[1605902050] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4818; }","duration":"130.924419ms","start":"2026-10-07T03:48:35.214858Z","end":"2026-10-07T03:48:35.345782Z","steps":["trace[1605902050] 'agreement among raft nodes before linearized reading'  (duration: 130.744846ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:35.38649Z","caller":"traceutil/trace.go:171","msg":"trace[951743860] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"151.117364ms","start":"2026-10-07T03:48:35.235336Z","end":"2026-10-07T03:48:35.386453Z","steps":["trace[951743860] 'process raft request'  (duration: 150.994732ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:35.456466Z","caller":"traceutil/trace.go:171","msg":"trace[1064629096] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"105.479846ms","start":"2026-10-07T03:48:35.350945Z","end":"2026-10-07T03:48:35.456424Z","steps":["trace[1064629096] 'process raft request'  (duration: 87.958257ms)","trace[1064629096] 'compare'  (duration: 16.672807ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:48:35.456629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.685949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-07T03:48:35.456719Z","caller":"traceutil/trace.go:171","msg":"trace[1850653901] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4820; }","duration":"107.82417ms","start":"2026-10-07T03:48:35.348873Z","end":"2026-10-07T03:48:35.456697Z","steps":["trace[1850653901] 'agreement among raft nodes before linearized reading'  (duration: 107.516636ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:48:35.45703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.830399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-fg9tg-tls\" ","response":"range_response_count:1 size:2129"}
{"level":"warn","ts":"2026-10-07T03:48:35.456888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.190241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-07T03:48:35.457301Z","caller":"traceutil/trace.go:171","msg":"trace[1739936287] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-fg9tg-tls; range_end:; response_count:1; response_revision:4820; }","duration":"103.136854ms","start":"2026-10-07T03:48:35.354142Z","end":"2026-10-07T03:48:35.457279Z","steps":["trace[1739936287] 'agreement among raft nodes before linearized reading'  (duration: 102.254521ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:35.457315Z","caller":"traceutil/trace.go:171","msg":"trace[144517150] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4820; }","duration":"107.671978ms","start":"2026-10-07T03:48:35.349624Z","end":"2026-10-07T03:48:35.457296Z","steps":["trace[144517150] 'agreement among raft nodes before linearized reading'  (duration: 107.028209ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:41.834879Z","caller":"traceutil/trace.go:171","msg":"trace[1020971245] linearizableReadLoop","detail":"{readStateIndex:5156; appliedIndex:5155; }","duration":"108.246763ms","start":"2026-10-07T03:48:41.726614Z","end":"2026-10-07T03:48:41.83486Z","steps":["trace[1020971245] 'read index received'  (duration: 108.07031ms)","trace[1020971245] 'applied index is now lower than readState.Index'  (duration: 175.843µs)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:48:41.834993Z","caller":"traceutil/trace.go:171","msg":"trace[355396760] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"115.354573ms","start":"2026-10-07T03:48:41.719629Z","end":"2026-10-07T03:48:41.834984Z","steps":["trace[355396760] 'process raft request'  (duration: 115.100909ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:48:41.835244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.616187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-07T03:48:41.835273Z","caller":"traceutil/trace.go:171","msg":"trace[519419649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4963; }","duration":"108.682798ms","start":"2026-10-07T03:48:41.726582Z","end":"2026-10-07T03:48:41.835265Z","steps":["trace[519419649] 'agreement among raft nodes before linearized reading'  (duration: 108.576307ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-07T03:48:41.835436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.716104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-10-07T03:48:41.835522Z","caller":"traceutil/trace.go:171","msg":"trace[1788417270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4963; }","duration":"107.829535ms","start":"2026-10-07T03:48:41.727673Z","end":"2026-10-07T03:48:41.835503Z","steps":["trace[1788417270] 'agreement among raft nodes before linearized reading'  (duration: 107.603532ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:45.234232Z","caller":"traceutil/trace.go:171","msg":"trace[1670419748] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5015; }","duration":"127.491861ms","start":"2026-10-07T03:48:45.10649Z","end":"2026-10-07T03:48:45.233982Z","steps":["trace[1670419748] 'process raft request'  (duration: 31.623787ms)","trace[1670419748] 'compare'  (duration: 95.623381ms)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:48:55.300244Z","caller":"traceutil/trace.go:171","msg":"trace[205563002] linearizableReadLoop","detail":"{readStateIndex:5350; appliedIndex:5349; }","duration":"111.405328ms","start":"2026-10-07T03:48:55.188813Z","end":"2026-10-07T03:48:55.300218Z","steps":["trace[205563002] 'read index received'  (duration: 90.840208ms)","trace[205563002] 'applied index is now lower than readState.Index'  (duration: 20.56424ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-07T03:48:55.300461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.627971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-10-07T03:48:55.300499Z","caller":"traceutil/trace.go:171","msg":"trace[45099392] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5151; }","duration":"111.716602ms","start":"2026-10-07T03:48:55.188768Z","end":"2026-10-07T03:48:55.300485Z","steps":["trace[45099392] 'agreement among raft nodes before linearized reading'  (duration: 111.54987ms)"],"step_count":1}
{"level":"info","ts":"2026-10-07T03:48:55.300606Z","caller":"traceutil/trace.go:171","msg":"trace[558367525] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"112.91836ms","start":"2026-10-07T03:48:55.18766Z","end":"2026-10-07T03:48:55.300579Z","steps":["trace[558367525] 'process raft request'  (duration: 92.051906ms)","trace[558367525] 'compare'  (duration: 20.392317ms)"],"step_count":2}
{"level":"info","ts":"2026-10-07T03:49:34.722585Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897}
{"level":"info","ts":"2026-10-07T03:49:34.834987Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"111.199356ms","hash":357875871,"current-db-size-bytes":52375552,"current-db-size":"52 MB","current-db-size-in-use-bytes":28340224,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-07T03:49:34.835051Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":357875871,"revision":2897,"compact-revision":-1}
{"level":"info","ts":"2026-10-07T03:54:34.729198Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5488}
{"level":"info","ts":"2026-10-07T03:54:34.837056Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5488,"took":"106.269716ms","hash":3847741054,"current-db-size-bytes":52375552,"current-db-size":"52 MB","current-db-size-in-use-bytes":18579456,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-07T03:54:34.837107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3847741054,"revision":5488,"compact-revision":2897}