{"level":"warn","ts":"2026-10-09T05:12:53.854035Z","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:53.854125Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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:53.854189Z","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:53.854215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-10-09T05:12:53.854232Z","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:53.854848Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-10-09T05:12:53.854914Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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:53.859064Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.929965ms"} {"level":"info","ts":"2026-10-09T05:12:53.871291Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-10-09T05:12:53.871384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T05:12:53.871407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-10-09T05:12:53.871418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T05:12:53.871425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-10-09T05:12:53.87146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-10-09T05:12:53.883746Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T05:12:53.885079Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T05:12:53.886079Z","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:53.887916Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T05:12:53.888084Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T05:12:53.888304Z","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:53.888425Z","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:53.889828Z","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:53.893501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-10-09T05:12:53.893513Z","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:53.893681Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T05:12:53.893707Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T05:12:53.893803Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-10-09T05:12:53.893814Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-10-09T05:12:53.89394Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-10-09T05:12:54.373478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T05:12:54.373549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T05:12:54.373592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-10-09T05:12:54.373615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-10-09T05:12:54.373634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-10-09T05:12:54.37365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-10-09T05:12:54.37367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-10-09T05:12:54.375108Z","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:54.3776Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T05:12:54.377967Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T05:12:54.377603Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T05:12:54.378701Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T05:12:54.378735Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T05:12:54.380835Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-10-09T05:12:54.381628Z","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:54.384375Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:12:54.384514Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:12:54.384547Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:13:45.069362Z","caller":"traceutil/trace.go:171","msg":"trace[1462683527] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"210.304481ms","start":"2026-10-09T05:13:44.859002Z","end":"2026-10-09T05:13:45.069307Z","steps":["trace[1462683527] 'process raft request' (duration: 204.426277ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:13:45.885791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.948837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T05:13:45.886031Z","caller":"traceutil/trace.go:171","msg":"trace[1831900218] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"484.168044ms","start":"2026-10-09T05:13:45.401842Z","end":"2026-10-09T05:13:45.88601Z","steps":["trace[1831900218] 'read index received' (duration: 84.141µs)","trace[1831900218] 'applied index is now lower than readState.Index' (duration: 484.082873ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:13:45.886071Z","caller":"traceutil/trace.go:171","msg":"trace[1222695713] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"806.680739ms","start":"2026-10-09T05:13:45.079324Z","end":"2026-10-09T05:13:45.886005Z","steps":["trace[1222695713] 'process raft request' (duration: 192.90317ms)","trace[1222695713] 'compare' (duration: 612.713464ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:13:45.886119Z","caller":"traceutil/trace.go:171","msg":"trace[898296230] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"746.986593ms","start":"2026-10-09T05:13:45.13909Z","end":"2026-10-09T05:13:45.886077Z","steps":["trace[898296230] 'process raft request' (duration: 746.843861ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:13:45.886223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.360076ms","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-09T05:13:45.886252Z","caller":"traceutil/trace.go:171","msg":"trace[1899330109] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"484.466218ms","start":"2026-10-09T05:13:45.401777Z","end":"2026-10-09T05:13:45.886243Z","steps":["trace[1899330109] 'agreement among raft nodes before linearized reading' (duration: 484.284585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:13:45.886294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:13:45.40175Z","time spent":"484.535159ms","remote":"127.0.0.1:33880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-09T05:13:45.886335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:13:45.13906Z","time spent":"747.179336ms","remote":"127.0.0.1:33982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T05:13:45.886339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:13:45.079291Z","time spent":"806.930913ms","remote":"127.0.0.1:33880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T05:13:47.003462Z","caller":"traceutil/trace.go:171","msg":"trace[1037369138] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"119.014583ms","start":"2026-10-09T05:13:46.884379Z","end":"2026-10-09T05:13:47.003393Z","steps":["trace[1037369138] 'process raft request' (duration: 117.660925ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:13:47.005566Z","caller":"traceutil/trace.go:171","msg":"trace[1296975192] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"121.118943ms","start":"2026-10-09T05:13:46.884402Z","end":"2026-10-09T05:13:47.005521Z","steps":["trace[1296975192] 'process raft request' (duration: 120.85922ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:13:47.005821Z","caller":"traceutil/trace.go:171","msg":"trace[529955818] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"119.640732ms","start":"2026-10-09T05:13:46.886107Z","end":"2026-10-09T05:13:47.005747Z","steps":["trace[529955818] 'process raft request' (duration: 119.355638ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:13:47.005591Z","caller":"traceutil/trace.go:171","msg":"trace[739990319] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"120.90051ms","start":"2026-10-09T05:13:46.884631Z","end":"2026-10-09T05:13:47.005531Z","steps":["trace[739990319] 'process raft request' (duration: 120.782949ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:14:01.998401Z","caller":"traceutil/trace.go:171","msg":"trace[1506503883] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"159.574332ms","start":"2026-10-09T05:14:01.838797Z","end":"2026-10-09T05:14:01.998371Z","steps":["trace[1506503883] 'process raft request' (duration: 159.319869ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:14:14.346748Z","caller":"traceutil/trace.go:171","msg":"trace[359257006] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"131.455521ms","start":"2026-10-09T05:14:14.215255Z","end":"2026-10-09T05:14:14.34671Z","steps":["trace[359257006] 'process raft request' (duration: 123.379704ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:14:14.346793Z","caller":"traceutil/trace.go:171","msg":"trace[916881700] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"126.699664ms","start":"2026-10-09T05:14:14.220052Z","end":"2026-10-09T05:14:14.346752Z","steps":["trace[916881700] 'process raft request' (duration: 126.551352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:14:35.408997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.128313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-10-09T05:14:35.409116Z","caller":"traceutil/trace.go:171","msg":"trace[1962225559] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1227; }","duration":"143.323706ms","start":"2026-10-09T05:14:35.265764Z","end":"2026-10-09T05:14:35.409088Z","steps":["trace[1962225559] 'range keys from in-memory index tree' (duration: 142.400555ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:27.438816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.975712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a5d1173-5496-4c50-96aa-0d188c895c56\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-09T05:15:27.438904Z","caller":"traceutil/trace.go:171","msg":"trace[1403784149] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a5d1173-5496-4c50-96aa-0d188c895c56; range_end:; response_count:1; response_revision:1907; }","duration":"139.116663ms","start":"2026-10-09T05:15:27.299766Z","end":"2026-10-09T05:15:27.438883Z","steps":["trace[1403784149] 'range keys from in-memory index tree' (duration: 138.76171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:27.438833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.600943ms","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:27.439014Z","caller":"traceutil/trace.go:171","msg":"trace[1308678922] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1907; }","duration":"169.822305ms","start":"2026-10-09T05:15:27.269175Z","end":"2026-10-09T05:15:27.438997Z","steps":["trace[1308678922] 'range keys from in-memory index tree' (duration: 169.350351ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:27.933887Z","caller":"traceutil/trace.go:171","msg":"trace[1301560273] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"153.075105ms","start":"2026-10-09T05:15:27.78078Z","end":"2026-10-09T05:15:27.933855Z","steps":["trace[1301560273] 'read index received' (duration: 136.600009ms)","trace[1301560273] 'applied index is now lower than readState.Index' (duration: 16.473176ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:15:27.934015Z","caller":"traceutil/trace.go:171","msg":"trace[780834903] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"257.068095ms","start":"2026-10-09T05:15:27.676928Z","end":"2026-10-09T05:15:27.933996Z","steps":["trace[780834903] 'process raft request' (duration: 240.436677ms)","trace[780834903] 'compare' (duration: 16.005411ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:15:27.9344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.60514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a5d1173-5496-4c50-96aa-0d188c895c56\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-10-09T05:15:27.934454Z","caller":"traceutil/trace.go:171","msg":"trace[325624592] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a5d1173-5496-4c50-96aa-0d188c895c56; range_end:; response_count:1; response_revision:1910; }","duration":"153.727642ms","start":"2026-10-09T05:15:27.78071Z","end":"2026-10-09T05:15:27.934438Z","steps":["trace[325624592] 'agreement among raft nodes before linearized reading' (duration: 153.53905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:27.936344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.53945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T05:15:27.936416Z","caller":"traceutil/trace.go:171","msg":"trace[1681363200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1911; }","duration":"132.638331ms","start":"2026-10-09T05:15:27.803759Z","end":"2026-10-09T05:15:27.936398Z","steps":["trace[1681363200] 'agreement among raft nodes before linearized reading' (duration: 132.52367ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:27.936364Z","caller":"traceutil/trace.go:171","msg":"trace[1248163867] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"145.657925ms","start":"2026-10-09T05:15:27.790685Z","end":"2026-10-09T05:15:27.936343Z","steps":["trace[1248163867] 'process raft request' (duration: 145.499224ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:39.14239Z","caller":"traceutil/trace.go:171","msg":"trace[1444377422] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"135.625143ms","start":"2026-10-09T05:15:39.006733Z","end":"2026-10-09T05:15:39.142358Z","steps":["trace[1444377422] 'process raft request' (duration: 135.456321ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:17:38.777868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.048097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-10-09T05:17:38.77856Z","caller":"traceutil/trace.go:171","msg":"trace[260461635] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2776; }","duration":"174.755613ms","start":"2026-10-09T05:17:38.603749Z","end":"2026-10-09T05:17:38.778505Z","steps":["trace[260461635] 'range keys from in-memory index tree' (duration: 173.882862ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:17:44.163779Z","caller":"traceutil/trace.go:171","msg":"trace[634929893] linearizableReadLoop","detail":"{readStateIndex:2911; appliedIndex:2910; }","duration":"128.145107ms","start":"2026-10-09T05:17:44.035604Z","end":"2026-10-09T05:17:44.163749Z","steps":["trace[634929893] 'read index received' (duration: 127.981384ms)","trace[634929893] 'applied index is now lower than readState.Index' (duration: 162.363µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:17:44.164087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.403813ms","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:17:44.164129Z","caller":"traceutil/trace.go:171","msg":"trace[575570426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2804; }","duration":"128.578657ms","start":"2026-10-09T05:17:44.03554Z","end":"2026-10-09T05:17:44.164119Z","steps":["trace[575570426] 'agreement among raft nodes before linearized reading' (duration: 128.309361ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:17:44.16418Z","caller":"traceutil/trace.go:171","msg":"trace[1827182110] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"135.068045ms","start":"2026-10-09T05:17:44.029053Z","end":"2026-10-09T05:17:44.164121Z","steps":["trace[1827182110] 'process raft request' (duration: 134.561663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:17:44.336936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.896334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T05:17:44.337117Z","caller":"traceutil/trace.go:171","msg":"trace[2010255346] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"167.651692ms","start":"2026-10-09T05:17:44.169426Z","end":"2026-10-09T05:17:44.337078Z","steps":["trace[2010255346] 'process raft request' (duration: 31.41075ms)","trace[2010255346] 'compare' (duration: 135.419074ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:22:31.614947Z","caller":"traceutil/trace.go:171","msg":"trace[585215860] linearizableReadLoop","detail":"{readStateIndex:5260; appliedIndex:5259; }","duration":"120.861221ms","start":"2026-10-09T05:22:31.494061Z","end":"2026-10-09T05:22:31.614923Z","steps":["trace[585215860] 'read index received' (duration: 120.7247ms)","trace[585215860] 'applied index is now lower than readState.Index' (duration: 135.371µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:22:31.615131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.047493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-09T05:22:31.615163Z","caller":"traceutil/trace.go:171","msg":"trace[1602847229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5067; }","duration":"121.115155ms","start":"2026-10-09T05:22:31.494038Z","end":"2026-10-09T05:22:31.615154Z","steps":["trace[1602847229] 'agreement among raft nodes before linearized reading' (duration: 120.976793ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:22:31.666305Z","caller":"traceutil/trace.go:171","msg":"trace[1800237459] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"169.207327ms","start":"2026-10-09T05:22:31.497071Z","end":"2026-10-09T05:22:31.666278Z","steps":["trace[1800237459] 'process raft request' (duration: 169.035445ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:22:32.074178Z","caller":"traceutil/trace.go:171","msg":"trace[1712570464] linearizableReadLoop","detail":"{readStateIndex:5267; appliedIndex:5265; }","duration":"168.361395ms","start":"2026-10-09T05:22:31.905793Z","end":"2026-10-09T05:22:32.074155Z","steps":["trace[1712570464] 'read index received' (duration: 104.74724ms)","trace[1712570464] 'applied index is now lower than readState.Index' (duration: 63.612905ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:22:32.074236Z","caller":"traceutil/trace.go:171","msg":"trace[2006588555] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"184.901303ms","start":"2026-10-09T05:22:31.889308Z","end":"2026-10-09T05:22:32.07421Z","steps":["trace[2006588555] 'process raft request' (duration: 121.223147ms)","trace[2006588555] 'compare' (duration: 63.427063ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:22:32.074276Z","caller":"traceutil/trace.go:171","msg":"trace[651046840] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"180.401507ms","start":"2026-10-09T05:22:31.893844Z","end":"2026-10-09T05:22:32.074246Z","steps":["trace[651046840] 'process raft request' (duration: 180.259976ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:22:32.074461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.717695ms","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-09T05:22:32.07448Z","caller":"traceutil/trace.go:171","msg":"trace[629514578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5074; }","duration":"142.771255ms","start":"2026-10-09T05:22:31.931704Z","end":"2026-10-09T05:22:32.074475Z","steps":["trace[629514578] 'agreement among raft nodes before linearized reading' (duration: 142.682684ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:22:32.0747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.868262ms","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-09T05:22:32.074781Z","caller":"traceutil/trace.go:171","msg":"trace[2083040712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5074; }","duration":"168.983603ms","start":"2026-10-09T05:22:31.905762Z","end":"2026-10-09T05:22:32.074746Z","steps":["trace[2083040712] 'agreement among raft nodes before linearized reading' (duration: 168.517558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:22:43.931934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.14048ms","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-09T05:22:43.932115Z","caller":"traceutil/trace.go:171","msg":"trace[231196659] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5242; }","duration":"199.267761ms","start":"2026-10-09T05:22:43.732739Z","end":"2026-10-09T05:22:43.932007Z","steps":["trace[231196659] 'range keys from in-memory index tree' (duration: 198.982768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:22:43.932103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.268575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-09T05:22:43.932152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.261419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-09T05:22:43.932175Z","caller":"traceutil/trace.go:171","msg":"trace[997016646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5242; }","duration":"209.398837ms","start":"2026-10-09T05:22:43.722758Z","end":"2026-10-09T05:22:43.932157Z","steps":["trace[997016646] 'range keys from in-memory index tree' (duration: 209.000202ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:22:43.932214Z","caller":"traceutil/trace.go:171","msg":"trace[909476165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5242; }","duration":"190.389901ms","start":"2026-10-09T05:22:43.741808Z","end":"2026-10-09T05:22:43.932198Z","steps":["trace[909476165] 'range keys from in-memory index tree' (duration: 189.993166ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:22:45.052811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.094217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T05:22:45.052934Z","caller":"traceutil/trace.go:171","msg":"trace[1991248617] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"277.059873ms","start":"2026-10-09T05:22:44.775851Z","end":"2026-10-09T05:22:45.052911Z","steps":["trace[1991248617] 'process raft request' (duration: 52.751774ms)","trace[1991248617] 'compare' (duration: 223.942445ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:22:45.052907Z","caller":"traceutil/trace.go:171","msg":"trace[336302819] linearizableReadLoop","detail":"{readStateIndex:5454; appliedIndex:5453; }","duration":"230.534547ms","start":"2026-10-09T05:22:44.822358Z","end":"2026-10-09T05:22:45.052893Z","steps":["trace[336302819] 'read index received' (duration: 6.181857ms)","trace[336302819] 'applied index is now lower than readState.Index' (duration: 224.35088ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:22:45.05325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.886671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-10-09T05:22:45.053291Z","caller":"traceutil/trace.go:171","msg":"trace[2035156320] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5254; }","duration":"230.967133ms","start":"2026-10-09T05:22:44.822312Z","end":"2026-10-09T05:22:45.053279Z","steps":["trace[2035156320] 'agreement among raft nodes before linearized reading' (duration: 230.76987ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:22:54.419573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857} {"level":"info","ts":"2026-10-09T05:22:54.508555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"87.943052ms","hash":2307918776,"current-db-size-bytes":52166656,"current-db-size":"52 MB","current-db-size-in-use-bytes":27455488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-09T05:22:54.50864Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2307918776,"revision":2857,"compact-revision":-1} {"level":"info","ts":"2026-10-09T05:26:45.509952Z","caller":"traceutil/trace.go:171","msg":"trace[592926468] transaction","detail":"{read_only:false; response_revision:7009; number_of_response:1; }","duration":"114.626534ms","start":"2026-10-09T05:26:45.395306Z","end":"2026-10-09T05:26:45.509933Z","steps":["trace[592926468] 'process raft request' (duration: 35.963371ms)","trace[592926468] 'compare' (duration: 78.49703ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:26:45.509952Z","caller":"traceutil/trace.go:171","msg":"trace[1370097544] transaction","detail":"{read_only:false; response_revision:7010; number_of_response:1; }","duration":"114.342689ms","start":"2026-10-09T05:26:45.395592Z","end":"2026-10-09T05:26:45.509935Z","steps":["trace[1370097544] 'process raft request' (duration: 114.293238ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:27:54.428578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5317} {"level":"info","ts":"2026-10-09T05:27:54.509188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5317,"took":"79.340817ms","hash":1020592474,"current-db-size-bytes":52166656,"current-db-size":"52 MB","current-db-size-in-use-bytes":18763776,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-09T05:27:54.509267Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1020592474,"revision":5317,"compact-revision":2857}