{"level":"warn","ts":"2026-06-09T22:15:08.766432Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:15:08.766516Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.225:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.225:2380","--initial-cluster=instance=https://199.19.213.225:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.225:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.225: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-06-09T22:15:08.766576Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:15:08.766588Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.225:2380"]} {"level":"info","ts":"2026-06-09T22:15:08.766612Z","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-06-09T22:15:08.767371Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"]} {"level":"info","ts":"2026-06-09T22:15:08.767456Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.225:2380"],"listen-peer-urls":["https://199.19.213.225:2380"],"advertise-client-urls":["https://199.19.213.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.225: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-06-09T22:15:08.771654Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.992011ms"} {"level":"info","ts":"2026-06-09T22:15:08.777463Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b7b89c171c5fe95c","cluster-id":"5746414c29a21eae"} {"level":"info","ts":"2026-06-09T22:15:08.781967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:15:08.782003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became follower at term 0"} {"level":"info","ts":"2026-06-09T22:15:08.782025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b7b89c171c5fe95c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:15:08.782041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became follower at term 1"} {"level":"info","ts":"2026-06-09T22:15:08.782082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=(13238502727729801564)"} {"level":"warn","ts":"2026-06-09T22:15:08.792748Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:15:08.794345Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:15:08.795779Z","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-06-09T22:15:08.798364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b7b89c171c5fe95c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:15:08.798684Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b7b89c171c5fe95c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:15:08.798835Z","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-06-09T22:15:08.798904Z","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-06-09T22:15:08.798916Z","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-06-09T22:15:08.799685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c switched to configuration voters=(13238502727729801564)"} {"level":"info","ts":"2026-06-09T22:15:08.799796Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5746414c29a21eae","local-member-id":"b7b89c171c5fe95c","added-peer-id":"b7b89c171c5fe95c","added-peer-peer-urls":["https://199.19.213.225:2380"]} {"level":"info","ts":"2026-06-09T22:15:08.805698Z","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-06-09T22:15:08.805936Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.225:2380"} {"level":"info","ts":"2026-06-09T22:15:08.806001Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.225:2380"} {"level":"info","ts":"2026-06-09T22:15:08.80606Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b7b89c171c5fe95c","initial-advertise-peer-urls":["https://199.19.213.225:2380"],"listen-peer-urls":["https://199.19.213.225:2380"],"advertise-client-urls":["https://199.19.213.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:15:08.806146Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:15:09.483701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:15:09.483775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:15:09.483806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c received MsgPreVoteResp from b7b89c171c5fe95c at term 1"} {"level":"info","ts":"2026-06-09T22:15:09.48382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:15:09.483828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c received MsgVoteResp from b7b89c171c5fe95c at term 2"} {"level":"info","ts":"2026-06-09T22:15:09.483838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b7b89c171c5fe95c became leader at term 2"} {"level":"info","ts":"2026-06-09T22:15:09.48385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b7b89c171c5fe95c elected leader b7b89c171c5fe95c at term 2"} {"level":"info","ts":"2026-06-09T22:15:09.493891Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:09.494827Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b7b89c171c5fe95c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.225:2379]}","request-path":"/0/members/b7b89c171c5fe95c/attributes","cluster-id":"5746414c29a21eae","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:15:09.49484Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:15:09.495056Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:15:09.495618Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:15:09.495645Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:15:09.495724Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5746414c29a21eae","local-member-id":"b7b89c171c5fe95c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:09.495899Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:09.495958Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:15:09.497425Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:15:09.498575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.225:2379"} {"level":"warn","ts":"2026-06-09T22:15:13.171543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.407123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:15:13.1717Z","caller":"traceutil/trace.go:171","msg":"trace[1833746592] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"231.219463ms","start":"2026-06-09T22:15:12.940464Z","end":"2026-06-09T22:15:13.171683Z","steps":["trace[1833746592] 'compare' (duration: 228.26679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:15:13.548953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.829471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:15:13.549066Z","caller":"traceutil/trace.go:171","msg":"trace[1032878831] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"370.181153ms","start":"2026-06-09T22:15:13.178867Z","end":"2026-06-09T22:15:13.549049Z","steps":["trace[1032878831] 'process raft request' (duration: 231.192681ms)","trace[1032878831] 'compare' (duration: 138.675138ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:15:13.549119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:15:13.178848Z","time spent":"370.251894ms","remote":"127.0.0.1:55116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11444,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:15:45.462868Z","caller":"traceutil/trace.go:171","msg":"trace[1036659550] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"105.829621ms","start":"2026-06-09T22:15:45.35701Z","end":"2026-06-09T22:15:45.462839Z","steps":["trace[1036659550] 'process raft request' (duration: 77.609793ms)","trace[1036659550] 'compare' (duration: 27.969296ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:15:45.698147Z","caller":"traceutil/trace.go:171","msg":"trace[984339252] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"173.559264ms","start":"2026-06-09T22:15:45.52456Z","end":"2026-06-09T22:15:45.698119Z","steps":["trace[984339252] 'process raft request' (duration: 170.800356ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:15:45.701083Z","caller":"traceutil/trace.go:171","msg":"trace[1753340195] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"170.954897ms","start":"2026-06-09T22:15:45.5301Z","end":"2026-06-09T22:15:45.701055Z","steps":["trace[1753340195] 'process raft request' (duration: 170.684925ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:15:45.7014Z","caller":"traceutil/trace.go:171","msg":"trace[1432372347] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"128.592794ms","start":"2026-06-09T22:15:45.572786Z","end":"2026-06-09T22:15:45.701379Z","steps":["trace[1432372347] 'process raft request' (duration: 128.468933ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:15:45.701526Z","caller":"traceutil/trace.go:171","msg":"trace[1057596934] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"153.987484ms","start":"2026-06-09T22:15:45.547532Z","end":"2026-06-09T22:15:45.70152Z","steps":["trace[1057596934] 'process raft request' (duration: 153.478919ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:15:50.975067Z","caller":"traceutil/trace.go:171","msg":"trace[2009522384] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"159.216522ms","start":"2026-06-09T22:15:50.815831Z","end":"2026-06-09T22:15:50.975048Z","steps":["trace[2009522384] 'process raft request' (duration: 158.116402ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:15:51.204978Z","caller":"traceutil/trace.go:171","msg":"trace[1985783840] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"108.486595ms","start":"2026-06-09T22:15:51.096468Z","end":"2026-06-09T22:15:51.204954Z","steps":["trace[1985783840] 'process raft request' (duration: 107.839038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:15:51.705092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.082416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:15:51.705261Z","caller":"traceutil/trace.go:171","msg":"trace[138722335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"418.291009ms","start":"2026-06-09T22:15:51.286952Z","end":"2026-06-09T22:15:51.705243Z","steps":["trace[138722335] 'range keys from in-memory index tree' (duration: 418.022296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:15:51.705305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:15:51.286937Z","time spent":"418.355539ms","remote":"127.0.0.1:55012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T22:15:51.73155Z","caller":"traceutil/trace.go:171","msg":"trace[132477117] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"117.349923ms","start":"2026-06-09T22:15:51.614171Z","end":"2026-06-09T22:15:51.731521Z","steps":["trace[132477117] 'read index received' (duration: 116.579225ms)","trace[132477117] 'applied index is now lower than readState.Index' (duration: 769.618µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:15:51.731838Z","caller":"traceutil/trace.go:171","msg":"trace[851122813] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"241.896836ms","start":"2026-06-09T22:15:51.489915Z","end":"2026-06-09T22:15:51.731811Z","steps":["trace[851122813] 'process raft request' (duration: 241.045867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:15:51.731874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.680586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-chbcf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-09T22:15:51.732035Z","caller":"traceutil/trace.go:171","msg":"trace[1223990953] range","detail":"{range_begin:/registry/pods/kube-system/cilium-chbcf; range_end:; response_count:1; response_revision:591; }","duration":"117.876648ms","start":"2026-06-09T22:15:51.614139Z","end":"2026-06-09T22:15:51.732016Z","steps":["trace[1223990953] 'agreement among raft nodes before linearized reading' (duration: 117.568595ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:22.545869Z","caller":"traceutil/trace.go:171","msg":"trace[1477426165] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"137.839327ms","start":"2026-06-09T22:17:22.407992Z","end":"2026-06-09T22:17:22.545831Z","steps":["trace[1477426165] 'read index received' (duration: 131.884628ms)","trace[1477426165] 'applied index is now lower than readState.Index' (duration: 5.953319ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:17:22.546192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.382371ms","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-06-09T22:17:22.546234Z","caller":"traceutil/trace.go:171","msg":"trace[841902341] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1815; }","duration":"138.477863ms","start":"2026-06-09T22:17:22.407743Z","end":"2026-06-09T22:17:22.54622Z","steps":["trace[841902341] 'agreement among raft nodes before linearized reading' (duration: 138.194676ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:57.02052Z","caller":"traceutil/trace.go:171","msg":"trace[89697796] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"123.88806ms","start":"2026-06-09T22:17:56.896601Z","end":"2026-06-09T22:17:57.020489Z","steps":["trace[89697796] 'process raft request' (duration: 123.684406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:17:57.403742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.171423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T22:17:57.403826Z","caller":"traceutil/trace.go:171","msg":"trace[794723380] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2060; }","duration":"130.276845ms","start":"2026-06-09T22:17:57.273531Z","end":"2026-06-09T22:17:57.403808Z","steps":["trace[794723380] 'count revisions from in-memory index tree' (duration: 130.05043ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:57.505792Z","caller":"traceutil/trace.go:171","msg":"trace[1248802210] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"230.276611ms","start":"2026-06-09T22:17:57.275483Z","end":"2026-06-09T22:17:57.50576Z","steps":["trace[1248802210] 'process raft request' (duration: 230.074967ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:17:57.507268Z","caller":"traceutil/trace.go:171","msg":"trace[353129011] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"199.439588ms","start":"2026-06-09T22:17:57.307758Z","end":"2026-06-09T22:17:57.507197Z","steps":["trace[353129011] 'process raft request' (duration: 198.968639ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:18:25.730196Z","caller":"traceutil/trace.go:171","msg":"trace[838028514] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"120.807111ms","start":"2026-06-09T22:18:25.609351Z","end":"2026-06-09T22:18:25.730158Z","steps":["trace[838028514] 'process raft request' (duration: 68.896042ms)","trace[838028514] 'compare' (duration: 51.758616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:19:02.445317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.7009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:19:02.445392Z","caller":"traceutil/trace.go:171","msg":"trace[862746183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2518; }","duration":"157.897213ms","start":"2026-06-09T22:19:02.28748Z","end":"2026-06-09T22:19:02.445377Z","steps":["trace[862746183] 'range keys from in-memory index tree' (duration: 157.607799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:34.408907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.093947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:19:34.409006Z","caller":"traceutil/trace.go:171","msg":"trace[735713779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2692; }","duration":"121.24096ms","start":"2026-06-09T22:19:34.287741Z","end":"2026-06-09T22:19:34.408982Z","steps":["trace[735713779] 'range keys from in-memory index tree' (duration: 120.990306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:19:34.409309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.950873ms","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-06-09T22:19:34.409387Z","caller":"traceutil/trace.go:171","msg":"trace[641052116] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2692; }","duration":"118.071774ms","start":"2026-06-09T22:19:34.291295Z","end":"2026-06-09T22:19:34.409367Z","steps":["trace[641052116] 'range keys from in-memory index tree' (duration: 117.787121ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:25.382019Z","caller":"traceutil/trace.go:171","msg":"trace[1095269422] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"110.8253ms","start":"2026-06-09T22:23:25.271128Z","end":"2026-06-09T22:23:25.381953Z","steps":["trace[1095269422] 'process raft request' (duration: 110.593205ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:25.532412Z","caller":"traceutil/trace.go:171","msg":"trace[1527870048] linearizableReadLoop","detail":"{readStateIndex:4848; appliedIndex:4847; }","duration":"150.452293ms","start":"2026-06-09T22:23:25.381929Z","end":"2026-06-09T22:23:25.532381Z","steps":["trace[1527870048] 'read index received' (duration: 143.401082ms)","trace[1527870048] 'applied index is now lower than readState.Index' (duration: 7.049771ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:23:25.532557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.285467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:23:25.532575Z","caller":"traceutil/trace.go:171","msg":"trace[1037043761] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"226.616031ms","start":"2026-06-09T22:23:25.305938Z","end":"2026-06-09T22:23:25.532554Z","steps":["trace[1037043761] 'process raft request' (duration: 219.454458ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:25.53261Z","caller":"traceutil/trace.go:171","msg":"trace[1763740986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4671; }","duration":"245.3711ms","start":"2026-06-09T22:23:25.287223Z","end":"2026-06-09T22:23:25.532594Z","steps":["trace[1763740986] 'agreement among raft nodes before linearized reading' (duration: 245.275957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:38.301887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.983636ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-09T22:23:38.301999Z","caller":"traceutil/trace.go:171","msg":"trace[249718811] linearizableReadLoop","detail":"{readStateIndex:5034; appliedIndex:5033; }","duration":"367.935993ms","start":"2026-06-09T22:23:37.934046Z","end":"2026-06-09T22:23:38.301982Z","steps":["trace[249718811] 'read index received' (duration: 47.787482ms)","trace[249718811] 'applied index is now lower than readState.Index' (duration: 320.147101ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:23:38.302366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.306811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:10126"} {"level":"info","ts":"2026-06-09T22:23:38.302445Z","caller":"traceutil/trace.go:171","msg":"trace[388064871] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4851; }","duration":"368.425753ms","start":"2026-06-09T22:23:37.934002Z","end":"2026-06-09T22:23:38.302427Z","steps":["trace[388064871] 'agreement among raft nodes before linearized reading' (duration: 368.133067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:38.30255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:37.933985Z","time spent":"368.551856ms","remote":"127.0.0.1:55186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":10149,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-09T22:23:38.302564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.300241ms","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-06-09T22:23:38.302663Z","caller":"traceutil/trace.go:171","msg":"trace[1112003357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4851; }","duration":"117.457434ms","start":"2026-06-09T22:23:38.185193Z","end":"2026-06-09T22:23:38.30265Z","steps":["trace[1112003357] 'agreement among raft nodes before linearized reading' (duration: 117.208949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:38.302658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.998319ms","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-06-09T22:23:38.302732Z","caller":"traceutil/trace.go:171","msg":"trace[306323372] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4851; }","duration":"248.138853ms","start":"2026-06-09T22:23:38.054571Z","end":"2026-06-09T22:23:38.30271Z","steps":["trace[306323372] 'agreement among raft nodes before linearized reading' (duration: 247.939498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:38.303004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.547633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vvc7w\" ","response":"range_response_count:1 size:9942"} {"level":"info","ts":"2026-06-09T22:23:38.303059Z","caller":"traceutil/trace.go:171","msg":"trace[1449565249] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vvc7w; range_end:; response_count:1; response_revision:4851; }","duration":"317.641194ms","start":"2026-06-09T22:23:37.985404Z","end":"2026-06-09T22:23:38.303046Z","steps":["trace[1449565249] 'agreement among raft nodes before linearized reading' (duration: 316.720854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:38.303134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:37.985389Z","time spent":"317.704716ms","remote":"127.0.0.1:55190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9965,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vvc7w\" "} {"level":"info","ts":"2026-06-09T22:23:38.42912Z","caller":"traceutil/trace.go:171","msg":"trace[619903002] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"115.991132ms","start":"2026-06-09T22:23:38.313105Z","end":"2026-06-09T22:23:38.429096Z","steps":["trace[619903002] 'process raft request' (duration: 113.679951ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:09.525544Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876} {"level":"info","ts":"2026-06-09T22:25:09.616446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"89.390517ms","hash":1136482863,"current-db-size-bytes":54394880,"current-db-size":"54 MB","current-db-size-in-use-bytes":29523968,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T22:25:09.616578Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1136482863,"revision":2876,"compact-revision":-1} {"level":"info","ts":"2026-06-09T22:27:45.967094Z","caller":"traceutil/trace.go:171","msg":"trace[2065215878] transaction","detail":"{read_only:false; response_revision:6652; number_of_response:1; }","duration":"119.281308ms","start":"2026-06-09T22:27:45.847789Z","end":"2026-06-09T22:27:45.967071Z","steps":["trace[2065215878] 'process raft request' (duration: 50.393406ms)","trace[2065215878] 'compare' (duration: 68.7828ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:30:09.531377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5602} {"level":"info","ts":"2026-06-09T22:30:09.600321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5602,"took":"67.436135ms","hash":2571865652,"current-db-size-bytes":54394880,"current-db-size":"54 MB","current-db-size-in-use-bytes":18173952,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T22:30:09.600376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2571865652,"revision":5602,"compact-revision":2876}