{"level":"warn","ts":"2026-04-02T16:42:50.424032Z","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-02T16:42:50.424108Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-02T16:42:50.424175Z","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-02T16:42:50.424187Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-02T16:42:50.424205Z","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-02T16:42:50.424934Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-04-02T16:42:50.425011Z","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":16,"max-cpu-available":16,"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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-02T16:42:50.428159Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.940304ms"} {"level":"info","ts":"2026-04-02T16:42:50.432804Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-04-02T16:42:50.432878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T16:42:50.432907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-04-02T16:42:50.432923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T16:42:50.432936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-04-02T16:42:50.43298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-04-02T16:42:50.439072Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T16:42:50.440488Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T16:42:50.442098Z","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-02T16:42:50.445283Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T16:42:50.445415Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T16:42:50.445471Z","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-02T16:42:50.445573Z","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-02T16:42:50.445597Z","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-02T16:42:50.447008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-04-02T16:42:50.447218Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-02T16:42:50.449012Z","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-02T16:42:50.449118Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-02T16:42:50.44918Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-02T16:42:50.449246Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T16:42:50.449296Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T16:42:50.935061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T16:42:50.935104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T16:42:50.935137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-04-02T16:42:50.935147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-04-02T16:42:50.935152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-02T16:42:50.93516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-04-02T16:42:50.935168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-02T16:42:50.944544Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:50.945775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T16:42:50.946154Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:42:50.946382Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:50.946524Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:50.946572Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T16:42:50.94669Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T16:42:50.946724Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T16:42:50.946742Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T16:42:50.949581Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-04-02T16:42:50.950312Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-02T16:43:28.695055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.109941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:43:28.695362Z","caller":"traceutil/trace.go:171","msg":"trace[96910782] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"321.431757ms","start":"2026-04-02T16:43:28.373913Z","end":"2026-04-02T16:43:28.695345Z","steps":["trace[96910782] 'read index received' (duration: 243.146241ms)","trace[96910782] 'applied index is now lower than readState.Index' (duration: 78.284546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:43:28.695531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.616151ms","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-04-02T16:43:28.695604Z","caller":"traceutil/trace.go:171","msg":"trace[257246620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"321.738393ms","start":"2026-04-02T16:43:28.373854Z","end":"2026-04-02T16:43:28.695593Z","steps":["trace[257246620] 'agreement among raft nodes before linearized reading' (duration: 321.556029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:28.695642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:28.373832Z","time spent":"321.799385ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T16:43:28.69569Z","caller":"traceutil/trace.go:171","msg":"trace[842379362] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"461.760735ms","start":"2026-04-02T16:43:28.233897Z","end":"2026-04-02T16:43:28.695658Z","steps":["trace[842379362] 'process raft request' (duration: 136.269647ms)","trace[842379362] 'compare' (duration: 323.899697ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:43:28.695825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:28.233867Z","time spent":"461.890138ms","remote":"127.0.0.1:41912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:43:28.695804Z","caller":"traceutil/trace.go:171","msg":"trace[765548955] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"416.302532ms","start":"2026-04-02T16:43:28.279332Z","end":"2026-04-02T16:43:28.695635Z","steps":["trace[765548955] 'process raft request' (duration: 415.951366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:28.696092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:43:28.279304Z","time spent":"416.664859ms","remote":"127.0.0.1:41974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T16:43:30.438169Z","caller":"traceutil/trace.go:171","msg":"trace[855400427] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"101.925405ms","start":"2026-04-02T16:43:30.33621Z","end":"2026-04-02T16:43:30.438135Z","steps":["trace[855400427] 'process raft request' (duration: 101.812173ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:30.438182Z","caller":"traceutil/trace.go:171","msg":"trace[801279509] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"103.479307ms","start":"2026-04-02T16:43:30.334674Z","end":"2026-04-02T16:43:30.438153Z","steps":["trace[801279509] 'process raft request' (duration: 103.167851ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:43.401065Z","caller":"traceutil/trace.go:171","msg":"trace[323832600] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"103.807963ms","start":"2026-04-02T16:43:43.297216Z","end":"2026-04-02T16:43:43.401024Z","steps":["trace[323832600] 'read index received' (duration: 103.693741ms)","trace[323832600] 'applied index is now lower than readState.Index' (duration: 113.292µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:43:43.401096Z","caller":"traceutil/trace.go:171","msg":"trace[1518406804] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"112.823083ms","start":"2026-04-02T16:43:43.288249Z","end":"2026-04-02T16:43:43.401072Z","steps":["trace[1518406804] 'process raft request' (duration: 112.629159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:43:43.401259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.028367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nfcqd\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-02T16:43:43.401293Z","caller":"traceutil/trace.go:171","msg":"trace[1164856047] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nfcqd; range_end:; response_count:1; response_revision:784; }","duration":"104.100728ms","start":"2026-04-02T16:43:43.297182Z","end":"2026-04-02T16:43:43.401282Z","steps":["trace[1164856047] 'agreement among raft nodes before linearized reading' (duration: 103.958065ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:43:53.620863Z","caller":"traceutil/trace.go:171","msg":"trace[95555080] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"103.790772ms","start":"2026-04-02T16:43:53.517043Z","end":"2026-04-02T16:43:53.620833Z","steps":["trace[95555080] 'process raft request' (duration: 73.338437ms)","trace[95555080] 'compare' (duration: 30.249852ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:44:05.78924Z","caller":"traceutil/trace.go:171","msg":"trace[1146841175] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"113.855942ms","start":"2026-04-02T16:44:05.675354Z","end":"2026-04-02T16:44:05.789209Z","steps":["trace[1146841175] 'process raft request' (duration: 113.692439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:54.373659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.740776ms","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-04-02T16:44:54.373763Z","caller":"traceutil/trace.go:171","msg":"trace[1532063173] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"219.902019ms","start":"2026-04-02T16:44:54.153841Z","end":"2026-04-02T16:44:54.373743Z","steps":["trace[1532063173] 'range keys from in-memory index tree' (duration: 219.569043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:44:54.373661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.788457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T16:44:54.373916Z","caller":"traceutil/trace.go:171","msg":"trace[1253275464] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:1828; }","duration":"147.092243ms","start":"2026-04-02T16:44:54.226793Z","end":"2026-04-02T16:44:54.373885Z","steps":["trace[1253275464] 'range keys from in-memory index tree' (duration: 146.589044ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:44:54.763266Z","caller":"traceutil/trace.go:171","msg":"trace[1763403889] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1899; }","duration":"107.071397ms","start":"2026-04-02T16:44:54.656165Z","end":"2026-04-02T16:44:54.763236Z","steps":["trace[1763403889] 'read index received' (duration: 67.072372ms)","trace[1763403889] 'applied index is now lower than readState.Index' (duration: 39.997004ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:44:54.763383Z","caller":"traceutil/trace.go:171","msg":"trace[1557171996] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"115.22032ms","start":"2026-04-02T16:44:54.648125Z","end":"2026-04-02T16:44:54.763346Z","steps":["trace[1557171996] 'process raft request' (duration: 75.114153ms)","trace[1557171996] 'compare' (duration: 39.546766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:44:54.763617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.435594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-406cc36e-fd45-4c4d-bfec-5efaea408cf5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-02T16:44:54.763697Z","caller":"traceutil/trace.go:171","msg":"trace[991338742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-406cc36e-fd45-4c4d-bfec-5efaea408cf5; range_end:; response_count:1; response_revision:1831; }","duration":"107.552146ms","start":"2026-04-02T16:44:54.656122Z","end":"2026-04-02T16:44:54.763674Z","steps":["trace[991338742] 'agreement among raft nodes before linearized reading' (duration: 107.24809ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:45:33.638922Z","caller":"traceutil/trace.go:171","msg":"trace[1416721961] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"117.984498ms","start":"2026-04-02T16:45:33.520901Z","end":"2026-04-02T16:45:33.638886Z","steps":["trace[1416721961] 'process raft request' (duration: 117.771084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:39.623471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.442626ms","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-04-02T16:45:39.623582Z","caller":"traceutil/trace.go:171","msg":"trace[1945885276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2122; }","duration":"178.61544ms","start":"2026-04-02T16:45:39.444941Z","end":"2026-04-02T16:45:39.623557Z","steps":["trace[1945885276] 'range keys from in-memory index tree' (duration: 178.101869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:39.62363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.887989ms","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-04-02T16:45:39.62371Z","caller":"traceutil/trace.go:171","msg":"trace[568314562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2122; }","duration":"275.012881ms","start":"2026-04-02T16:45:39.348675Z","end":"2026-04-02T16:45:39.623688Z","steps":["trace[568314562] 'range keys from in-memory index tree' (duration: 274.635333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:45:39.623731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.40267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-02T16:45:39.623829Z","caller":"traceutil/trace.go:171","msg":"trace[415742269] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2122; }","duration":"264.496082ms","start":"2026-04-02T16:45:39.359297Z","end":"2026-04-02T16:45:39.623793Z","steps":["trace[415742269] 'range keys from in-memory index tree' (duration: 264.139985ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:46:33.978779Z","caller":"traceutil/trace.go:171","msg":"trace[78973250] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"111.526924ms","start":"2026-04-02T16:46:33.867227Z","end":"2026-04-02T16:46:33.978754Z","steps":["trace[78973250] 'process raft request' (duration: 111.168717ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:08.362142Z","caller":"traceutil/trace.go:171","msg":"trace[1685928200] linearizableReadLoop","detail":"{readStateIndex:2899; appliedIndex:2898; }","duration":"210.890136ms","start":"2026-04-02T16:47:08.151228Z","end":"2026-04-02T16:47:08.362119Z","steps":["trace[1685928200] 'read index received' (duration: 210.741593ms)","trace[1685928200] 'applied index is now lower than readState.Index' (duration: 147.533µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:47:08.362251Z","caller":"traceutil/trace.go:171","msg":"trace[1748539370] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"223.63853ms","start":"2026-04-02T16:47:08.138578Z","end":"2026-04-02T16:47:08.362217Z","steps":["trace[1748539370] 'process raft request' (duration: 223.396914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:47:08.362388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.148243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-02T16:47:08.362432Z","caller":"traceutil/trace.go:171","msg":"trace[400866583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2795; }","duration":"211.244154ms","start":"2026-04-02T16:47:08.151176Z","end":"2026-04-02T16:47:08.362421Z","steps":["trace[400866583] 'agreement among raft nodes before linearized reading' (duration: 211.088681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:47:08.362728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.059501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T16:47:08.362766Z","caller":"traceutil/trace.go:171","msg":"trace[1667412079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2795; }","duration":"199.136283ms","start":"2026-04-02T16:47:08.163621Z","end":"2026-04-02T16:47:08.362757Z","steps":["trace[1667412079] 'agreement among raft nodes before linearized reading' (duration: 199.047381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:47:08.362968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.9223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-02T16:47:08.363033Z","caller":"traceutil/trace.go:171","msg":"trace[424489174] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2795; }","duration":"191.025052ms","start":"2026-04-02T16:47:08.171989Z","end":"2026-04-02T16:47:08.363014Z","steps":["trace[424489174] 'agreement among raft nodes before linearized reading' (duration: 190.766477ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:08.508141Z","caller":"traceutil/trace.go:171","msg":"trace[2129674181] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"140.754855ms","start":"2026-04-02T16:47:08.367362Z","end":"2026-04-02T16:47:08.508117Z","steps":["trace[2129674181] 'process raft request' (duration: 105.654877ms)","trace[2129674181] 'compare' (duration: 34.75176ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:47:08.508165Z","caller":"traceutil/trace.go:171","msg":"trace[1755131914] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"140.53992ms","start":"2026-04-02T16:47:08.367597Z","end":"2026-04-02T16:47:08.508137Z","steps":["trace[1755131914] 'process raft request' (duration: 140.464589ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:47:08.508146Z","caller":"traceutil/trace.go:171","msg":"trace[703370778] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"140.545101ms","start":"2026-04-02T16:47:08.36757Z","end":"2026-04-02T16:47:08.508115Z","steps":["trace[703370778] 'process raft request' (duration: 140.395318ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:50:48.814281Z","caller":"traceutil/trace.go:171","msg":"trace[1058456416] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"102.908673ms","start":"2026-04-02T16:50:48.711356Z","end":"2026-04-02T16:50:48.814265Z","steps":["trace[1058456416] 'process raft request' (duration: 102.657358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:50:54.426738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.453093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77b13c57-a02c-49c6-8667-0c18366699f0\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-02T16:50:54.42692Z","caller":"traceutil/trace.go:171","msg":"trace[52218981] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77b13c57-a02c-49c6-8667-0c18366699f0; range_end:; response_count:1; response_revision:4963; }","duration":"114.692498ms","start":"2026-04-02T16:50:54.312206Z","end":"2026-04-02T16:50:54.426898Z","steps":["trace[52218981] 'range keys from in-memory index tree' (duration: 114.254588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:50:54.427205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.752949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777461"} {"level":"info","ts":"2026-04-02T16:50:54.427331Z","caller":"traceutil/trace.go:171","msg":"trace[2059980146] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4963; }","duration":"119.966253ms","start":"2026-04-02T16:50:54.30734Z","end":"2026-04-02T16:50:54.427306Z","steps":["trace[2059980146] 'range keys from in-memory index tree' (duration: 119.023673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:50:54.427334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.491145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-02T16:50:54.42744Z","caller":"traceutil/trace.go:171","msg":"trace[191658391] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4963; }","duration":"100.660809ms","start":"2026-04-02T16:50:54.326755Z","end":"2026-04-02T16:50:54.427416Z","steps":["trace[191658391] 'range keys from in-memory index tree' (duration: 99.659887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:50:54.426869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.516462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-02T16:50:54.427641Z","caller":"traceutil/trace.go:171","msg":"trace[160173157] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:4963; }","duration":"183.320157ms","start":"2026-04-02T16:50:54.244286Z","end":"2026-04-02T16:50:54.427606Z","steps":["trace[160173157] 'range keys from in-memory index tree' (duration: 182.239995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:03.678777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.34972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T16:51:03.678956Z","caller":"traceutil/trace.go:171","msg":"trace[1029432920] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"146.578524ms","start":"2026-04-02T16:51:03.532359Z","end":"2026-04-02T16:51:03.678937Z","steps":["trace[1029432920] 'process raft request' (duration: 146.512003ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:03.679002Z","caller":"traceutil/trace.go:171","msg":"trace[2025111370] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"146.605973ms","start":"2026-04-02T16:51:03.532359Z","end":"2026-04-02T16:51:03.678965Z","steps":["trace[2025111370] 'process raft request' (duration: 21.001318ms)","trace[2025111370] 'compare' (duration: 125.202317ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:51:03.680852Z","caller":"traceutil/trace.go:171","msg":"trace[776830554] linearizableReadLoop","detail":"{readStateIndex:5312; appliedIndex:5311; }","duration":"115.84498ms","start":"2026-04-02T16:51:03.564993Z","end":"2026-04-02T16:51:03.680838Z","steps":["trace[776830554] 'read index received' (duration: 115.798379ms)","trace[776830554] 'applied index is now lower than readState.Index' (duration: 45.681µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:51:03.681029Z","caller":"traceutil/trace.go:171","msg":"trace[240833925] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"144.482203ms","start":"2026-04-02T16:51:03.536538Z","end":"2026-04-02T16:51:03.68102Z","steps":["trace[240833925] 'process raft request' (duration: 144.254338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:03.681247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.247609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-02T16:51:03.681291Z","caller":"traceutil/trace.go:171","msg":"trace[395191524] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5124; }","duration":"116.33075ms","start":"2026-04-02T16:51:03.564948Z","end":"2026-04-02T16:51:03.681278Z","steps":["trace[395191524] 'agreement among raft nodes before linearized reading' (duration: 116.164756ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:13.092305Z","caller":"traceutil/trace.go:171","msg":"trace[620124578] linearizableReadLoop","detail":"{readStateIndex:5517; appliedIndex:5516; }","duration":"100.227619ms","start":"2026-04-02T16:51:12.992055Z","end":"2026-04-02T16:51:13.092282Z","steps":["trace[620124578] 'read index received' (duration: 100.027275ms)","trace[620124578] 'applied index is now lower than readState.Index' (duration: 199.424µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:51:13.092559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.482294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-h24j2\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-02T16:51:13.092597Z","caller":"traceutil/trace.go:171","msg":"trace[1194263194] range","detail":"{range_begin:/registry/pods/openstack/keepalived-h24j2; range_end:; response_count:1; response_revision:5326; }","duration":"100.567836ms","start":"2026-04-02T16:51:12.99202Z","end":"2026-04-02T16:51:13.092587Z","steps":["trace[1194263194] 'agreement among raft nodes before linearized reading' (duration: 100.369453ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:13.092817Z","caller":"traceutil/trace.go:171","msg":"trace[1654345334] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"140.985283ms","start":"2026-04-02T16:51:12.951817Z","end":"2026-04-02T16:51:13.092803Z","steps":["trace[1654345334] 'process raft request' (duration: 140.322119ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:25.147477Z","caller":"traceutil/trace.go:171","msg":"trace[136968348] linearizableReadLoop","detail":"{readStateIndex:5689; appliedIndex:5688; }","duration":"326.638426ms","start":"2026-04-02T16:51:24.82081Z","end":"2026-04-02T16:51:25.147449Z","steps":["trace[136968348] 'read index received' (duration: 326.576574ms)","trace[136968348] 'applied index is now lower than readState.Index' (duration: 60.992µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:51:25.14765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.808879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:51:25.147613Z","caller":"traceutil/trace.go:171","msg":"trace[1856735200] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"338.147975ms","start":"2026-04-02T16:51:24.809422Z","end":"2026-04-02T16:51:25.14757Z","steps":["trace[1856735200] 'process raft request' (duration: 337.86691ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:51:25.147689Z","caller":"traceutil/trace.go:171","msg":"trace[1960507780] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5492; }","duration":"326.897311ms","start":"2026-04-02T16:51:24.820784Z","end":"2026-04-02T16:51:25.147681Z","steps":["trace[1960507780] 'agreement among raft nodes before linearized reading' (duration: 326.81224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:25.14772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:51:24.820773Z","time spent":"326.940112ms","remote":"127.0.0.1:41862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-02T16:51:25.147882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.649329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T16:51:25.148062Z","caller":"traceutil/trace.go:171","msg":"trace[778814172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5492; }","duration":"247.869754ms","start":"2026-04-02T16:51:24.900162Z","end":"2026-04-02T16:51:25.148031Z","steps":["trace[778814172] 'agreement among raft nodes before linearized reading' (duration: 247.581618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:25.14803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.70363ms","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-04-02T16:51:25.148172Z","caller":"traceutil/trace.go:171","msg":"trace[1373939370] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5492; }","duration":"258.918204ms","start":"2026-04-02T16:51:24.889222Z","end":"2026-04-02T16:51:25.14814Z","steps":["trace[1373939370] 'agreement among raft nodes before linearized reading' (duration: 258.500636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:51:25.148263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:51:24.8094Z","time spent":"338.311259ms","remote":"127.0.0.1:41912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T16:51:25.265055Z","caller":"traceutil/trace.go:171","msg":"trace[1292868054] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"100.24711ms","start":"2026-04-02T16:51:25.164776Z","end":"2026-04-02T16:51:25.265023Z","steps":["trace[1292868054] 'process raft request' (duration: 100.095697ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:52:51.141475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3033} {"level":"info","ts":"2026-04-02T16:52:51.21888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3033,"took":"76.11213ms","hash":1144951250,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":32165888,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-02T16:52:51.218975Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1144951250,"revision":3033,"compact-revision":-1} {"level":"info","ts":"2026-04-02T16:57:03.615225Z","caller":"traceutil/trace.go:171","msg":"trace[1379307363] transaction","detail":"{read_only:false; response_revision:8095; number_of_response:1; }","duration":"111.627018ms","start":"2026-04-02T16:57:03.503574Z","end":"2026-04-02T16:57:03.615201Z","steps":["trace[1379307363] 'process raft request' (duration: 111.480345ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:03.626608Z","caller":"traceutil/trace.go:171","msg":"trace[275178433] transaction","detail":"{read_only:false; response_revision:8096; number_of_response:1; }","duration":"121.193408ms","start":"2026-04-02T16:57:03.505392Z","end":"2026-04-02T16:57:03.626585Z","steps":["trace[275178433] 'process raft request' (duration: 120.79373ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:15.370281Z","caller":"traceutil/trace.go:171","msg":"trace[922133354] linearizableReadLoop","detail":"{readStateIndex:8438; appliedIndex:8437; }","duration":"111.472765ms","start":"2026-04-02T16:57:15.258786Z","end":"2026-04-02T16:57:15.370258Z","steps":["trace[922133354] 'read index received' (duration: 98.399865ms)","trace[922133354] 'applied index is now lower than readState.Index' (duration: 13.07171ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:57:15.37034Z","caller":"traceutil/trace.go:171","msg":"trace[155115469] transaction","detail":"{read_only:false; response_revision:8157; number_of_response:1; }","duration":"195.33389ms","start":"2026-04-02T16:57:15.174944Z","end":"2026-04-02T16:57:15.370278Z","steps":["trace[155115469] 'process raft request' (duration: 182.340301ms)","trace[155115469] 'compare' (duration: 12.879757ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:57:15.370444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.65336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-h24j2\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-02T16:57:15.37047Z","caller":"traceutil/trace.go:171","msg":"trace[411396594] range","detail":"{range_begin:/registry/pods/openstack/keepalived-h24j2; range_end:; response_count:1; response_revision:8157; }","duration":"111.724801ms","start":"2026-04-02T16:57:15.258738Z","end":"2026-04-02T16:57:15.370463Z","steps":["trace[411396594] 'agreement among raft nodes before linearized reading' (duration: 111.605448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T16:57:43.704591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.221389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-h24j2\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-02T16:57:43.704686Z","caller":"traceutil/trace.go:171","msg":"trace[2139039354] range","detail":"{range_begin:/registry/pods/openstack/keepalived-h24j2; range_end:; response_count:1; response_revision:8363; }","duration":"165.341562ms","start":"2026-04-02T16:57:43.539309Z","end":"2026-04-02T16:57:43.704651Z","steps":["trace[2139039354] 'range keys from in-memory index tree' (duration: 165.038356ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:51.149092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6231} {"level":"info","ts":"2026-04-02T16:57:51.243713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6231,"took":"92.695701ms","hash":1231346726,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":23212032,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-02T16:57:51.243775Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1231346726,"revision":6231,"compact-revision":3033} {"level":"warn","ts":"2026-04-02T16:57:55.837155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.386805ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-02T16:57:55.837369Z","caller":"traceutil/trace.go:171","msg":"trace[597356798] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8467; }","duration":"253.692967ms","start":"2026-04-02T16:57:55.583659Z","end":"2026-04-02T16:57:55.837352Z","steps":["trace[597356798] 'process raft request' (duration: 128.967055ms)","trace[597356798] 'compare' (duration: 124.004918ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T16:57:55.838257Z","caller":"traceutil/trace.go:171","msg":"trace[1750981145] transaction","detail":"{read_only:false; response_revision:8468; number_of_response:1; }","duration":"254.049792ms","start":"2026-04-02T16:57:55.584173Z","end":"2026-04-02T16:57:55.838223Z","steps":["trace[1750981145] 'process raft request' (duration: 253.091073ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:57:57.332078Z","caller":"traceutil/trace.go:171","msg":"trace[799326237] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"246.209095ms","start":"2026-04-02T16:57:57.085804Z","end":"2026-04-02T16:57:57.332013Z","steps":["trace[799326237] 'process raft request' (duration: 245.972251ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:58:59.279271Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b8.wal"} {"level":"info","ts":"2026-04-02T16:59:02.453959Z","caller":"traceutil/trace.go:171","msg":"trace[1718740910] linearizableReadLoop","detail":"{readStateIndex:9416; appliedIndex:9414; }","duration":"129.963975ms","start":"2026-04-02T16:59:02.323965Z","end":"2026-04-02T16:59:02.453929Z","steps":["trace[1718740910] 'read index received' (duration: 23.324685ms)","trace[1718740910] 'applied index is now lower than readState.Index' (duration: 106.63814ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:59:02.454524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.534356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:29 size:261463"} {"level":"info","ts":"2026-04-02T16:59:02.454613Z","caller":"traceutil/trace.go:171","msg":"trace[597749453] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:29; response_revision:9105; }","duration":"130.656498ms","start":"2026-04-02T16:59:02.323938Z","end":"2026-04-02T16:59:02.454595Z","steps":["trace[597749453] 'agreement among raft nodes before linearized reading' (duration: 130.123067ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:59:02.456201Z","caller":"traceutil/trace.go:171","msg":"trace[973077851] transaction","detail":"{read_only:false; response_revision:9105; number_of_response:1; }","duration":"133.368444ms","start":"2026-04-02T16:59:02.32281Z","end":"2026-04-02T16:59:02.456178Z","steps":["trace[973077851] 'process raft request' (duration: 130.957336ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:59:02.527119Z","caller":"traceutil/trace.go:171","msg":"trace[682521282] transaction","detail":"{read_only:false; response_revision:9106; number_of_response:1; }","duration":"164.26245ms","start":"2026-04-02T16:59:02.36282Z","end":"2026-04-02T16:59:02.527083Z","steps":["trace[682521282] 'process raft request' (duration: 120.848864ms)","trace[682521282] 'compare' (duration: 43.234603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T16:59:02.527347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.974164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-02T16:59:02.527388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.017864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T16:59:02.527483Z","caller":"traceutil/trace.go:171","msg":"trace[257513027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9106; }","duration":"203.144296ms","start":"2026-04-02T16:59:02.324317Z","end":"2026-04-02T16:59:02.527461Z","steps":["trace[257513027] 'agreement among raft nodes before linearized reading' (duration: 202.921652ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:59:02.527539Z","caller":"traceutil/trace.go:171","msg":"trace[1619387510] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9106; }","duration":"179.131937ms","start":"2026-04-02T16:59:02.348311Z","end":"2026-04-02T16:59:02.527443Z","steps":["trace[1619387510] 'agreement among raft nodes before linearized reading' (duration: 178.801ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T16:59:48.64319Z","caller":"traceutil/trace.go:171","msg":"trace[1276569802] transaction","detail":"{read_only:false; response_revision:9512; number_of_response:1; }","duration":"100.436756ms","start":"2026-04-02T16:59:48.54272Z","end":"2026-04-02T16:59:48.643156Z","steps":["trace[1276569802] 'process raft request' (duration: 50.023969ms)","trace[1276569802] 'compare' (duration: 50.024919ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T17:00:09.555276Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-02T17:00:09.56181Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-02T17:00:09.561903Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-02T17:02:51.156311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8434} {"level":"info","ts":"2026-04-02T17:02:51.238106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8434,"took":"78.276174ms","hash":777458478,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":25092096,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-02T17:02:51.23818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":777458478,"revision":8434,"compact-revision":6231} {"level":"info","ts":"2026-04-02T17:07:51.163626Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10785} {"level":"info","ts":"2026-04-02T17:07:51.246339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10785,"took":"79.460987ms","hash":3064147228,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":20332544,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-02T17:07:51.246421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3064147228,"revision":10785,"compact-revision":8434}