{"level":"warn","ts":"2026-04-14T05:34:12.708984Z","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-14T05:34:12.709077Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-14T05:34:12.70916Z","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-14T05:34:12.709172Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-14T05:34:12.709197Z","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-14T05:34:12.709977Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-04-14T05:34:12.710131Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-14T05:34:12.714083Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.664529ms"} {"level":"info","ts":"2026-04-14T05:34:12.724083Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-04-14T05:34:12.724165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T05:34:12.72419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-04-14T05:34:12.724208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T05:34:12.724219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-04-14T05:34:12.724256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-04-14T05:34:12.729775Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T05:34:12.731064Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T05:34:12.732426Z","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-14T05:34:12.735484Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T05:34:12.735849Z","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-14T05:34:12.735858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T05:34:12.736126Z","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-14T05:34:12.736222Z","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-14T05:34:12.748333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-04-14T05:34:12.748548Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-14T05:34:12.749081Z","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-14T05:34:12.749352Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T05:34:12.749385Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T05:34:12.749491Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-14T05:34:12.749505Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-14T05:34:13.524677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T05:34:13.524753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T05:34:13.524794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-04-14T05:34:13.524814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-04-14T05:34:13.524833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-14T05:34:13.52485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-04-14T05:34:13.524876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-14T05:34:13.526483Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:34:13.526635Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T05:34:13.526687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T05:34:13.526723Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T05:34:13.526949Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T05:34:13.527024Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T05:34:13.527328Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:34:13.527424Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:34:13.527458Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T05:34:13.528514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-04-14T05:34:13.530134Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-14T05:34:17.85227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.928472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:34:17.852395Z","caller":"traceutil/trace.go:171","msg":"trace[212399560] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"240.686026ms","start":"2026-04-14T05:34:17.61169Z","end":"2026-04-14T05:34:17.852376Z","steps":["trace[212399560] 'process raft request' (duration: 21.121005ms)","trace[212399560] 'compare' (duration: 218.804691ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:34:18.162005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.611406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:34:18.16217Z","caller":"traceutil/trace.go:171","msg":"trace[1098031910] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"305.801119ms","start":"2026-04-14T05:34:17.856352Z","end":"2026-04-14T05:34:18.162153Z","steps":["trace[1098031910] 'process raft request' (duration: 305.749939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:34:18.162234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:34:17.856335Z","time spent":"305.87809ms","remote":"127.0.0.1:42412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":290,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:34:18.162336Z","caller":"traceutil/trace.go:171","msg":"trace[1467159021] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"425.170989ms","start":"2026-04-14T05:34:17.737099Z","end":"2026-04-14T05:34:18.162269Z","steps":["trace[1467159021] 'process raft request' (duration: 260.230819ms)","trace[1467159021] 'compare' (duration: 164.450524ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:34:18.162515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:34:17.737078Z","time spent":"425.362112ms","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T05:34:47.722175Z","caller":"traceutil/trace.go:171","msg":"trace[1425198308] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"152.393791ms","start":"2026-04-14T05:34:47.569723Z","end":"2026-04-14T05:34:47.722117Z","steps":["trace[1425198308] 'process raft request' (duration: 91.259433ms)","trace[1425198308] 'compare' (duration: 60.796174ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:34:48.219026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.62461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:34:48.219454Z","caller":"traceutil/trace.go:171","msg":"trace[1777882979] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"448.510216ms","start":"2026-04-14T05:34:47.770913Z","end":"2026-04-14T05:34:48.219423Z","steps":["trace[1777882979] 'process raft request' (duration: 159.156528ms)","trace[1777882979] 'compare' (duration: 288.418017ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:34:48.219554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:34:47.770881Z","time spent":"448.629547ms","remote":"127.0.0.1:42254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T05:34:48.778044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.469792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:34:48.778148Z","caller":"traceutil/trace.go:171","msg":"trace[1924984406] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"500.787743ms","start":"2026-04-14T05:34:48.277347Z","end":"2026-04-14T05:34:48.778135Z","steps":["trace[1924984406] 'process raft request' (duration: 265.175659ms)","trace[1924984406] 'compare' (duration: 235.177599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:34:48.778185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:34:48.277319Z","time spent":"500.850693ms","remote":"127.0.0.1:42338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T05:36:28.387815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.589715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f4a3eea2-d94b-4691-a0bc-f87d2284579c\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-14T05:36:28.387912Z","caller":"traceutil/trace.go:171","msg":"trace[1517738533] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f4a3eea2-d94b-4691-a0bc-f87d2284579c; range_end:; response_count:1; response_revision:1855; }","duration":"154.726068ms","start":"2026-04-14T05:36:28.233166Z","end":"2026-04-14T05:36:28.387892Z","steps":["trace[1517738533] 'range keys from in-memory index tree' (duration: 154.40381ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:36:42.02569Z","caller":"traceutil/trace.go:171","msg":"trace[1298279944] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2046; }","duration":"189.510219ms","start":"2026-04-14T05:36:41.836151Z","end":"2026-04-14T05:36:42.025661Z","steps":["trace[1298279944] 'read index received' (duration: 189.407347ms)","trace[1298279944] 'applied index is now lower than readState.Index' (duration: 101.492µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:36:42.025852Z","caller":"traceutil/trace.go:171","msg":"trace[2071130929] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"218.741508ms","start":"2026-04-14T05:36:41.807084Z","end":"2026-04-14T05:36:42.025826Z","steps":["trace[2071130929] 'process raft request' (duration: 218.277537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:36:42.02602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.845446ms","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-14T05:36:42.026079Z","caller":"traceutil/trace.go:171","msg":"trace[1985473133] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1970; }","duration":"189.940219ms","start":"2026-04-14T05:36:41.836119Z","end":"2026-04-14T05:36:42.026059Z","steps":["trace[1985473133] 'agreement among raft nodes before linearized reading' (duration: 189.672513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:36:42.060619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.744099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T05:36:42.060695Z","caller":"traceutil/trace.go:171","msg":"trace[227556873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1971; }","duration":"161.828291ms","start":"2026-04-14T05:36:41.898851Z","end":"2026-04-14T05:36:42.060679Z","steps":["trace[227556873] 'agreement among raft nodes before linearized reading' (duration: 161.616326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:36:42.06078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.023638ms","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-14T05:36:42.060854Z","caller":"traceutil/trace.go:171","msg":"trace[1595827859] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1971; }","duration":"132.134431ms","start":"2026-04-14T05:36:41.928701Z","end":"2026-04-14T05:36:42.060835Z","steps":["trace[1595827859] 'agreement among raft nodes before linearized reading' (duration: 131.962597ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:36:57.445926Z","caller":"traceutil/trace.go:171","msg":"trace[1527783528] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"110.118006ms","start":"2026-04-14T05:36:57.335781Z","end":"2026-04-14T05:36:57.445899Z","steps":["trace[1527783528] 'process raft request' (duration: 109.958913ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:24.713538Z","caller":"traceutil/trace.go:171","msg":"trace[1558193095] transaction","detail":"{read_only:false; response_revision:4526; number_of_response:1; }","duration":"105.361394ms","start":"2026-04-14T05:42:24.608153Z","end":"2026-04-14T05:42:24.713514Z","steps":["trace[1558193095] 'process raft request' (duration: 57.057729ms)","trace[1558193095] 'compare' (duration: 48.12292ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:42:24.755136Z","caller":"traceutil/trace.go:171","msg":"trace[874710587] linearizableReadLoop","detail":"{readStateIndex:4704; appliedIndex:4701; }","duration":"138.549437ms","start":"2026-04-14T05:42:24.616566Z","end":"2026-04-14T05:42:24.755115Z","steps":["trace[874710587] 'read index received' (duration: 48.579993ms)","trace[874710587] 'applied index is now lower than readState.Index' (duration: 89.968314ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:42:24.755354Z","caller":"traceutil/trace.go:171","msg":"trace[1386512130] transaction","detail":"{read_only:false; response_revision:4528; number_of_response:1; }","duration":"143.14773ms","start":"2026-04-14T05:42:24.612175Z","end":"2026-04-14T05:42:24.755323Z","steps":["trace[1386512130] 'process raft request' (duration: 142.891923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:42:24.756607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.017546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-14T05:42:24.756728Z","caller":"traceutil/trace.go:171","msg":"trace[1299749790] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4528; }","duration":"140.167101ms","start":"2026-04-14T05:42:24.616537Z","end":"2026-04-14T05:42:24.756704Z","steps":["trace[1299749790] 'agreement among raft nodes before linearized reading' (duration: 138.748863ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:24.755164Z","caller":"traceutil/trace.go:171","msg":"trace[578317258] transaction","detail":"{read_only:false; response_revision:4527; number_of_response:1; }","duration":"143.698255ms","start":"2026-04-14T05:42:24.611426Z","end":"2026-04-14T05:42:24.755124Z","steps":["trace[578317258] 'process raft request' (duration: 143.51751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:42:45.407856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.456169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T05:42:45.408058Z","caller":"traceutil/trace.go:171","msg":"trace[1522569320] linearizableReadLoop","detail":"{readStateIndex:5058; appliedIndex:5056; }","duration":"281.497858ms","start":"2026-04-14T05:42:45.126538Z","end":"2026-04-14T05:42:45.408036Z","steps":["trace[1522569320] 'read index received' (duration: 167.015461ms)","trace[1522569320] 'applied index is now lower than readState.Index' (duration: 114.480877ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:42:45.408205Z","caller":"traceutil/trace.go:171","msg":"trace[505643001] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"478.840294ms","start":"2026-04-14T05:42:44.929352Z","end":"2026-04-14T05:42:45.408192Z","steps":["trace[505643001] 'process raft request' (duration: 478.617988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:42:45.408408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:42:44.929319Z","time spent":"478.984288ms","remote":"127.0.0.1:42350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:42:45.408522Z","caller":"traceutil/trace.go:171","msg":"trace[1673887677] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"545.917571ms","start":"2026-04-14T05:42:44.862134Z","end":"2026-04-14T05:42:45.408051Z","steps":["trace[1673887677] 'process raft request' (duration: 197.163644ms)","trace[1673887677] 'compare' (duration: 348.269534ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T05:42:45.408526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.577271ms","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":"warn","ts":"2026-04-14T05:42:45.408674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T05:42:44.862114Z","time spent":"546.484725ms","remote":"127.0.0.1:42350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T05:42:45.408711Z","caller":"traceutil/trace.go:171","msg":"trace[75783786] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4870; }","duration":"231.819277ms","start":"2026-04-14T05:42:45.176871Z","end":"2026-04-14T05:42:45.40869Z","steps":["trace[75783786] 'agreement among raft nodes before linearized reading' (duration: 231.443847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T05:42:45.408854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.255188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-04-14T05:42:45.408915Z","caller":"traceutil/trace.go:171","msg":"trace[538486466] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4870; }","duration":"282.422602ms","start":"2026-04-14T05:42:45.126477Z","end":"2026-04-14T05:42:45.4089Z","steps":["trace[538486466] 'agreement among raft nodes before linearized reading' (duration: 281.826797ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:45.638673Z","caller":"traceutil/trace.go:171","msg":"trace[1930751273] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"192.55744ms","start":"2026-04-14T05:42:45.446089Z","end":"2026-04-14T05:42:45.638647Z","steps":["trace[1930751273] 'process raft request' (duration: 127.94799ms)","trace[1930751273] 'compare' (duration: 64.444166ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T05:42:45.639007Z","caller":"traceutil/trace.go:171","msg":"trace[1485296874] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"192.500729ms","start":"2026-04-14T05:42:45.446483Z","end":"2026-04-14T05:42:45.638984Z","steps":["trace[1485296874] 'process raft request' (duration: 192.201681ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:45.63902Z","caller":"traceutil/trace.go:171","msg":"trace[1237560755] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"192.619112ms","start":"2026-04-14T05:42:45.446361Z","end":"2026-04-14T05:42:45.63898Z","steps":["trace[1237560755] 'process raft request' (duration: 192.279363ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:45.63877Z","caller":"traceutil/trace.go:171","msg":"trace[1769676392] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"191.222066ms","start":"2026-04-14T05:42:45.447536Z","end":"2026-04-14T05:42:45.638758Z","steps":["trace[1769676392] 'process raft request' (duration: 191.183375ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:42:45.639205Z","caller":"traceutil/trace.go:171","msg":"trace[641382820] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"192.903069ms","start":"2026-04-14T05:42:45.446284Z","end":"2026-04-14T05:42:45.639187Z","steps":["trace[641382820] 'process raft request' (duration: 192.305094ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T05:44:13.554167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2905} {"level":"info","ts":"2026-04-14T05:44:13.62156Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2905,"took":"65.830128ms","hash":3240451233,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":29368320,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-14T05:44:13.621634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3240451233,"revision":2905,"compact-revision":-1} {"level":"info","ts":"2026-04-14T05:49:13.563317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5621} {"level":"info","ts":"2026-04-14T05:49:13.676357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5621,"took":"111.632853ms","hash":3079683529,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":18345984,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-14T05:49:13.676419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3079683529,"revision":5621,"compact-revision":2905}