{"level":"warn","ts":"2026-05-05T11:18:49.027333Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:18:49.027449Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.219:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.219:2380","--initial-cluster=instance=https://199.19.213.219:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.219:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.219:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-05T11:18:49.027525Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:18:49.027539Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-05-05T11:18:49.027563Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T11:18:49.0282Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"]} {"level":"info","ts":"2026-05-05T11:18:49.028276Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.219:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-05T11:18:49.032606Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.09644ms"} {"level":"info","ts":"2026-05-05T11:18:49.037346Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e142186203fa167","cluster-id":"e7586aea7e662ee6"} {"level":"info","ts":"2026-05-05T11:18:49.037393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T11:18:49.037413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 0"} {"level":"info","ts":"2026-05-05T11:18:49.03743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e142186203fa167 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T11:18:49.037446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 1"} {"level":"info","ts":"2026-05-05T11:18:49.037496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"warn","ts":"2026-05-05T11:18:49.044912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T11:18:49.048068Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T11:18:49.049549Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-05T11:18:49.052697Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e142186203fa167","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T11:18:49.052953Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e142186203fa167","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T11:18:49.053103Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T11:18:49.053157Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T11:18:49.053168Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T11:18:49.053774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"info","ts":"2026-05-05T11:18:49.053947Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","added-peer-id":"7e142186203fa167","added-peer-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-05-05T11:18:49.055956Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T11:18:49.056109Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-05-05T11:18:49.056228Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-05-05T11:18:49.056992Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e142186203fa167","initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T11:18:49.057028Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T11:18:49.639221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T11:18:49.639276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T11:18:49.6393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgPreVoteResp from 7e142186203fa167 at term 1"} {"level":"info","ts":"2026-05-05T11:18:49.639314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became candidate at term 2"} {"level":"info","ts":"2026-05-05T11:18:49.639319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgVoteResp from 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-05-05T11:18:49.639333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became leader at term 2"} {"level":"info","ts":"2026-05-05T11:18:49.639342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e142186203fa167 elected leader 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-05-05T11:18:49.655343Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:18:49.667696Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:18:49.667749Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:18:49.667695Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e142186203fa167","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.219:2379]}","request-path":"/0/members/7e142186203fa167/attributes","cluster-id":"e7586aea7e662ee6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T11:18:49.668093Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T11:18:49.668183Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T11:18:49.668365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:18:49.668501Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:18:49.668541Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:18:49.671145Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T11:18:49.690403Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.219:2379"} {"level":"info","ts":"2026-05-05T11:19:06.556205Z","caller":"traceutil/trace.go:171","msg":"trace[1073661058] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"212.836617ms","start":"2026-05-05T11:19:06.343337Z","end":"2026-05-05T11:19:06.556174Z","steps":["trace[1073661058] 'process raft request' (duration: 212.583601ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:20.248976Z","caller":"traceutil/trace.go:171","msg":"trace[570602644] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"113.465831ms","start":"2026-05-05T11:19:20.135479Z","end":"2026-05-05T11:19:20.248944Z","steps":["trace[570602644] 'process raft request' (duration: 99.326094ms)","trace[570602644] 'compare' (duration: 12.867527ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:19:20.249115Z","caller":"traceutil/trace.go:171","msg":"trace[1675967025] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"106.149554ms","start":"2026-05-05T11:19:20.142954Z","end":"2026-05-05T11:19:20.249103Z","steps":["trace[1675967025] 'process raft request' (duration: 104.881734ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:20.249189Z","caller":"traceutil/trace.go:171","msg":"trace[1278540361] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"100.220358ms","start":"2026-05-05T11:19:20.148962Z","end":"2026-05-05T11:19:20.249182Z","steps":["trace[1278540361] 'process raft request' (duration: 98.917988ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:20.249257Z","caller":"traceutil/trace.go:171","msg":"trace[308401890] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"100.233679ms","start":"2026-05-05T11:19:20.149016Z","end":"2026-05-05T11:19:20.24925Z","steps":["trace[308401890] 'process raft request' (duration: 98.895298ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:26.697725Z","caller":"traceutil/trace.go:171","msg":"trace[221896729] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"316.786183ms","start":"2026-05-05T11:19:26.380907Z","end":"2026-05-05T11:19:26.697693Z","steps":["trace[221896729] 'process raft request' (duration: 316.075133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:19:26.69841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:19:26.380877Z","time spent":"316.935816ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:19:27.019708Z","caller":"traceutil/trace.go:171","msg":"trace[1487914925] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"264.821392ms","start":"2026-05-05T11:19:26.75485Z","end":"2026-05-05T11:19:27.019671Z","steps":["trace[1487914925] 'process raft request' (duration: 264.139483ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:27.020076Z","caller":"traceutil/trace.go:171","msg":"trace[239759895] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"181.249026ms","start":"2026-05-05T11:19:26.838265Z","end":"2026-05-05T11:19:27.019514Z","steps":["trace[239759895] 'read index received' (duration: 180.643888ms)","trace[239759895] 'applied index is now lower than readState.Index' (duration: 603.468µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:19:27.020264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.844825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:19:27.020355Z","caller":"traceutil/trace.go:171","msg":"trace[1267230629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"182.016606ms","start":"2026-05-05T11:19:26.838324Z","end":"2026-05-05T11:19:27.020341Z","steps":["trace[1267230629] 'agreement among raft nodes before linearized reading' (duration: 181.860224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:19:27.020248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.948666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nwgjb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-05T11:19:27.020479Z","caller":"traceutil/trace.go:171","msg":"trace[398758468] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nwgjb; range_end:; response_count:1; response_revision:620; }","duration":"182.25436ms","start":"2026-05-05T11:19:26.8382Z","end":"2026-05-05T11:19:27.020454Z","steps":["trace[398758468] 'agreement among raft nodes before linearized reading' (duration: 181.684782ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:27.202456Z","caller":"traceutil/trace.go:171","msg":"trace[555781082] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"165.325019ms","start":"2026-05-05T11:19:27.037071Z","end":"2026-05-05T11:19:27.202396Z","steps":["trace[555781082] 'process raft request' (duration: 149.606381ms)","trace[555781082] 'compare' (duration: 15.545686ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:19:43.090789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.387187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gsdt7\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-05T11:19:43.090927Z","caller":"traceutil/trace.go:171","msg":"trace[1899534827] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gsdt7; range_end:; response_count:1; response_revision:784; }","duration":"136.610409ms","start":"2026-05-05T11:19:42.954295Z","end":"2026-05-05T11:19:43.090905Z","steps":["trace[1899534827] 'range keys from in-memory index tree' (duration: 136.007813ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:19:43.277713Z","caller":"traceutil/trace.go:171","msg":"trace[115421391] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"177.4758ms","start":"2026-05-05T11:19:43.100212Z","end":"2026-05-05T11:19:43.277688Z","steps":["trace[115421391] 'process raft request' (duration: 177.139447ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:20:59.585767Z","caller":"traceutil/trace.go:171","msg":"trace[1813912180] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"228.949365ms","start":"2026-05-05T11:20:59.356788Z","end":"2026-05-05T11:20:59.585737Z","steps":["trace[1813912180] 'read index received' (duration: 228.647813ms)","trace[1813912180] 'applied index is now lower than readState.Index' (duration: 300.162µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:20:59.586025Z","caller":"traceutil/trace.go:171","msg":"trace[1633907131] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"240.077612ms","start":"2026-05-05T11:20:59.345908Z","end":"2026-05-05T11:20:59.585986Z","steps":["trace[1633907131] 'process raft request' (duration: 239.498359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:20:59.586103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.282908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2d3bd33-6676-47dd-9f73-8f6f5a822a10\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-05T11:20:59.586177Z","caller":"traceutil/trace.go:171","msg":"trace[1717010552] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2d3bd33-6676-47dd-9f73-8f6f5a822a10; range_end:; response_count:1; response_revision:1844; }","duration":"229.423713ms","start":"2026-05-05T11:20:59.356734Z","end":"2026-05-05T11:20:59.586158Z","steps":["trace[1717010552] 'agreement among raft nodes before linearized reading' (duration: 229.122241ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:05.534547Z","caller":"traceutil/trace.go:171","msg":"trace[393701518] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"108.491176ms","start":"2026-05-05T11:21:05.426021Z","end":"2026-05-05T11:21:05.534512Z","steps":["trace[393701518] 'process raft request' (duration: 108.077032ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:42.196668Z","caller":"traceutil/trace.go:171","msg":"trace[1597504495] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"158.355531ms","start":"2026-05-05T11:21:42.038275Z","end":"2026-05-05T11:21:42.19663Z","steps":["trace[1597504495] 'process raft request' (duration: 158.144866ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:42.391304Z","caller":"traceutil/trace.go:171","msg":"trace[1978439073] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2253; }","duration":"182.241347ms","start":"2026-05-05T11:21:42.209037Z","end":"2026-05-05T11:21:42.391278Z","steps":["trace[1978439073] 'read index received' (duration: 93.547186ms)","trace[1978439073] 'applied index is now lower than readState.Index' (duration: 88.692801ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:42.391447Z","caller":"traceutil/trace.go:171","msg":"trace[1795405246] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"190.110753ms","start":"2026-05-05T11:21:42.201322Z","end":"2026-05-05T11:21:42.391433Z","steps":["trace[1795405246] 'process raft request' (duration: 101.224427ms)","trace[1795405246] 'compare' (duration: 88.483195ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:42.391726Z","caller":"traceutil/trace.go:171","msg":"trace[782252549] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"189.081779ms","start":"2026-05-05T11:21:42.202609Z","end":"2026-05-05T11:21:42.391691Z","steps":["trace[782252549] 'process raft request' (duration: 188.585407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:42.391821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.126872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T11:21:42.39187Z","caller":"traceutil/trace.go:171","msg":"trace[945770199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2185; }","duration":"103.235296ms","start":"2026-05-05T11:21:42.288621Z","end":"2026-05-05T11:21:42.391856Z","steps":["trace[945770199] 'agreement among raft nodes before linearized reading' (duration: 103.043081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:42.39193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.836211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"warn","ts":"2026-05-05T11:21:42.392005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.688609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T11:21:42.39204Z","caller":"traceutil/trace.go:171","msg":"trace[86145324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2185; }","duration":"101.756631ms","start":"2026-05-05T11:21:42.290275Z","end":"2026-05-05T11:21:42.392032Z","steps":["trace[86145324] 'agreement among raft nodes before linearized reading' (duration: 101.622658ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:42.392047Z","caller":"traceutil/trace.go:171","msg":"trace[1380119612] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2185; }","duration":"183.025555ms","start":"2026-05-05T11:21:42.20899Z","end":"2026-05-05T11:21:42.392015Z","steps":["trace[1380119612] 'agreement among raft nodes before linearized reading' (duration: 182.640266ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:22:24.85926Z","caller":"traceutil/trace.go:171","msg":"trace[762325205] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"142.768862ms","start":"2026-05-05T11:22:24.716463Z","end":"2026-05-05T11:22:24.859231Z","steps":["trace[762325205] 'process raft request' (duration: 142.401866ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:22:51.995834Z","caller":"traceutil/trace.go:171","msg":"trace[959496785] linearizableReadLoop","detail":"{readStateIndex:2868; appliedIndex:2867; }","duration":"156.499397ms","start":"2026-05-05T11:22:51.839297Z","end":"2026-05-05T11:22:51.995797Z","steps":["trace[959496785] 'read index received' (duration: 156.310675ms)","trace[959496785] 'applied index is now lower than readState.Index' (duration: 187.312µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:22:51.995909Z","caller":"traceutil/trace.go:171","msg":"trace[1847925160] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"223.819079ms","start":"2026-05-05T11:22:51.772047Z","end":"2026-05-05T11:22:51.995866Z","steps":["trace[1847925160] 'process raft request' (duration: 223.539945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:22:51.996039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.71657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:22:51.996407Z","caller":"traceutil/trace.go:171","msg":"trace[679829573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2766; }","duration":"157.084495ms","start":"2026-05-05T11:22:51.839288Z","end":"2026-05-05T11:22:51.996372Z","steps":["trace[679829573] 'agreement among raft nodes before linearized reading' (duration: 156.69157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:22:52.304625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.596059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-05T11:22:52.304711Z","caller":"traceutil/trace.go:171","msg":"trace[1409515569] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2766; }","duration":"133.714371ms","start":"2026-05-05T11:22:52.170976Z","end":"2026-05-05T11:22:52.30469Z","steps":["trace[1409515569] 'range keys from in-memory index tree' (duration: 133.345025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:22:52.304636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.161906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-05-05T11:22:52.304936Z","caller":"traceutil/trace.go:171","msg":"trace[110956978] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2766; }","duration":"205.506432ms","start":"2026-05-05T11:22:52.099405Z","end":"2026-05-05T11:22:52.304912Z","steps":["trace[110956978] 'range keys from in-memory index tree' (duration: 204.945984ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:22:52.487306Z","caller":"traceutil/trace.go:171","msg":"trace[1051479786] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"131.721793ms","start":"2026-05-05T11:22:52.355549Z","end":"2026-05-05T11:22:52.48727Z","steps":["trace[1051479786] 'process raft request' (duration: 59.82029ms)","trace[1051479786] 'compare' (duration: 71.745561ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:25:36.485793Z","caller":"traceutil/trace.go:171","msg":"trace[1028663801] transaction","detail":"{read_only:false; response_revision:4566; number_of_response:1; }","duration":"160.289758ms","start":"2026-05-05T11:25:36.325478Z","end":"2026-05-05T11:25:36.485768Z","steps":["trace[1028663801] 'process raft request' (duration: 151.832867ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:36.485793Z","caller":"traceutil/trace.go:171","msg":"trace[2128441968] transaction","detail":"{read_only:false; response_revision:4567; number_of_response:1; }","duration":"160.192636ms","start":"2026-05-05T11:25:36.325578Z","end":"2026-05-05T11:25:36.48577Z","steps":["trace[2128441968] 'process raft request' (duration: 160.119563ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:37.056643Z","caller":"traceutil/trace.go:171","msg":"trace[431788415] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"146.104692ms","start":"2026-05-05T11:25:36.910516Z","end":"2026-05-05T11:25:37.056621Z","steps":["trace[431788415] 'process raft request' (duration: 146.02263ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:37.057329Z","caller":"traceutil/trace.go:171","msg":"trace[1470848931] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"148.234438ms","start":"2026-05-05T11:25:36.909076Z","end":"2026-05-05T11:25:37.05731Z","steps":["trace[1470848931] 'process raft request' (duration: 147.389733ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:37.05751Z","caller":"traceutil/trace.go:171","msg":"trace[1314093821] linearizableReadLoop","detail":"{readStateIndex:4768; appliedIndex:4768; }","duration":"138.593549ms","start":"2026-05-05T11:25:36.918863Z","end":"2026-05-05T11:25:37.057457Z","steps":["trace[1314093821] 'read index received' (duration: 138.572748ms)","trace[1314093821] 'applied index is now lower than readState.Index' (duration: 12.861µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:25:37.057506Z","caller":"traceutil/trace.go:171","msg":"trace[495009567] transaction","detail":"{read_only:false; response_revision:4574; number_of_response:1; }","duration":"148.603449ms","start":"2026-05-05T11:25:36.90889Z","end":"2026-05-05T11:25:37.057494Z","steps":["trace[495009567] 'process raft request' (duration: 147.489595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:37.05792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.009092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-05T11:25:37.058184Z","caller":"traceutil/trace.go:171","msg":"trace[883231731] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4576; }","duration":"139.136507ms","start":"2026-05-05T11:25:36.918836Z","end":"2026-05-05T11:25:37.057972Z","steps":["trace[883231731] 'agreement among raft nodes before linearized reading' (duration: 138.846857ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:37.05899Z","caller":"traceutil/trace.go:171","msg":"trace[743660459] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"150.326833ms","start":"2026-05-05T11:25:36.908641Z","end":"2026-05-05T11:25:37.058968Z","steps":["trace[743660459] 'process raft request' (duration: 147.524096ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:37.076673Z","caller":"traceutil/trace.go:171","msg":"trace[477718456] transaction","detail":"{read_only:false; response_revision:4577; number_of_response:1; }","duration":"151.912738ms","start":"2026-05-05T11:25:36.92472Z","end":"2026-05-05T11:25:37.076632Z","steps":["trace[477718456] 'process raft request' (duration: 151.689322ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:43.047937Z","caller":"traceutil/trace.go:171","msg":"trace[663998915] linearizableReadLoop","detail":"{readStateIndex:4909; appliedIndex:4908; }","duration":"224.89827ms","start":"2026-05-05T11:25:42.823009Z","end":"2026-05-05T11:25:43.047907Z","steps":["trace[663998915] 'read index received' (duration: 224.646503ms)","trace[663998915] 'applied index is now lower than readState.Index' (duration: 250.157µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:25:43.048049Z","caller":"traceutil/trace.go:171","msg":"trace[2115554480] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"368.951165ms","start":"2026-05-05T11:25:42.679066Z","end":"2026-05-05T11:25:43.048017Z","steps":["trace[2115554480] 'process raft request' (duration: 368.648526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:43.048199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:25:42.679045Z","time spent":"369.078919ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2585,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T11:25:43.048511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.486708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.219\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T11:25:43.048584Z","caller":"traceutil/trace.go:171","msg":"trace[513054939] range","detail":"{range_begin:/registry/masterleases/199.19.213.219; range_end:; response_count:1; response_revision:4714; }","duration":"225.607312ms","start":"2026-05-05T11:25:42.82296Z","end":"2026-05-05T11:25:43.048567Z","steps":["trace[513054939] 'agreement among raft nodes before linearized reading' (duration: 225.103627ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:43.063429Z","caller":"traceutil/trace.go:171","msg":"trace[443166464] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"234.723314ms","start":"2026-05-05T11:25:42.828678Z","end":"2026-05-05T11:25:43.063401Z","steps":["trace[443166464] 'process raft request' (duration: 234.483717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:43.063475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.987002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-05-05T11:25:43.063466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.885003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3732432d-dad4-4d4a-a6ab-2ec8d119c6b4\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-05-05T11:25:43.063488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.148036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:25:43.063532Z","caller":"traceutil/trace.go:171","msg":"trace[183797774] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4715; }","duration":"120.076514ms","start":"2026-05-05T11:25:42.943443Z","end":"2026-05-05T11:25:43.06352Z","steps":["trace[183797774] 'agreement among raft nodes before linearized reading' (duration: 119.952281ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:43.06355Z","caller":"traceutil/trace.go:171","msg":"trace[1897960396] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3732432d-dad4-4d4a-a6ab-2ec8d119c6b4; range_end:; response_count:1; response_revision:4715; }","duration":"172.008087ms","start":"2026-05-05T11:25:42.891527Z","end":"2026-05-05T11:25:43.063535Z","steps":["trace[1897960396] 'agreement among raft nodes before linearized reading' (duration: 171.807101ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:25:43.063562Z","caller":"traceutil/trace.go:171","msg":"trace[2015108588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4715; }","duration":"228.251538ms","start":"2026-05-05T11:25:42.835296Z","end":"2026-05-05T11:25:43.063548Z","steps":["trace[2015108588] 'agreement among raft nodes before linearized reading' (duration: 228.117344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:25:43.063485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.774035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3732432d-dad4-4d4a-a6ab-2ec8d119c6b4\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-05T11:25:43.0639Z","caller":"traceutil/trace.go:171","msg":"trace[538891363] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3732432d-dad4-4d4a-a6ab-2ec8d119c6b4; range_end:; response_count:1; response_revision:4715; }","duration":"240.203868ms","start":"2026-05-05T11:25:42.82366Z","end":"2026-05-05T11:25:43.063864Z","steps":["trace[538891363] 'agreement among raft nodes before linearized reading' (duration: 239.703953ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:28:49.811064Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3249} {"level":"info","ts":"2026-05-05T11:28:49.908404Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3249,"took":"95.645642ms","hash":1529034788,"current-db-size-bytes":58548224,"current-db-size":"58 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-05T11:28:49.908664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1529034788,"revision":3249,"compact-revision":-1} {"level":"info","ts":"2026-05-05T11:29:25.813115Z","caller":"traceutil/trace.go:171","msg":"trace[282955873] linearizableReadLoop","detail":"{readStateIndex:6990; appliedIndex:6989; }","duration":"103.038991ms","start":"2026-05-05T11:29:25.710054Z","end":"2026-05-05T11:29:25.813093Z","steps":["trace[282955873] 'read index received' (duration: 57.177399ms)","trace[282955873] 'applied index is now lower than readState.Index' (duration: 45.860592ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:29:25.813223Z","caller":"traceutil/trace.go:171","msg":"trace[1397817843] transaction","detail":"{read_only:false; response_revision:6698; number_of_response:1; }","duration":"110.250353ms","start":"2026-05-05T11:29:25.702962Z","end":"2026-05-05T11:29:25.813213Z","steps":["trace[1397817843] 'process raft request' (duration: 64.31423ms)","trace[1397817843] 'compare' (duration: 45.70135ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:29:25.813369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.305775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-05-05T11:29:25.813402Z","caller":"traceutil/trace.go:171","msg":"trace[1291025710] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6698; }","duration":"103.441737ms","start":"2026-05-05T11:29:25.709951Z","end":"2026-05-05T11:29:25.813393Z","steps":["trace[1291025710] 'agreement among raft nodes before linearized reading' (duration: 103.339995ms)"],"step_count":1}