{"level":"warn","ts":"2026-08-13T07:49:31.760677Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-13T07:49:31.760747Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.181: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.181:2380","--initial-cluster=instance=https://199.19.213.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.181: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-08-13T07:49:31.760805Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-13T07:49:31.760814Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.181:2380"]}
{"level":"info","ts":"2026-08-13T07:49:31.760833Z","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-08-13T07:49:31.761422Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"]}
{"level":"info","ts":"2026-08-13T07:49:31.761496Z","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.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.181: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-08-13T07:49:31.764895Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.198655ms"}
{"level":"info","ts":"2026-08-13T07:49:31.770127Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1a532052a1358225","cluster-id":"b34324311008a1d3"}
{"level":"info","ts":"2026-08-13T07:49:31.770249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-13T07:49:31.770278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 0"}
{"level":"info","ts":"2026-08-13T07:49:31.770302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1a532052a1358225 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-13T07:49:31.770322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 1"}
{"level":"info","ts":"2026-08-13T07:49:31.770381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"}
{"level":"warn","ts":"2026-08-13T07:49:31.777809Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-13T07:49:31.779546Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-13T07:49:31.780507Z","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-08-13T07:49:31.782055Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1a532052a1358225","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-13T07:49:31.7839Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1a532052a1358225","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-13T07:49:31.783368Z","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-08-13T07:49:31.784089Z","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-08-13T07:49:31.784314Z","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-08-13T07:49:31.786059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"}
{"level":"info","ts":"2026-08-13T07:49:31.787033Z","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-08-13T07:49:31.787274Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1a532052a1358225","initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-13T07:49:31.787306Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-13T07:49:31.787415Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.181:2380"}
{"level":"info","ts":"2026-08-13T07:49:31.787432Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.181:2380"}
{"level":"info","ts":"2026-08-13T07:49:31.792511Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","added-peer-id":"1a532052a1358225","added-peer-peer-urls":["https://199.19.213.181:2380"]}
{"level":"info","ts":"2026-08-13T07:49:32.170827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-13T07:49:32.171037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-13T07:49:32.171097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgPreVoteResp from 1a532052a1358225 at term 1"}
{"level":"info","ts":"2026-08-13T07:49:32.17112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became candidate at term 2"}
{"level":"info","ts":"2026-08-13T07:49:32.171131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgVoteResp from 1a532052a1358225 at term 2"}
{"level":"info","ts":"2026-08-13T07:49:32.171149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became leader at term 2"}
{"level":"info","ts":"2026-08-13T07:49:32.171163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1a532052a1358225 elected leader 1a532052a1358225 at term 2"}
{"level":"info","ts":"2026-08-13T07:49:32.172546Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T07:49:32.173306Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1a532052a1358225","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.181:2379]}","request-path":"/0/members/1a532052a1358225/attributes","cluster-id":"b34324311008a1d3","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-13T07:49:32.173458Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-13T07:49:32.173568Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-13T07:49:32.174176Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T07:49:32.174407Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T07:49:32.174453Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T07:49:32.179019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-13T07:49:32.179042Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-13T07:49:32.180357Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.181:2379"}
{"level":"info","ts":"2026-08-13T07:49:32.180993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-13T07:50:17.019911Z","caller":"traceutil/trace.go:171","msg":"trace[1280502590] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"121.480278ms","start":"2026-08-13T07:50:16.898411Z","end":"2026-08-13T07:50:17.019892Z","steps":["trace[1280502590] 'read index received'  (duration: 119.946005ms)","trace[1280502590] 'applied index is now lower than readState.Index'  (duration: 1.533093ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:50:17.019998Z","caller":"traceutil/trace.go:171","msg":"trace[306917586] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"212.970533ms","start":"2026-08-13T07:50:16.806992Z","end":"2026-08-13T07:50:17.019962Z","steps":["trace[306917586] 'process raft request'  (duration: 211.568752ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:50:17.02008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.660242ms","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-08-13T07:50:17.020131Z","caller":"traceutil/trace.go:171","msg":"trace[875153532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"121.770135ms","start":"2026-08-13T07:50:16.898352Z","end":"2026-08-13T07:50:17.020123Z","steps":["trace[875153532] 'agreement among raft nodes before linearized reading'  (duration: 121.627661ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:50:17.262734Z","caller":"traceutil/trace.go:171","msg":"trace[699841158] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"182.892652ms","start":"2026-08-13T07:50:17.079823Z","end":"2026-08-13T07:50:17.262715Z","steps":["trace[699841158] 'process raft request'  (duration: 182.784079ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:50:17.843223Z","caller":"traceutil/trace.go:171","msg":"trace[1599110989] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"487.431439ms","start":"2026-08-13T07:50:17.355758Z","end":"2026-08-13T07:50:17.843189Z","steps":["trace[1599110989] 'process raft request'  (duration: 470.475554ms)","trace[1599110989] 'compare'  (duration: 16.792822ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:50:17.843946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:17.355737Z","time spent":"487.563453ms","remote":"127.0.0.1:51604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-p2x5t\" mod_revision:483 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-p2x5t\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-p2x5t\" > >"}
{"level":"info","ts":"2026-08-13T07:50:17.844933Z","caller":"traceutil/trace.go:171","msg":"trace[1364263828] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"163.019192ms","start":"2026-08-13T07:50:17.681877Z","end":"2026-08-13T07:50:17.844897Z","steps":["trace[1364263828] 'process raft request'  (duration: 162.070971ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:51:04.813059Z","caller":"traceutil/trace.go:171","msg":"trace[467881077] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1215; }","duration":"188.748012ms","start":"2026-08-13T07:51:04.624291Z","end":"2026-08-13T07:51:04.813039Z","steps":["trace[467881077] 'read index received'  (duration: 188.566138ms)","trace[467881077] 'applied index is now lower than readState.Index'  (duration: 180.674µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:51:04.81324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.551036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-13T07:51:04.813258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.965177ms","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-08-13T07:51:04.813272Z","caller":"traceutil/trace.go:171","msg":"trace[1139765465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1179; }","duration":"184.631247ms","start":"2026-08-13T07:51:04.628635Z","end":"2026-08-13T07:51:04.813266Z","steps":["trace[1139765465] 'agreement among raft nodes before linearized reading'  (duration: 184.525745ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:51:04.813394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.296958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-13T07:51:04.813478Z","caller":"traceutil/trace.go:171","msg":"trace[275643224] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1179; }","duration":"100.434202ms","start":"2026-08-13T07:51:04.713024Z","end":"2026-08-13T07:51:04.813458Z","steps":["trace[275643224] 'agreement among raft nodes before linearized reading'  (duration: 100.292528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:51:04.813332Z","caller":"traceutil/trace.go:171","msg":"trace[1143349126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1179; }","duration":"189.033739ms","start":"2026-08-13T07:51:04.624252Z","end":"2026-08-13T07:51:04.813285Z","steps":["trace[1143349126] 'agreement among raft nodes before linearized reading'  (duration: 188.888765ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:51:04.813108Z","caller":"traceutil/trace.go:171","msg":"trace[300756662] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"238.079592ms","start":"2026-08-13T07:51:04.575013Z","end":"2026-08-13T07:51:04.813092Z","steps":["trace[300756662] 'process raft request'  (duration: 237.882098ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:51:50.702107Z","caller":"traceutil/trace.go:171","msg":"trace[1153124295] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"231.813622ms","start":"2026-08-13T07:51:50.470272Z","end":"2026-08-13T07:51:50.702086Z","steps":["trace[1153124295] 'read index received'  (duration: 231.552886ms)","trace[1153124295] 'applied index is now lower than readState.Index'  (duration: 259.586µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:51:50.70216Z","caller":"traceutil/trace.go:171","msg":"trace[454542111] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"303.959182ms","start":"2026-08-13T07:51:50.398179Z","end":"2026-08-13T07:51:50.702138Z","steps":["trace[454542111] 'process raft request'  (duration: 303.687566ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:51:50.702501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:50.398151Z","time spent":"304.050054ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1801 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-13T07:51:50.702385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.028896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-08-13T07:51:50.702576Z","caller":"traceutil/trace.go:171","msg":"trace[1824103995] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1846; }","duration":"232.349124ms","start":"2026-08-13T07:51:50.470215Z","end":"2026-08-13T07:51:50.702564Z","steps":["trace[1824103995] 'agreement among raft nodes before linearized reading'  (duration: 231.960375ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:51:51.158134Z","caller":"traceutil/trace.go:171","msg":"trace[1002949254] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"109.753856ms","start":"2026-08-13T07:51:51.048349Z","end":"2026-08-13T07:51:51.158102Z","steps":["trace[1002949254] 'process raft request'  (duration: 63.655059ms)","trace[1002949254] 'compare'  (duration: 45.896602ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:51:51.158273Z","caller":"traceutil/trace.go:171","msg":"trace[780029410] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"108.978719ms","start":"2026-08-13T07:51:51.049246Z","end":"2026-08-13T07:51:51.158225Z","steps":["trace[780029410] 'process raft request'  (duration: 108.805455ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:52:04.889611Z","caller":"traceutil/trace.go:171","msg":"trace[793814814] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"123.09399ms","start":"2026-08-13T07:52:04.766478Z","end":"2026-08-13T07:52:04.889572Z","steps":["trace[793814814] 'process raft request'  (duration: 122.836014ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:52:39.349473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.269099ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9378077695579392962 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2145 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-13T07:52:39.349623Z","caller":"traceutil/trace.go:171","msg":"trace[909079529] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"206.558993ms","start":"2026-08-13T07:52:39.143045Z","end":"2026-08-13T07:52:39.349604Z","steps":["trace[909079529] 'read index received'  (duration: 88.851363ms)","trace[909079529] 'applied index is now lower than readState.Index'  (duration: 117.70554ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:52:39.349634Z","caller":"traceutil/trace.go:171","msg":"trace[1170508397] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"247.958569ms","start":"2026-08-13T07:52:39.101637Z","end":"2026-08-13T07:52:39.349595Z","steps":["trace[1170508397] 'process raft request'  (duration: 130.311701ms)","trace[1170508397] 'compare'  (duration: 117.044973ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:52:39.349933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.877231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-08-13T07:52:39.350016Z","caller":"traceutil/trace.go:171","msg":"trace[1440725555] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2157; }","duration":"207.015395ms","start":"2026-08-13T07:52:39.142987Z","end":"2026-08-13T07:52:39.350002Z","steps":["trace[1440725555] 'agreement among raft nodes before linearized reading'  (duration: 206.710727ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:53:21.566271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.445843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-13T07:53:21.566341Z","caller":"traceutil/trace.go:171","msg":"trace[1429052539] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2488; }","duration":"125.568935ms","start":"2026-08-13T07:53:21.440761Z","end":"2026-08-13T07:53:21.56633Z","steps":["trace[1429052539] 'count revisions from in-memory index tree'  (duration: 125.255148ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:53:53.906373Z","caller":"traceutil/trace.go:171","msg":"trace[421171784] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"164.724391ms","start":"2026-08-13T07:53:53.741626Z","end":"2026-08-13T07:53:53.906351Z","steps":["trace[421171784] 'process raft request'  (duration: 164.583528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:53:53.91027Z","caller":"traceutil/trace.go:171","msg":"trace[1880555458] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2766; }","duration":"155.369124ms","start":"2026-08-13T07:53:53.754883Z","end":"2026-08-13T07:53:53.910252Z","steps":["trace[1880555458] 'read index received'  (duration: 151.321139ms)","trace[1880555458] 'applied index is now lower than readState.Index'  (duration: 4.047135ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:53:53.910441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.547307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-08-13T07:53:53.910472Z","caller":"traceutil/trace.go:171","msg":"trace[564839674] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2668; }","duration":"155.616148ms","start":"2026-08-13T07:53:53.754847Z","end":"2026-08-13T07:53:53.910463Z","steps":["trace[564839674] 'agreement among raft nodes before linearized reading'  (duration: 155.484426ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:53:53.910689Z","caller":"traceutil/trace.go:171","msg":"trace[746361583] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"166.669726ms","start":"2026-08-13T07:53:53.744005Z","end":"2026-08-13T07:53:53.910674Z","steps":["trace[746361583] 'process raft request'  (duration: 166.217958ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:53:53.910789Z","caller":"traceutil/trace.go:171","msg":"trace[1638672715] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"168.94207ms","start":"2026-08-13T07:53:53.741838Z","end":"2026-08-13T07:53:53.91078Z","steps":["trace[1638672715] 'process raft request'  (duration: 168.299677ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:57:53.690484Z","caller":"traceutil/trace.go:171","msg":"trace[493999698] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4778; }","duration":"114.171256ms","start":"2026-08-13T07:57:53.576272Z","end":"2026-08-13T07:57:53.690443Z","steps":["trace[493999698] 'read index received'  (duration: 17.214968ms)","trace[493999698] 'applied index is now lower than readState.Index'  (duration: 96.955108ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:57:53.69068Z","caller":"traceutil/trace.go:171","msg":"trace[1205781150] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"117.868691ms","start":"2026-08-13T07:57:53.57278Z","end":"2026-08-13T07:57:53.690649Z","steps":["trace[1205781150] 'process raft request'  (duration: 20.76364ms)","trace[1205781150] 'compare'  (duration: 96.735373ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:57:53.690767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.283406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-08-13T07:57:53.690828Z","caller":"traceutil/trace.go:171","msg":"trace[1562800144] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4600; }","duration":"113.401329ms","start":"2026-08-13T07:57:53.577415Z","end":"2026-08-13T07:57:53.690817Z","steps":["trace[1562800144] 'agreement among raft nodes before linearized reading'  (duration: 113.192874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:57:53.690707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.418282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-rqpxt-tls\" ","response":"range_response_count:1 size:2130"}
{"level":"info","ts":"2026-08-13T07:57:53.691072Z","caller":"traceutil/trace.go:171","msg":"trace[875867424] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-rqpxt-tls; range_end:; response_count:1; response_revision:4600; }","duration":"114.818322ms","start":"2026-08-13T07:57:53.576238Z","end":"2026-08-13T07:57:53.691056Z","steps":["trace[875867424] 'agreement among raft nodes before linearized reading'  (duration: 114.314531ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:58:00.604186Z","caller":"traceutil/trace.go:171","msg":"trace[245407205] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"111.07682ms","start":"2026-08-13T07:58:00.493089Z","end":"2026-08-13T07:58:00.604166Z","steps":["trace[245407205] 'process raft request'  (duration: 110.923907ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:58:00.615589Z","caller":"traceutil/trace.go:171","msg":"trace[1346560621] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"121.66434ms","start":"2026-08-13T07:58:00.493904Z","end":"2026-08-13T07:58:00.615569Z","steps":["trace[1346560621] 'process raft request'  (duration: 121.535877ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:58:00.954415Z","caller":"traceutil/trace.go:171","msg":"trace[984258927] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"195.375026ms","start":"2026-08-13T07:58:00.759003Z","end":"2026-08-13T07:58:00.954378Z","steps":["trace[984258927] 'process raft request'  (duration: 117.65196ms)","trace[984258927] 'compare'  (duration: 77.46483ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T07:58:00.95467Z","caller":"traceutil/trace.go:171","msg":"trace[291694468] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"103.288895ms","start":"2026-08-13T07:58:00.851359Z","end":"2026-08-13T07:58:00.954648Z","steps":["trace[291694468] 'process raft request'  (duration: 102.922367ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:59:03.44768Z","caller":"traceutil/trace.go:171","msg":"trace[491250023] linearizableReadLoop","detail":"{readStateIndex:5555; appliedIndex:5554; }","duration":"152.169948ms","start":"2026-08-13T07:59:03.295478Z","end":"2026-08-13T07:59:03.447648Z","steps":["trace[491250023] 'read index received'  (duration: 75.017245ms)","trace[491250023] 'applied index is now lower than readState.Index'  (duration: 77.151063ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:59:03.447962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.369523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T07:59:03.447707Z","caller":"traceutil/trace.go:171","msg":"trace[1125730504] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"155.996375ms","start":"2026-08-13T07:59:03.291684Z","end":"2026-08-13T07:59:03.447681Z","steps":["trace[1125730504] 'process raft request'  (duration: 78.898753ms)","trace[1125730504] 'compare'  (duration: 76.54923ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T07:59:03.448132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.453635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T07:59:03.448029Z","caller":"traceutil/trace.go:171","msg":"trace[634017152] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5353; }","duration":"152.578217ms","start":"2026-08-13T07:59:03.295436Z","end":"2026-08-13T07:59:03.448015Z","steps":["trace[634017152] 'agreement among raft nodes before linearized reading'  (duration: 152.367503ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:59:03.448245Z","caller":"traceutil/trace.go:171","msg":"trace[1534789029] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5353; }","duration":"152.628879ms","start":"2026-08-13T07:59:03.295595Z","end":"2026-08-13T07:59:03.448224Z","steps":["trace[1534789029] 'agreement among raft nodes before linearized reading'  (duration: 152.441614ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T07:59:03.448407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.790365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T07:59:03.448543Z","caller":"traceutil/trace.go:171","msg":"trace[1165243483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5353; }","duration":"140.136813ms","start":"2026-08-13T07:59:03.308359Z","end":"2026-08-13T07:59:03.448496Z","steps":["trace[1165243483] 'agreement among raft nodes before linearized reading'  (duration: 139.715223ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T07:59:32.614601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876}
{"level":"info","ts":"2026-08-13T07:59:32.708177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"92.510262ms","hash":3495061410,"current-db-size-bytes":54738944,"current-db-size":"55 MB","current-db-size-in-use-bytes":29741056,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-13T07:59:32.708234Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3495061410,"revision":2876,"compact-revision":-1}
{"level":"info","ts":"2026-08-13T08:04:32.618971Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5565}
{"level":"info","ts":"2026-08-13T08:04:32.704173Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5565,"took":"83.679415ms","hash":1888642223,"current-db-size-bytes":54738944,"current-db-size":"55 MB","current-db-size-in-use-bytes":18354176,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-08-13T08:04:32.704235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1888642223,"revision":5565,"compact-revision":2876}