{"level":"warn","ts":"2026-04-22T18:20:05.996524Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T18:20:05.996643Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-22T18:20:05.996727Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T18:20:05.996743Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-22T18:20:05.996764Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T18:20:05.997439Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-22T18:20:05.997517Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-22T18:20:06.001675Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.747914ms"} {"level":"info","ts":"2026-04-22T18:20:06.009604Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-22T18:20:06.009704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T18:20:06.009732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-22T18:20:06.009748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T18:20:06.009765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-22T18:20:06.009801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-22T18:20:06.018042Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T18:20:06.021874Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T18:20:06.023068Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T18:20:06.025524Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T18:20:06.026204Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T18:20:06.026435Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T18:20:06.027046Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T18:20:06.027119Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T18:20:06.026958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-22T18:20:06.027944Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-22T18:20:06.034821Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T18:20:06.034939Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-22T18:20:06.035011Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-22T18:20:06.035105Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T18:20:06.035144Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T18:20:06.510521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T18:20:06.510616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T18:20:06.510644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-22T18:20:06.510666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-22T18:20:06.510678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-22T18:20:06.510694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-22T18:20:06.510709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-22T18:20:06.511441Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T18:20:06.512112Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T18:20:06.512274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T18:20:06.512107Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T18:20:06.512594Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T18:20:06.512651Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T18:20:06.512755Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T18:20:06.512763Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T18:20:06.512815Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T18:20:06.516244Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T18:20:06.516262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-22T18:20:10.5581Z","caller":"traceutil/trace.go:171","msg":"trace[223683131] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"148.559063ms","start":"2026-04-22T18:20:10.409513Z","end":"2026-04-22T18:20:10.558072Z","steps":["trace[223683131] 'read index received' (duration: 148.380949ms)","trace[223683131] 'applied index is now lower than readState.Index' (duration: 176.614µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:20:10.558314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.771066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3708"} {"level":"info","ts":"2026-04-22T18:20:10.558403Z","caller":"traceutil/trace.go:171","msg":"trace[1351517305] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:209; }","duration":"148.903769ms","start":"2026-04-22T18:20:10.40948Z","end":"2026-04-22T18:20:10.558384Z","steps":["trace[1351517305] 'agreement among raft nodes before linearized reading' (duration: 148.719186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:20:10.831178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.921317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T18:20:10.83135Z","caller":"traceutil/trace.go:171","msg":"trace[2006162704] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"271.860019ms","start":"2026-04-22T18:20:10.559444Z","end":"2026-04-22T18:20:10.831304Z","steps":["trace[2006162704] 'process raft request' (duration: 132.269859ms)","trace[2006162704] 'compare' (duration: 138.725034ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:20:10.964624Z","caller":"traceutil/trace.go:171","msg":"trace[1972812109] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"128.762464ms","start":"2026-04-22T18:20:10.835834Z","end":"2026-04-22T18:20:10.964597Z","steps":["trace[1972812109] 'process raft request' (duration: 128.723073ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:20:10.964628Z","caller":"traceutil/trace.go:171","msg":"trace[630304658] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"402.345853ms","start":"2026-04-22T18:20:10.562233Z","end":"2026-04-22T18:20:10.964579Z","steps":["trace[630304658] 'process raft request' (duration: 373.238456ms)","trace[630304658] 'compare' (duration: 28.866923ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:20:10.964799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:20:10.56222Z","time spent":"402.496187ms","remote":"127.0.0.1:49024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T18:20:10.964649Z","caller":"traceutil/trace.go:171","msg":"trace[1754348919] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"399.509142ms","start":"2026-04-22T18:20:10.565108Z","end":"2026-04-22T18:20:10.964617Z","steps":["trace[1754348919] 'process raft request' (duration: 399.38213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:20:10.96536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:20:10.565076Z","time spent":"399.95242ms","remote":"127.0.0.1:48914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T18:20:36.056831Z","caller":"traceutil/trace.go:171","msg":"trace[1078139581] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"172.325493ms","start":"2026-04-22T18:20:35.884483Z","end":"2026-04-22T18:20:36.056808Z","steps":["trace[1078139581] 'process raft request' (duration: 162.002771ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:20:36.056829Z","caller":"traceutil/trace.go:171","msg":"trace[2014947302] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"162.941321ms","start":"2026-04-22T18:20:35.893866Z","end":"2026-04-22T18:20:36.056807Z","steps":["trace[2014947302] 'process raft request' (duration: 162.87006ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:20:41.809304Z","caller":"traceutil/trace.go:171","msg":"trace[1860295496] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"176.589589ms","start":"2026-04-22T18:20:41.632671Z","end":"2026-04-22T18:20:41.809261Z","steps":["trace[1860295496] 'process raft request' (duration: 175.743398ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:20:42.461986Z","caller":"traceutil/trace.go:171","msg":"trace[658222659] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"145.768983ms","start":"2026-04-22T18:20:42.316189Z","end":"2026-04-22T18:20:42.461958Z","steps":["trace[658222659] 'process raft request' (duration: 144.707579ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:20:42.952615Z","caller":"traceutil/trace.go:171","msg":"trace[1142752024] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"430.450515ms","start":"2026-04-22T18:20:42.522124Z","end":"2026-04-22T18:20:42.952574Z","steps":["trace[1142752024] 'process raft request' (duration: 430.06287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:20:42.95283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:20:42.522105Z","time spent":"430.613877ms","remote":"127.0.0.1:48926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T18:20:42.971912Z","caller":"traceutil/trace.go:171","msg":"trace[1505953234] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"439.832819ms","start":"2026-04-22T18:20:42.532045Z","end":"2026-04-22T18:20:42.971878Z","steps":["trace[1505953234] 'process raft request' (duration: 439.690628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:20:42.972088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:20:42.532029Z","time spent":"439.973801ms","remote":"127.0.0.1:49262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T18:20:57.370714Z","caller":"traceutil/trace.go:171","msg":"trace[622272159] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"137.000342ms","start":"2026-04-22T18:20:57.233689Z","end":"2026-04-22T18:20:57.370689Z","steps":["trace[622272159] 'process raft request' (duration: 136.78141ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:16.230668Z","caller":"traceutil/trace.go:171","msg":"trace[1033088443] linearizableReadLoop","detail":"{readStateIndex:1941; appliedIndex:1940; }","duration":"250.300624ms","start":"2026-04-22T18:22:15.980329Z","end":"2026-04-22T18:22:16.23063Z","steps":["trace[1033088443] 'read index received' (duration: 250.040559ms)","trace[1033088443] 'applied index is now lower than readState.Index' (duration: 258.675µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:22:16.230815Z","caller":"traceutil/trace.go:171","msg":"trace[536860228] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"329.413317ms","start":"2026-04-22T18:22:15.90139Z","end":"2026-04-22T18:22:16.230803Z","steps":["trace[536860228] 'process raft request' (duration: 329.06537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:22:16.231053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.665915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-04-22T18:22:16.231137Z","caller":"traceutil/trace.go:171","msg":"trace[1325319494] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1868; }","duration":"240.761077ms","start":"2026-04-22T18:22:15.990354Z","end":"2026-04-22T18:22:16.231115Z","steps":["trace[1325319494] 'agreement among raft nodes before linearized reading' (duration: 240.539672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:22:16.231383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.04871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f090b6b-f5ba-4b7f-ad3d-8eeb95b65389\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-22T18:22:16.23143Z","caller":"traceutil/trace.go:171","msg":"trace[1078472691] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f090b6b-f5ba-4b7f-ad3d-8eeb95b65389; range_end:; response_count:1; response_revision:1868; }","duration":"251.116923ms","start":"2026-04-22T18:22:15.980299Z","end":"2026-04-22T18:22:16.231416Z","steps":["trace[1078472691] 'agreement among raft nodes before linearized reading' (duration: 251.00472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:22:16.232159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:22:15.90137Z","time spent":"329.465318ms","remote":"127.0.0.1:49024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T18:22:16.40602Z","caller":"traceutil/trace.go:171","msg":"trace[29086985] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"114.26182ms","start":"2026-04-22T18:22:16.291733Z","end":"2026-04-22T18:22:16.405995Z","steps":["trace[29086985] 'process raft request' (duration: 114.165368ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:16.406045Z","caller":"traceutil/trace.go:171","msg":"trace[1395248381] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"114.450474ms","start":"2026-04-22T18:22:16.291563Z","end":"2026-04-22T18:22:16.406013Z","steps":["trace[1395248381] 'process raft request' (duration: 114.193999ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:16.406387Z","caller":"traceutil/trace.go:171","msg":"trace[1504424552] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"108.483845ms","start":"2026-04-22T18:22:16.297872Z","end":"2026-04-22T18:22:16.406356Z","steps":["trace[1504424552] 'process raft request' (duration: 108.078347ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:16.406607Z","caller":"traceutil/trace.go:171","msg":"trace[910511377] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"108.525316ms","start":"2026-04-22T18:22:16.298063Z","end":"2026-04-22T18:22:16.406589Z","steps":["trace[910511377] 'process raft request' (duration: 108.22021ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:16.650544Z","caller":"traceutil/trace.go:171","msg":"trace[1343407937] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"237.460603ms","start":"2026-04-22T18:22:16.413054Z","end":"2026-04-22T18:22:16.650514Z","steps":["trace[1343407937] 'process raft request' (duration: 224.825501ms)","trace[1343407937] 'compare' (duration: 12.489599ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:22:27.200741Z","caller":"traceutil/trace.go:171","msg":"trace[2143244206] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"168.310472ms","start":"2026-04-22T18:22:27.032407Z","end":"2026-04-22T18:22:27.200718Z","steps":["trace[2143244206] 'process raft request' (duration: 168.153089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T18:22:51.383086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.403015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T18:22:51.383413Z","caller":"traceutil/trace.go:171","msg":"trace[662178075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2115; }","duration":"144.808771ms","start":"2026-04-22T18:22:51.238576Z","end":"2026-04-22T18:22:51.383385Z","steps":["trace[662178075] 'range keys from in-memory index tree' (duration: 144.287743ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.410188Z","caller":"traceutil/trace.go:171","msg":"trace[2021646780] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"121.229571ms","start":"2026-04-22T18:22:51.288914Z","end":"2026-04-22T18:22:51.410143Z","steps":["trace[2021646780] 'process raft request' (duration: 121.020787ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.545038Z","caller":"traceutil/trace.go:171","msg":"trace[1431284087] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2196; }","duration":"159.865854ms","start":"2026-04-22T18:22:51.385137Z","end":"2026-04-22T18:22:51.545003Z","steps":["trace[1431284087] 'read index received' (duration: 24.761041ms)","trace[1431284087] 'applied index is now lower than readState.Index' (duration: 135.103363ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:22:51.545639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.469525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T18:22:51.545764Z","caller":"traceutil/trace.go:171","msg":"trace[997141231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2117; }","duration":"160.683289ms","start":"2026-04-22T18:22:51.38506Z","end":"2026-04-22T18:22:51.545743Z","steps":["trace[997141231] 'agreement among raft nodes before linearized reading' (duration: 160.439664ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.545375Z","caller":"traceutil/trace.go:171","msg":"trace[263846335] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"203.097496ms","start":"2026-04-22T18:22:51.342264Z","end":"2026-04-22T18:22:51.545361Z","steps":["trace[263846335] 'process raft request' (duration: 202.579867ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.712983Z","caller":"traceutil/trace.go:171","msg":"trace[1658635999] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"275.301244ms","start":"2026-04-22T18:22:51.437627Z","end":"2026-04-22T18:22:51.712929Z","steps":["trace[1658635999] 'process raft request' (duration: 274.870576ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.713145Z","caller":"traceutil/trace.go:171","msg":"trace[1762986995] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2198; }","duration":"167.998386ms","start":"2026-04-22T18:22:51.54512Z","end":"2026-04-22T18:22:51.713118Z","steps":["trace[1762986995] 'read index received' (duration: 145.27862ms)","trace[1762986995] 'applied index is now lower than readState.Index' (duration: 22.711066ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:22:51.713099Z","caller":"traceutil/trace.go:171","msg":"trace[1350087754] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"280.2478ms","start":"2026-04-22T18:22:51.432819Z","end":"2026-04-22T18:22:51.713067Z","steps":["trace[1350087754] 'process raft request' (duration: 257.480723ms)","trace[1350087754] 'compare' (duration: 21.964643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:22:51.713383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.229409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T18:22:51.713427Z","caller":"traceutil/trace.go:171","msg":"trace[1590013949] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2119; }","duration":"230.345291ms","start":"2026-04-22T18:22:51.483067Z","end":"2026-04-22T18:22:51.713413Z","steps":["trace[1590013949] 'agreement among raft nodes before linearized reading' (duration: 230.146997ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:22:51.713913Z","caller":"traceutil/trace.go:171","msg":"trace[1125749975] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"122.86416ms","start":"2026-04-22T18:22:51.59102Z","end":"2026-04-22T18:22:51.713884Z","steps":["trace[1125749975] 'process raft request' (duration: 122.427981ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:23:56.701588Z","caller":"traceutil/trace.go:171","msg":"trace[1095935801] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"193.173637ms","start":"2026-04-22T18:23:56.508364Z","end":"2026-04-22T18:23:56.701538Z","steps":["trace[1095935801] 'process raft request' (duration: 192.834312ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:24:27.481221Z","caller":"traceutil/trace.go:171","msg":"trace[1567019355] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"140.127236ms","start":"2026-04-22T18:24:27.341064Z","end":"2026-04-22T18:24:27.481191Z","steps":["trace[1567019355] 'process raft request' (duration: 139.70152ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:05.783844Z","caller":"traceutil/trace.go:171","msg":"trace[689805206] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"134.444736ms","start":"2026-04-22T18:28:05.649376Z","end":"2026-04-22T18:28:05.783821Z","steps":["trace[689805206] 'process raft request' (duration: 134.287522ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:11.041768Z","caller":"traceutil/trace.go:171","msg":"trace[1221891076] linearizableReadLoop","detail":"{readStateIndex:4786; appliedIndex:4785; }","duration":"102.21809ms","start":"2026-04-22T18:28:10.939528Z","end":"2026-04-22T18:28:11.041746Z","steps":["trace[1221891076] 'read index received' (duration: 91.892098ms)","trace[1221891076] 'applied index is now lower than readState.Index' (duration: 10.321632ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:28:11.041825Z","caller":"traceutil/trace.go:171","msg":"trace[1839479304] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"106.998288ms","start":"2026-04-22T18:28:10.934796Z","end":"2026-04-22T18:28:11.041795Z","steps":["trace[1839479304] 'process raft request' (duration: 96.539142ms)","trace[1839479304] 'compare' (duration: 10.264941ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:28:11.041998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.443566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-22T18:28:11.042056Z","caller":"traceutil/trace.go:171","msg":"trace[372796099] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4607; }","duration":"102.542499ms","start":"2026-04-22T18:28:10.939498Z","end":"2026-04-22T18:28:11.042041Z","steps":["trace[372796099] 'agreement among raft nodes before linearized reading' (duration: 102.363394ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:17.960442Z","caller":"traceutil/trace.go:171","msg":"trace[1121994563] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"209.814022ms","start":"2026-04-22T18:28:17.750596Z","end":"2026-04-22T18:28:17.96041Z","steps":["trace[1121994563] 'process raft request' (duration: 209.662428ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:18.06415Z","caller":"traceutil/trace.go:171","msg":"trace[1719963577] linearizableReadLoop","detail":"{readStateIndex:4892; appliedIndex:4890; }","duration":"197.58252ms","start":"2026-04-22T18:28:17.866533Z","end":"2026-04-22T18:28:18.064115Z","steps":["trace[1719963577] 'read index received' (duration: 93.802147ms)","trace[1719963577] 'applied index is now lower than readState.Index' (duration: 103.779133ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T18:28:18.064231Z","caller":"traceutil/trace.go:171","msg":"trace[105914995] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"306.52671ms","start":"2026-04-22T18:28:17.757634Z","end":"2026-04-22T18:28:18.064161Z","steps":["trace[105914995] 'process raft request' (duration: 263.988868ms)","trace[105914995] 'compare' (duration: 42.341097ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:28:18.064415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T18:28:17.757606Z","time spent":"306.703405ms","remote":"127.0.0.1:48926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11829,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T18:28:18.064434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.873907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d1c5983-7547-41db-90cd-5a08375cd56e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-22T18:28:18.064479Z","caller":"traceutil/trace.go:171","msg":"trace[1127539942] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d1c5983-7547-41db-90cd-5a08375cd56e; range_end:; response_count:1; response_revision:4712; }","duration":"197.9761ms","start":"2026-04-22T18:28:17.866489Z","end":"2026-04-22T18:28:18.064465Z","steps":["trace[1127539942] 'agreement among raft nodes before linearized reading' (duration: 197.797465ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:31.400527Z","caller":"traceutil/trace.go:171","msg":"trace[550248229] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"282.074206ms","start":"2026-04-22T18:28:31.118429Z","end":"2026-04-22T18:28:31.400503Z","steps":["trace[550248229] 'process raft request' (duration: 278.941388ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:31.406002Z","caller":"traceutil/trace.go:171","msg":"trace[1945617255] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"241.655109ms","start":"2026-04-22T18:28:31.164321Z","end":"2026-04-22T18:28:31.405976Z","steps":["trace[1945617255] 'process raft request' (duration: 241.507885ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:28:31.406254Z","caller":"traceutil/trace.go:171","msg":"trace[749576759] linearizableReadLoop","detail":"{readStateIndex:5084; appliedIndex:5082; }","duration":"167.265743ms","start":"2026-04-22T18:28:31.238956Z","end":"2026-04-22T18:28:31.406222Z","steps":["trace[749576759] 'read index received' (duration: 158.364831ms)","trace[749576759] 'applied index is now lower than readState.Index' (duration: 8.899062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T18:28:31.406415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.420366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T18:28:31.406647Z","caller":"traceutil/trace.go:171","msg":"trace[1483192453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4899; }","duration":"167.724344ms","start":"2026-04-22T18:28:31.238907Z","end":"2026-04-22T18:28:31.406632Z","steps":["trace[1483192453] 'agreement among raft nodes before linearized reading' (duration: 167.417376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:30:06.547648Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2947} {"level":"info","ts":"2026-04-22T18:30:06.627968Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2947,"took":"78.975218ms","hash":2615326965,"current-db-size-bytes":54157312,"current-db-size":"54 MB","current-db-size-in-use-bytes":29573120,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T18:30:06.628016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2615326965,"revision":2947,"compact-revision":-1} {"level":"info","ts":"2026-04-22T18:32:22.528494Z","caller":"traceutil/trace.go:171","msg":"trace[470598327] transaction","detail":"{read_only:false; response_revision:6552; number_of_response:1; }","duration":"233.685676ms","start":"2026-04-22T18:32:22.294785Z","end":"2026-04-22T18:32:22.528471Z","steps":["trace[470598327] 'process raft request' (duration: 233.551233ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:32:22.530601Z","caller":"traceutil/trace.go:171","msg":"trace[2031687329] transaction","detail":"{read_only:false; response_revision:6553; number_of_response:1; }","duration":"194.261109ms","start":"2026-04-22T18:32:22.336314Z","end":"2026-04-22T18:32:22.530575Z","steps":["trace[2031687329] 'process raft request' (duration: 194.120226ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T18:35:06.56169Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5643} {"level":"info","ts":"2026-04-22T18:35:06.638359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5643,"took":"75.41169ms","hash":2130517478,"current-db-size-bytes":54157312,"current-db-size":"54 MB","current-db-size-in-use-bytes":18202624,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-22T18:35:06.638438Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2130517478,"revision":5643,"compact-revision":2947}