{"level":"warn","ts":"2026-07-02T00:18:08.511438Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-02T00:18:08.511633Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07-02T00:18:08.51175Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-02T00:18:08.511788Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]}
{"level":"info","ts":"2026-07-02T00:18:08.511829Z","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-07-02T00:18:08.512798Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]}
{"level":"info","ts":"2026-07-02T00:18:08.512923Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07-02T00:18:08.516443Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.246247ms"}
{"level":"info","ts":"2026-07-02T00:18:08.522037Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"}
{"level":"info","ts":"2026-07-02T00:18:08.522155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"}
{"level":"info","ts":"2026-07-02T00:18:08.522198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"}
{"level":"info","ts":"2026-07-02T00:18:08.522231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-02T00:18:08.522284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"}
{"level":"info","ts":"2026-07-02T00:18:08.522364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"}
{"level":"warn","ts":"2026-07-02T00:18:08.530162Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-02T00:18:08.532116Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-02T00:18:08.533129Z","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-07-02T00:18:08.535286Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-02T00:18:08.535518Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-02T00:18:08.535532Z","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-07-02T00:18:08.535638Z","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-07-02T00:18:08.535655Z","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-07-02T00:18:08.537307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"}
{"level":"info","ts":"2026-07-02T00:18:08.53789Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]}
{"level":"info","ts":"2026-07-02T00:18:08.540278Z","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-07-02T00:18:08.540446Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"}
{"level":"info","ts":"2026-07-02T00:18:08.540488Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"}
{"level":"info","ts":"2026-07-02T00:18:08.540735Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-02T00:18:08.540903Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-02T00:18:08.82319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"}
{"level":"info","ts":"2026-07-02T00:18:08.82325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-02T00:18:08.823281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"}
{"level":"info","ts":"2026-07-02T00:18:08.823296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"}
{"level":"info","ts":"2026-07-02T00:18:08.823303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"}
{"level":"info","ts":"2026-07-02T00:18:08.823318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"}
{"level":"info","ts":"2026-07-02T00:18:08.823346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"}
{"level":"info","ts":"2026-07-02T00:18:08.824147Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-02T00:18:08.824172Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-02T00:18:08.824376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-02T00:18:08.82442Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-02T00:18:08.824794Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-02T00:18:08.824846Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-02T00:18:08.825192Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-02T00:18:08.825355Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-02T00:18:08.825421Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-02T00:18:08.827971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"}
{"level":"info","ts":"2026-07-02T00:18:08.82877Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-02T00:18:42.878923Z","caller":"traceutil/trace.go:171","msg":"trace[1840405238] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"107.794237ms","start":"2026-07-02T00:18:42.771096Z","end":"2026-07-02T00:18:42.87889Z","steps":["trace[1840405238] 'process raft request'  (duration: 107.388138ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:18:44.300828Z","caller":"traceutil/trace.go:171","msg":"trace[75006492] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"100.544804ms","start":"2026-07-02T00:18:44.200248Z","end":"2026-07-02T00:18:44.300793Z","steps":["trace[75006492] 'process raft request'  (duration: 99.939002ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:18:44.310499Z","caller":"traceutil/trace.go:171","msg":"trace[736309208] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"100.089965ms","start":"2026-07-02T00:18:44.210398Z","end":"2026-07-02T00:18:44.310488Z","steps":["trace[736309208] 'process raft request'  (duration: 99.503783ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:18:50.217067Z","caller":"traceutil/trace.go:171","msg":"trace[1248923044] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"161.122055ms","start":"2026-07-02T00:18:50.055918Z","end":"2026-07-02T00:18:50.21704Z","steps":["trace[1248923044] 'process raft request'  (duration: 160.665696ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:18:50.377088Z","caller":"traceutil/trace.go:171","msg":"trace[1487355845] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"304.567261ms","start":"2026-07-02T00:18:50.07249Z","end":"2026-07-02T00:18:50.377057Z","steps":["trace[1487355845] 'process raft request'  (duration: 249.527088ms)","trace[1487355845] 'compare'  (duration: 54.89229ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-02T00:18:50.378046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:18:50.072476Z","time spent":"304.755835ms","remote":"127.0.0.1:49470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:609 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-02T00:18:50.381806Z","caller":"traceutil/trace.go:171","msg":"trace[1525601340] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"112.220528ms","start":"2026-07-02T00:18:50.269555Z","end":"2026-07-02T00:18:50.381776Z","steps":["trace[1525601340] 'process raft request'  (duration: 112.122757ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:18:50.911969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.280538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v997k\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-07-02T00:18:50.912072Z","caller":"traceutil/trace.go:171","msg":"trace[409304044] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v997k; range_end:; response_count:1; response_revision:627; }","duration":"425.423461ms","start":"2026-07-02T00:18:50.486632Z","end":"2026-07-02T00:18:50.912055Z","steps":["trace[409304044] 'range keys from in-memory index tree'  (duration: 425.175696ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:18:50.91212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:18:50.486612Z","time spent":"425.499202ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-v997k\" "}
{"level":"info","ts":"2026-07-02T00:18:50.914784Z","caller":"traceutil/trace.go:171","msg":"trace[1346235774] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"140.106965ms","start":"2026-07-02T00:18:50.774632Z","end":"2026-07-02T00:18:50.914739Z","steps":["trace[1346235774] 'process raft request'  (duration: 138.545986ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:19:06.60153Z","caller":"traceutil/trace.go:171","msg":"trace[1989272252] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"142.616527ms","start":"2026-07-02T00:19:06.458893Z","end":"2026-07-02T00:19:06.60151Z","steps":["trace[1989272252] 'read index received'  (duration: 142.430584ms)","trace[1989272252] 'applied index is now lower than readState.Index'  (duration: 185.033µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-02T00:19:06.601673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.760899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-02T00:19:06.601737Z","caller":"traceutil/trace.go:171","msg":"trace[1918873732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"142.877722ms","start":"2026-07-02T00:19:06.45885Z","end":"2026-07-02T00:19:06.601728Z","steps":["trace[1918873732] 'agreement among raft nodes before linearized reading'  (duration: 142.75813ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:19:06.602003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.085197ms","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-07-02T00:19:06.602067Z","caller":"traceutil/trace.go:171","msg":"trace[107483626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:793; }","duration":"111.207749ms","start":"2026-07-02T00:19:06.490845Z","end":"2026-07-02T00:19:06.602053Z","steps":["trace[107483626] 'agreement among raft nodes before linearized reading'  (duration: 111.008916ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:19:06.602203Z","caller":"traceutil/trace.go:171","msg":"trace[396712050] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"148.918111ms","start":"2026-07-02T00:19:06.453253Z","end":"2026-07-02T00:19:06.602171Z","steps":["trace[396712050] 'process raft request'  (duration: 148.135168ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:20:29.399215Z","caller":"traceutil/trace.go:171","msg":"trace[1227369840] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"335.478381ms","start":"2026-07-02T00:20:29.063704Z","end":"2026-07-02T00:20:29.399183Z","steps":["trace[1227369840] 'process raft request'  (duration: 278.44445ms)","trace[1227369840] 'compare'  (duration: 56.9227ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-02T00:20:29.399399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:29.063635Z","time spent":"335.676174ms","remote":"127.0.0.1:49470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1794 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-07-02T00:20:29.470436Z","caller":"traceutil/trace.go:171","msg":"trace[1759625519] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1929; }","duration":"384.579715ms","start":"2026-07-02T00:20:29.085835Z","end":"2026-07-02T00:20:29.470415Z","steps":["trace[1759625519] 'read index received'  (duration: 256.339493ms)","trace[1759625519] 'applied index is now lower than readState.Index'  (duration: 128.239202ms)"],"step_count":2}
{"level":"info","ts":"2026-07-02T00:20:29.47053Z","caller":"traceutil/trace.go:171","msg":"trace[1445837436] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"405.841495ms","start":"2026-07-02T00:20:29.06467Z","end":"2026-07-02T00:20:29.470511Z","steps":["trace[1445837436] 'process raft request'  (duration: 405.602633ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:20:29.470678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:29.064646Z","time spent":"405.961346ms","remote":"127.0.0.1:49470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1793 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-02T00:20:29.47092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.07902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-02T00:20:29.471002Z","caller":"traceutil/trace.go:171","msg":"trace[1342560378] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1868; }","duration":"385.190891ms","start":"2026-07-02T00:20:29.08579Z","end":"2026-07-02T00:20:29.470981Z","steps":["trace[1342560378] 'agreement among raft nodes before linearized reading'  (duration: 384.907248ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:20:29.471345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:20:29.085772Z","time spent":"385.422354ms","remote":"127.0.0.1:49316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":667,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-02T00:20:34.742479Z","caller":"traceutil/trace.go:171","msg":"trace[457397866] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"107.417508ms","start":"2026-07-02T00:20:34.635035Z","end":"2026-07-02T00:20:34.742452Z","steps":["trace[457397866] 'process raft request'  (duration: 107.249797ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:20:37.721645Z","caller":"traceutil/trace.go:171","msg":"trace[1610287491] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"142.782364ms","start":"2026-07-02T00:20:37.578836Z","end":"2026-07-02T00:20:37.721619Z","steps":["trace[1610287491] 'process raft request'  (duration: 142.651522ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:20:37.723169Z","caller":"traceutil/trace.go:171","msg":"trace[179152501] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"144.014466ms","start":"2026-07-02T00:20:37.579125Z","end":"2026-07-02T00:20:37.72314Z","steps":["trace[179152501] 'process raft request'  (duration: 143.798554ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:20:37.723048Z","caller":"traceutil/trace.go:171","msg":"trace[275048128] linearizableReadLoop","detail":"{readStateIndex:2031; appliedIndex:2029; }","duration":"104.719951ms","start":"2026-07-02T00:20:37.618308Z","end":"2026-07-02T00:20:37.723028Z","steps":["trace[275048128] 'read index received'  (duration: 103.277276ms)","trace[275048128] 'applied index is now lower than readState.Index'  (duration: 1.442005ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-02T00:20:37.72346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.130334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-02T00:20:37.723539Z","caller":"traceutil/trace.go:171","msg":"trace[1738747267] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1964; }","duration":"105.252715ms","start":"2026-07-02T00:20:37.618267Z","end":"2026-07-02T00:20:37.72352Z","steps":["trace[1738747267] 'agreement among raft nodes before linearized reading'  (duration: 105.021603ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:21:01.223318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.406548ms","expected-duration":"100ms","prefix":"","request":"header:<ID:6605829714050030425 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2124 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:473 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-02T00:21:01.223588Z","caller":"traceutil/trace.go:171","msg":"trace[940078242] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"154.085686ms","start":"2026-07-02T00:21:01.069453Z","end":"2026-07-02T00:21:01.223539Z","steps":["trace[940078242] 'process raft request'  (duration: 16.220824ms)","trace[940078242] 'compare'  (duration: 137.196166ms)"],"step_count":2}
{"level":"info","ts":"2026-07-02T00:21:01.659Z","caller":"traceutil/trace.go:171","msg":"trace[1840041687] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"116.476552ms","start":"2026-07-02T00:21:01.542496Z","end":"2026-07-02T00:21:01.658972Z","steps":["trace[1840041687] 'process raft request'  (duration: 116.31629ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:43.577702Z","caller":"traceutil/trace.go:171","msg":"trace[551601876] transaction","detail":"{read_only:false; response_revision:4357; number_of_response:1; }","duration":"107.564537ms","start":"2026-07-02T00:24:43.470115Z","end":"2026-07-02T00:24:43.57768Z","steps":["trace[551601876] 'process raft request'  (duration: 103.821325ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.502082Z","caller":"traceutil/trace.go:171","msg":"trace[2112820909] linearizableReadLoop","detail":"{readStateIndex:4604; appliedIndex:4603; }","duration":"158.288866ms","start":"2026-07-02T00:24:46.343767Z","end":"2026-07-02T00:24:46.502056Z","steps":["trace[2112820909] 'read index received'  (duration: 150.123361ms)","trace[2112820909] 'applied index is now lower than readState.Index'  (duration: 8.160774ms)"],"step_count":2}
{"level":"info","ts":"2026-07-02T00:24:46.502218Z","caller":"traceutil/trace.go:171","msg":"trace[232029872] transaction","detail":"{read_only:false; response_revision:4409; number_of_response:1; }","duration":"158.460998ms","start":"2026-07-02T00:24:46.343746Z","end":"2026-07-02T00:24:46.502207Z","steps":["trace[232029872] 'process raft request'  (duration: 150.128621ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:24:46.502494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.707102ms","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-07-02T00:24:46.502577Z","caller":"traceutil/trace.go:171","msg":"trace[774063573] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4409; }","duration":"158.826364ms","start":"2026-07-02T00:24:46.343733Z","end":"2026-07-02T00:24:46.50256Z","steps":["trace[774063573] 'agreement among raft nodes before linearized reading'  (duration: 158.518799ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.507819Z","caller":"traceutil/trace.go:171","msg":"trace[544652995] transaction","detail":"{read_only:false; response_revision:4410; number_of_response:1; }","duration":"163.960078ms","start":"2026-07-02T00:24:46.343843Z","end":"2026-07-02T00:24:46.507803Z","steps":["trace[544652995] 'process raft request'  (duration: 163.689744ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.508079Z","caller":"traceutil/trace.go:171","msg":"trace[1455003622] transaction","detail":"{read_only:false; response_revision:4415; number_of_response:1; }","duration":"155.715603ms","start":"2026-07-02T00:24:46.352326Z","end":"2026-07-02T00:24:46.508041Z","steps":["trace[1455003622] 'process raft request'  (duration: 155.404908ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.508492Z","caller":"traceutil/trace.go:171","msg":"trace[1487058445] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"164.58727ms","start":"2026-07-02T00:24:46.343892Z","end":"2026-07-02T00:24:46.508479Z","steps":["trace[1487058445] 'process raft request'  (duration: 163.708655ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.508712Z","caller":"traceutil/trace.go:171","msg":"trace[350950543] transaction","detail":"{read_only:false; response_revision:4412; number_of_response:1; }","duration":"164.798893ms","start":"2026-07-02T00:24:46.343892Z","end":"2026-07-02T00:24:46.508691Z","steps":["trace[350950543] 'process raft request'  (duration: 163.743065ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.508784Z","caller":"traceutil/trace.go:171","msg":"trace[1485273582] transaction","detail":"{read_only:false; response_revision:4413; number_of_response:1; }","duration":"164.860284ms","start":"2026-07-02T00:24:46.343915Z","end":"2026-07-02T00:24:46.508775Z","steps":["trace[1485273582] 'process raft request'  (duration: 163.762545ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:46.508679Z","caller":"traceutil/trace.go:171","msg":"trace[1174060959] transaction","detail":"{read_only:false; response_revision:4414; number_of_response:1; }","duration":"164.709892ms","start":"2026-07-02T00:24:46.343938Z","end":"2026-07-02T00:24:46.508648Z","steps":["trace[1174060959] 'process raft request'  (duration: 163.762145ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:24:53.00588Z","caller":"traceutil/trace.go:171","msg":"trace[1513502211] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"114.362879ms","start":"2026-07-02T00:24:52.891482Z","end":"2026-07-02T00:24:53.005845Z","steps":["trace[1513502211] 'process raft request'  (duration: 114.119876ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:25:06.113822Z","caller":"traceutil/trace.go:171","msg":"trace[616013836] linearizableReadLoop","detail":"{readStateIndex:4942; appliedIndex:4941; }","duration":"225.968339ms","start":"2026-07-02T00:25:05.887831Z","end":"2026-07-02T00:25:06.1138Z","steps":["trace[616013836] 'read index received'  (duration: 225.755816ms)","trace[616013836] 'applied index is now lower than readState.Index'  (duration: 211.523µs)"],"step_count":2}
{"level":"info","ts":"2026-07-02T00:25:06.113872Z","caller":"traceutil/trace.go:171","msg":"trace[1442281682] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"328.334925ms","start":"2026-07-02T00:25:05.785516Z","end":"2026-07-02T00:25:06.113851Z","steps":["trace[1442281682] 'process raft request'  (duration: 328.132422ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-02T00:25:06.113994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:25:05.785498Z","time spent":"328.422056ms","remote":"127.0.0.1:49316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:4714 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-02T00:25:06.115051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.000265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3198"}
{"level":"info","ts":"2026-07-02T00:25:06.115175Z","caller":"traceutil/trace.go:171","msg":"trace[965863741] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4734; }","duration":"227.363292ms","start":"2026-07-02T00:25:05.887785Z","end":"2026-07-02T00:25:06.115149Z","steps":["trace[965863741] 'agreement among raft nodes before linearized reading'  (duration: 226.127552ms)"],"step_count":1}
{"level":"info","ts":"2026-07-02T00:28:09.111176Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3196}
{"level":"info","ts":"2026-07-02T00:28:09.213556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3196,"took":"101.21838ms","hash":3457307937,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":31367168,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-02T00:28:09.213653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3457307937,"revision":3196,"compact-revision":-1}