{"level":"warn","ts":"2026-03-19T09:00:05.821464Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-19T09:00:05.82162Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.12: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.12:2380","--initial-cluster=instance=https://199.19.213.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.12: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-03-19T09:00:05.82178Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-19T09:00:05.821809Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.12:2380"]}
{"level":"info","ts":"2026-03-19T09:00:05.821891Z","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-03-19T09:00:05.822612Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"]}
{"level":"info","ts":"2026-03-19T09:00:05.822752Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.12: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-03-19T09:00:05.826302Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.281134ms"}
{"level":"info","ts":"2026-03-19T09:00:05.832188Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"790561176553eafe","cluster-id":"e32c72c573d8545f"}
{"level":"info","ts":"2026-03-19T09:00:05.832395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=()"}
{"level":"info","ts":"2026-03-19T09:00:05.83248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 0"}
{"level":"info","ts":"2026-03-19T09:00:05.832548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 790561176553eafe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-19T09:00:05.83258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 1"}
{"level":"info","ts":"2026-03-19T09:00:05.83266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"}
{"level":"warn","ts":"2026-03-19T09:00:05.844858Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-19T09:00:05.846745Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-19T09:00:05.847901Z","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-03-19T09:00:05.850342Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"790561176553eafe","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-19T09:00:05.850528Z","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-03-19T09:00:05.850602Z","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-03-19T09:00:05.850612Z","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-03-19T09:00:05.850952Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"790561176553eafe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-19T09:00:05.853573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"}
{"level":"info","ts":"2026-03-19T09:00:05.853902Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","added-peer-id":"790561176553eafe","added-peer-peer-urls":["https://199.19.213.12:2380"]}
{"level":"info","ts":"2026-03-19T09:00:05.855798Z","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-03-19T09:00:05.855937Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.12:2380"}
{"level":"info","ts":"2026-03-19T09:00:05.856019Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.12:2380"}
{"level":"info","ts":"2026-03-19T09:00:05.856105Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"790561176553eafe","initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-19T09:00:05.856142Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-19T09:00:06.333168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe is starting a new election at term 1"}
{"level":"info","ts":"2026-03-19T09:00:06.333231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-19T09:00:06.333265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgPreVoteResp from 790561176553eafe at term 1"}
{"level":"info","ts":"2026-03-19T09:00:06.333302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became candidate at term 2"}
{"level":"info","ts":"2026-03-19T09:00:06.333308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgVoteResp from 790561176553eafe at term 2"}
{"level":"info","ts":"2026-03-19T09:00:06.333317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became leader at term 2"}
{"level":"info","ts":"2026-03-19T09:00:06.333325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 790561176553eafe elected leader 790561176553eafe at term 2"}
{"level":"info","ts":"2026-03-19T09:00:06.334434Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T09:00:06.335284Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T09:00:06.335287Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"790561176553eafe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.12:2379]}","request-path":"/0/members/790561176553eafe/attributes","cluster-id":"e32c72c573d8545f","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-19T09:00:06.335361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T09:00:06.335541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-19T09:00:06.335605Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-19T09:00:06.335687Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T09:00:06.335757Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T09:00:06.335778Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T09:00:06.337623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-19T09:00:06.338875Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.12:2379"}
{"level":"info","ts":"2026-03-19T09:00:42.362673Z","caller":"traceutil/trace.go:171","msg":"trace[1653443004] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"182.160147ms","start":"2026-03-19T09:00:42.180485Z","end":"2026-03-19T09:00:42.362646Z","steps":["trace[1653443004] 'process raft request'  (duration: 181.982613ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:01:55.872043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.304838ms","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-03-19T09:01:55.872044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.029463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-19T09:01:55.872216Z","caller":"traceutil/trace.go:171","msg":"trace[141521575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1589; }","duration":"129.530534ms","start":"2026-03-19T09:01:55.742661Z","end":"2026-03-19T09:01:55.872191Z","steps":["trace[141521575] 'range keys from in-memory index tree'  (duration: 129.104483ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:01:55.872276Z","caller":"traceutil/trace.go:171","msg":"trace[1393030584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1589; }","duration":"126.34875ms","start":"2026-03-19T09:01:55.745888Z","end":"2026-03-19T09:01:55.872237Z","steps":["trace[1393030584] 'range keys from in-memory index tree'  (duration: 125.732715ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:01:56.009872Z","caller":"traceutil/trace.go:171","msg":"trace[1027759334] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"132.882621ms","start":"2026-03-19T09:01:55.876961Z","end":"2026-03-19T09:01:56.009843Z","steps":["trace[1027759334] 'process raft request'  (duration: 132.702857ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:01:56.033925Z","caller":"traceutil/trace.go:171","msg":"trace[688324290] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"155.717971ms","start":"2026-03-19T09:01:55.878182Z","end":"2026-03-19T09:01:56.0339Z","steps":["trace[688324290] 'process raft request'  (duration: 155.585698ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:02:40.864952Z","caller":"traceutil/trace.go:171","msg":"trace[173801824] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"123.734089ms","start":"2026-03-19T09:02:40.741177Z","end":"2026-03-19T09:02:40.864911Z","steps":["trace[173801824] 'process raft request'  (duration: 123.589635ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:02:40.897032Z","caller":"traceutil/trace.go:171","msg":"trace[1719805054] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"154.222176ms","start":"2026-03-19T09:02:40.742787Z","end":"2026-03-19T09:02:40.897009Z","steps":["trace[1719805054] 'process raft request'  (duration: 154.105634ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:03:37.336341Z","caller":"traceutil/trace.go:171","msg":"trace[1886453586] linearizableReadLoop","detail":"{readStateIndex:2411; appliedIndex:2410; }","duration":"106.265361ms","start":"2026-03-19T09:03:37.23005Z","end":"2026-03-19T09:03:37.336316Z","steps":["trace[1886453586] 'read index received'  (duration: 103.771922ms)","trace[1886453586] 'applied index is now lower than readState.Index'  (duration: 2.492269ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:03:37.336367Z","caller":"traceutil/trace.go:171","msg":"trace[56694230] transaction","detail":"{read_only:false; response_revision:2321; number_of_response:1; }","duration":"133.033457ms","start":"2026-03-19T09:03:37.203305Z","end":"2026-03-19T09:03:37.336338Z","steps":["trace[56694230] 'process raft request'  (duration: 130.455387ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:03:37.336496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.425434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:03:37.336533Z","caller":"traceutil/trace.go:171","msg":"trace[1952603409] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2321; }","duration":"106.507827ms","start":"2026-03-19T09:03:37.230015Z","end":"2026-03-19T09:03:37.336522Z","steps":["trace[1952603409] 'agreement among raft nodes before linearized reading'  (duration: 106.413644ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:04:09.588677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.328173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:04:09.588773Z","caller":"traceutil/trace.go:171","msg":"trace[122434470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2499; }","duration":"129.508769ms","start":"2026-03-19T09:04:09.459244Z","end":"2026-03-19T09:04:09.588753Z","steps":["trace[122434470] 'range keys from in-memory index tree'  (duration: 129.136598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:05.553369Z","caller":"traceutil/trace.go:171","msg":"trace[1891258457] linearizableReadLoop","detail":"{readStateIndex:4456; appliedIndex:4455; }","duration":"108.431374ms","start":"2026-03-19T09:08:05.444888Z","end":"2026-03-19T09:08:05.553319Z","steps":["trace[1891258457] 'read index received'  (duration: 99.107323ms)","trace[1891258457] 'applied index is now lower than readState.Index'  (duration: 9.322621ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:08:05.553646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.740752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T09:08:05.553686Z","caller":"traceutil/trace.go:171","msg":"trace[760114654] transaction","detail":"{read_only:false; response_revision:4287; number_of_response:1; }","duration":"126.315048ms","start":"2026-03-19T09:08:05.427326Z","end":"2026-03-19T09:08:05.553642Z","steps":["trace[760114654] 'process raft request'  (duration: 116.661249ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:05.553793Z","caller":"traceutil/trace.go:171","msg":"trace[1057796629] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:4287; }","duration":"108.947856ms","start":"2026-03-19T09:08:05.444824Z","end":"2026-03-19T09:08:05.553772Z","steps":["trace[1057796629] 'agreement among raft nodes before linearized reading'  (duration: 108.719171ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:10.871392Z","caller":"traceutil/trace.go:171","msg":"trace[1292066835] linearizableReadLoop","detail":"{readStateIndex:4623; appliedIndex:4622; }","duration":"108.095526ms","start":"2026-03-19T09:08:10.763279Z","end":"2026-03-19T09:08:10.871374Z","steps":["trace[1292066835] 'read index received'  (duration: 107.891351ms)","trace[1292066835] 'applied index is now lower than readState.Index'  (duration: 202.385µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:08:10.871536Z","caller":"traceutil/trace.go:171","msg":"trace[554218789] transaction","detail":"{read_only:false; response_revision:4449; number_of_response:1; }","duration":"120.129333ms","start":"2026-03-19T09:08:10.751363Z","end":"2026-03-19T09:08:10.871493Z","steps":["trace[554218789] 'process raft request'  (duration: 119.822105ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:10.871751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.450544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-03-19T09:08:10.871859Z","caller":"traceutil/trace.go:171","msg":"trace[1708139578] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4449; }","duration":"108.600257ms","start":"2026-03-19T09:08:10.763221Z","end":"2026-03-19T09:08:10.871821Z","steps":["trace[1708139578] 'agreement among raft nodes before linearized reading'  (duration: 108.27883ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:15.816154Z","caller":"traceutil/trace.go:171","msg":"trace[64322501] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"130.550509ms","start":"2026-03-19T09:08:15.685573Z","end":"2026-03-19T09:08:15.816124Z","steps":["trace[64322501] 'process raft request'  (duration: 130.144219ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.687397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933144295149237090,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-19T09:08:25.71655Z","caller":"traceutil/trace.go:171","msg":"trace[1437594065] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"701.48303ms","start":"2026-03-19T09:08:25.015042Z","end":"2026-03-19T09:08:25.716525Z","steps":["trace[1437594065] 'process raft request'  (duration: 701.270504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.716995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:08:25.015026Z","time spent":"701.595153ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":124095,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:4772 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:124058 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"info","ts":"2026-03-19T09:08:25.720464Z","caller":"traceutil/trace.go:171","msg":"trace[1355006972] linearizableReadLoop","detail":"{readStateIndex:4987; appliedIndex:4986; }","duration":"533.110029ms","start":"2026-03-19T09:08:25.187325Z","end":"2026-03-19T09:08:25.720435Z","steps":["trace[1355006972] 'read index received'  (duration: 530.007907ms)","trace[1355006972] 'applied index is now lower than readState.Index'  (duration: 3.100592ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:08:25.720787Z","caller":"traceutil/trace.go:171","msg":"trace[2037920722] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"600.684072ms","start":"2026-03-19T09:08:25.120091Z","end":"2026-03-19T09:08:25.720775Z","steps":["trace[2037920722] 'process raft request'  (duration: 600.196161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.72108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:08:25.120061Z","time spent":"600.750414ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4767 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-03-19T09:08:25.721305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.989999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:08:25.721332Z","caller":"traceutil/trace.go:171","msg":"trace[749163161] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:4802; }","duration":"534.059551ms","start":"2026-03-19T09:08:25.187264Z","end":"2026-03-19T09:08:25.721324Z","steps":["trace[749163161] 'agreement among raft nodes before linearized reading'  (duration: 533.942188ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.72135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:08:25.187244Z","time spent":"534.102392ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-nnnvv\" "}
{"level":"warn","ts":"2026-03-19T09:08:25.721492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.717208ms","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-03-19T09:08:25.721515Z","caller":"traceutil/trace.go:171","msg":"trace[479675802] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4802; }","duration":"506.766208ms","start":"2026-03-19T09:08:25.214741Z","end":"2026-03-19T09:08:25.721508Z","steps":["trace[479675802] 'agreement among raft nodes before linearized reading'  (duration: 506.708847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.721532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:08:25.214727Z","time spent":"506.80093ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-03-19T09:08:25.721691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.064696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-wmb7r\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-03-19T09:08:25.721712Z","caller":"traceutil/trace.go:171","msg":"trace[168319085] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-wmb7r; range_end:; response_count:1; response_revision:4802; }","duration":"119.137588ms","start":"2026-03-19T09:08:25.602569Z","end":"2026-03-19T09:08:25.721706Z","steps":["trace[168319085] 'agreement among raft nodes before linearized reading'  (duration: 119.072056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:08:25.721809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.014717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:08:25.721829Z","caller":"traceutil/trace.go:171","msg":"trace[211504403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4802; }","duration":"262.078129ms","start":"2026-03-19T09:08:25.459745Z","end":"2026-03-19T09:08:25.721824Z","steps":["trace[211504403] 'agreement among raft nodes before linearized reading'  (duration: 262.043418ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:28.429488Z","caller":"traceutil/trace.go:171","msg":"trace[2064046950] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"100.883859ms","start":"2026-03-19T09:08:28.328577Z","end":"2026-03-19T09:08:28.429461Z","steps":["trace[2064046950] 'process raft request'  (duration: 100.625373ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:08:34.346472Z","caller":"traceutil/trace.go:171","msg":"trace[1729888275] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"160.550765ms","start":"2026-03-19T09:08:34.185887Z","end":"2026-03-19T09:08:34.346437Z","steps":["trace[1729888275] 'process raft request'  (duration: 77.811495ms)","trace[1729888275] 'compare'  (duration: 82.546416ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:10:06.573228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2782}
{"level":"info","ts":"2026-03-19T09:10:06.645452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2782,"took":"70.765409ms","hash":2282949921,"current-db-size-bytes":41500672,"current-db-size":"42 MB","current-db-size-in-use-bytes":30924800,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-19T09:10:06.645535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2282949921,"revision":2782,"compact-revision":-1}
{"level":"info","ts":"2026-03-19T09:12:48.559908Z","caller":"traceutil/trace.go:171","msg":"trace[890218511] linearizableReadLoop","detail":"{readStateIndex:6957; appliedIndex:6956; }","duration":"103.818798ms","start":"2026-03-19T09:12:48.456065Z","end":"2026-03-19T09:12:48.559884Z","steps":["trace[890218511] 'read index received'  (duration: 17.768058ms)","trace[890218511] 'applied index is now lower than readState.Index'  (duration: 86.04975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:48.559921Z","caller":"traceutil/trace.go:171","msg":"trace[58453307] transaction","detail":"{read_only:false; response_revision:6709; number_of_response:1; }","duration":"173.312407ms","start":"2026-03-19T09:12:48.386583Z","end":"2026-03-19T09:12:48.559895Z","steps":["trace[58453307] 'process raft request'  (duration: 87.312499ms)","trace[58453307] 'compare'  (duration: 85.873225ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:12:48.560024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.944221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T09:12:48.560051Z","caller":"traceutil/trace.go:171","msg":"trace[1951723431] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:6709; }","duration":"104.016513ms","start":"2026-03-19T09:12:48.456028Z","end":"2026-03-19T09:12:48.560045Z","steps":["trace[1951723431] 'agreement among raft nodes before linearized reading'  (duration: 103.942961ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.043152Z","caller":"traceutil/trace.go:171","msg":"trace[181686892] transaction","detail":"{read_only:false; response_revision:6711; number_of_response:1; }","duration":"102.777804ms","start":"2026-03-19T09:12:48.940345Z","end":"2026-03-19T09:12:49.043122Z","steps":["trace[181686892] 'process raft request'  (duration: 102.57884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.340701Z","caller":"traceutil/trace.go:171","msg":"trace[221425397] transaction","detail":"{read_only:false; response_revision:6732; number_of_response:1; }","duration":"145.958972ms","start":"2026-03-19T09:12:49.194711Z","end":"2026-03-19T09:12:49.34067Z","steps":["trace[221425397] 'process raft request'  (duration: 129.829242ms)","trace[221425397] 'compare'  (duration: 15.946796ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:12:49.340787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.542187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-03-19T09:12:49.340885Z","caller":"traceutil/trace.go:171","msg":"trace[1121359639] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:6732; }","duration":"149.65414ms","start":"2026-03-19T09:12:49.191214Z","end":"2026-03-19T09:12:49.340868Z","steps":["trace[1121359639] 'agreement among raft nodes before linearized reading'  (duration: 149.451235ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:49.341253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.914509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:18 size:161352"}
{"level":"info","ts":"2026-03-19T09:12:49.341288Z","caller":"traceutil/trace.go:171","msg":"trace[1373469918] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:18; response_revision:6732; }","duration":"147.9828ms","start":"2026-03-19T09:12:49.193298Z","end":"2026-03-19T09:12:49.341281Z","steps":["trace[1373469918] 'agreement among raft nodes before linearized reading'  (duration: 147.732064ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.813529Z","caller":"traceutil/trace.go:171","msg":"trace[1033561802] transaction","detail":"{read_only:false; response_revision:6758; number_of_response:1; }","duration":"139.271085ms","start":"2026-03-19T09:12:49.674231Z","end":"2026-03-19T09:12:49.813502Z","steps":["trace[1033561802] 'process raft request'  (duration: 139.032499ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.813762Z","caller":"traceutil/trace.go:171","msg":"trace[1070280685] transaction","detail":"{read_only:false; response_revision:6759; number_of_response:1; }","duration":"119.371395ms","start":"2026-03-19T09:12:49.694354Z","end":"2026-03-19T09:12:49.813725Z","steps":["trace[1070280685] 'process raft request'  (duration: 119.070358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:49.813883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.742917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"}
{"level":"warn","ts":"2026-03-19T09:12:49.813972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.309729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-03-19T09:12:49.813997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.025352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:49.814042Z","caller":"traceutil/trace.go:171","msg":"trace[1241049460] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:6759; }","duration":"140.433212ms","start":"2026-03-19T09:12:49.673594Z","end":"2026-03-19T09:12:49.814027Z","steps":["trace[1241049460] 'agreement among raft nodes before linearized reading'  (duration: 140.239177ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.814169Z","caller":"traceutil/trace.go:171","msg":"trace[1256231984] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:6759; }","duration":"140.154575ms","start":"2026-03-19T09:12:49.673886Z","end":"2026-03-19T09:12:49.814041Z","steps":["trace[1256231984] 'agreement among raft nodes before linearized reading'  (duration: 139.989131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:49.814098Z","caller":"traceutil/trace.go:171","msg":"trace[258666686] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6759; }","duration":"131.951852ms","start":"2026-03-19T09:12:49.68208Z","end":"2026-03-19T09:12:49.814032Z","steps":["trace[258666686] 'agreement among raft nodes before linearized reading'  (duration: 131.649555ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:50.035001Z","caller":"traceutil/trace.go:171","msg":"trace[792581221] transaction","detail":"{read_only:false; response_revision:6764; number_of_response:1; }","duration":"125.832358ms","start":"2026-03-19T09:12:49.909139Z","end":"2026-03-19T09:12:50.034971Z","steps":["trace[792581221] 'process raft request'  (duration: 125.698215ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:50.035012Z","caller":"traceutil/trace.go:171","msg":"trace[380985246] transaction","detail":"{read_only:false; response_revision:6763; number_of_response:1; }","duration":"126.085524ms","start":"2026-03-19T09:12:49.908868Z","end":"2026-03-19T09:12:50.034954Z","steps":["trace[380985246] 'process raft request'  (duration: 102.786234ms)","trace[380985246] 'compare'  (duration: 23.012153ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:50.035415Z","caller":"traceutil/trace.go:171","msg":"trace[1754502604] transaction","detail":"{read_only:false; response_revision:6765; number_of_response:1; }","duration":"125.012598ms","start":"2026-03-19T09:12:49.910389Z","end":"2026-03-19T09:12:50.035402Z","steps":["trace[1754502604] 'process raft request'  (duration: 124.506566ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:50.035575Z","caller":"traceutil/trace.go:171","msg":"trace[1419237150] transaction","detail":"{read_only:false; response_revision:6766; number_of_response:1; }","duration":"122.902728ms","start":"2026-03-19T09:12:49.912646Z","end":"2026-03-19T09:12:50.035548Z","steps":["trace[1419237150] 'process raft request'  (duration: 122.559201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:50.035683Z","caller":"traceutil/trace.go:171","msg":"trace[1781663211] linearizableReadLoop","detail":"{readStateIndex:7016; appliedIndex:7011; }","duration":"122.52992ms","start":"2026-03-19T09:12:49.913136Z","end":"2026-03-19T09:12:50.035666Z","steps":["trace[1781663211] 'read index received'  (duration: 8.361727ms)","trace[1781663211] 'applied index is now lower than readState.Index'  (duration: 114.166993ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:50.035734Z","caller":"traceutil/trace.go:171","msg":"trace[83043561] transaction","detail":"{read_only:false; response_revision:6767; number_of_response:1; }","duration":"122.651662ms","start":"2026-03-19T09:12:49.913068Z","end":"2026-03-19T09:12:50.03572Z","steps":["trace[83043561] 'process raft request'  (duration: 122.364906ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:50.035817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.643173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:50.035891Z","caller":"traceutil/trace.go:171","msg":"trace[1703315978] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:6767; }","duration":"122.752815ms","start":"2026-03-19T09:12:49.913114Z","end":"2026-03-19T09:12:50.035867Z","steps":["trace[1703315978] 'agreement among raft nodes before linearized reading'  (duration: 122.623572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:50.035921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.123506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4725"}
{"level":"info","ts":"2026-03-19T09:12:50.035955Z","caller":"traceutil/trace.go:171","msg":"trace[524800153] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:6767; }","duration":"121.178008ms","start":"2026-03-19T09:12:49.914764Z","end":"2026-03-19T09:12:50.035942Z","steps":["trace[524800153] 'agreement among raft nodes before linearized reading'  (duration: 121.017504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:50.036355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.474914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-03-19T09:12:50.036527Z","caller":"traceutil/trace.go:171","msg":"trace[692726921] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:6767; }","duration":"121.68487ms","start":"2026-03-19T09:12:49.914817Z","end":"2026-03-19T09:12:50.036501Z","steps":["trace[692726921] 'agreement among raft nodes before linearized reading'  (duration: 121.203898ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:50.406703Z","caller":"traceutil/trace.go:171","msg":"trace[1986787826] transaction","detail":"{read_only:false; response_revision:6778; number_of_response:1; }","duration":"101.163396ms","start":"2026-03-19T09:12:50.305513Z","end":"2026-03-19T09:12:50.406676Z","steps":["trace[1986787826] 'process raft request'  (duration: 100.578692ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:51.682787Z","caller":"traceutil/trace.go:171","msg":"trace[1313032165] transaction","detail":"{read_only:false; response_revision:6788; number_of_response:1; }","duration":"107.612209ms","start":"2026-03-19T09:12:51.575148Z","end":"2026-03-19T09:12:51.68276Z","steps":["trace[1313032165] 'process raft request'  (duration: 107.442835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:51.835959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.107461ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933144295149242565 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:6754 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T09:12:51.836133Z","caller":"traceutil/trace.go:171","msg":"trace[1939674980] transaction","detail":"{read_only:false; response_revision:6789; number_of_response:1; }","duration":"148.740509ms","start":"2026-03-19T09:12:51.687367Z","end":"2026-03-19T09:12:51.836108Z","steps":["trace[1939674980] 'process raft request'  (duration: 48.29365ms)","trace[1939674980] 'compare'  (duration: 99.997147ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:51.836164Z","caller":"traceutil/trace.go:171","msg":"trace[237313036] transaction","detail":"{read_only:false; response_revision:6790; number_of_response:1; }","duration":"148.048892ms","start":"2026-03-19T09:12:51.688101Z","end":"2026-03-19T09:12:51.83615Z","steps":["trace[237313036] 'process raft request'  (duration: 147.9952ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:52.961708Z","caller":"traceutil/trace.go:171","msg":"trace[1632339851] transaction","detail":"{read_only:false; response_revision:6804; number_of_response:1; }","duration":"153.952691ms","start":"2026-03-19T09:12:52.807724Z","end":"2026-03-19T09:12:52.961676Z","steps":["trace[1632339851] 'process raft request'  (duration: 153.650564ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:54.374307Z","caller":"traceutil/trace.go:171","msg":"trace[752408723] transaction","detail":"{read_only:false; response_revision:6810; number_of_response:1; }","duration":"107.565478ms","start":"2026-03-19T09:12:54.266722Z","end":"2026-03-19T09:12:54.374288Z","steps":["trace[752408723] 'process raft request'  (duration: 107.409384ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:54.750461Z","caller":"traceutil/trace.go:171","msg":"trace[1246459858] transaction","detail":"{read_only:false; response_revision:6812; number_of_response:1; }","duration":"296.648176ms","start":"2026-03-19T09:12:54.453773Z","end":"2026-03-19T09:12:54.750421Z","steps":["trace[1246459858] 'process raft request'  (duration: 202.452864ms)","trace[1246459858] 'compare'  (duration: 94.002418ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:12:54.750568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.446267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:54.750632Z","caller":"traceutil/trace.go:171","msg":"trace[700236923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6812; }","duration":"292.550259ms","start":"2026-03-19T09:12:54.458068Z","end":"2026-03-19T09:12:54.750619Z","steps":["trace[700236923] 'agreement among raft nodes before linearized reading'  (duration: 292.420886ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:54.750439Z","caller":"traceutil/trace.go:171","msg":"trace[593657518] linearizableReadLoop","detail":"{readStateIndex:7062; appliedIndex:7061; }","duration":"292.283363ms","start":"2026-03-19T09:12:54.458099Z","end":"2026-03-19T09:12:54.750382Z","steps":["trace[593657518] 'read index received'  (duration: 198.108662ms)","trace[593657518] 'applied index is now lower than readState.Index'  (duration: 94.173741ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:12:54.751085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.430272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T09:12:54.751182Z","caller":"traceutil/trace.go:171","msg":"trace[405371647] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:6812; }","duration":"207.537215ms","start":"2026-03-19T09:12:54.543632Z","end":"2026-03-19T09:12:54.751169Z","steps":["trace[405371647] 'agreement among raft nodes before linearized reading'  (duration: 207.371031ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:55.826734Z","caller":"traceutil/trace.go:171","msg":"trace[835475139] transaction","detail":"{read_only:false; response_revision:6817; number_of_response:1; }","duration":"160.25555ms","start":"2026-03-19T09:12:55.66646Z","end":"2026-03-19T09:12:55.826715Z","steps":["trace[835475139] 'process raft request'  (duration: 160.080076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:55.862175Z","caller":"traceutil/trace.go:171","msg":"trace[1838607517] transaction","detail":"{read_only:false; response_revision:6818; number_of_response:1; }","duration":"141.328774ms","start":"2026-03-19T09:12:55.720794Z","end":"2026-03-19T09:12:55.862122Z","steps":["trace[1838607517] 'process raft request'  (duration: 141.074008ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:55.990927Z","caller":"traceutil/trace.go:171","msg":"trace[879446244] transaction","detail":"{read_only:false; response_revision:6820; number_of_response:1; }","duration":"105.581001ms","start":"2026-03-19T09:12:55.885291Z","end":"2026-03-19T09:12:55.990872Z","steps":["trace[879446244] 'process raft request'  (duration: 49.782715ms)","trace[879446244] 'compare'  (duration: 55.669833ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:12:58.663328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.012174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:58.66342Z","caller":"traceutil/trace.go:171","msg":"trace[1231562459] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-user; range_end:; response_count:0; response_revision:6832; }","duration":"188.171338ms","start":"2026-03-19T09:12:58.475227Z","end":"2026-03-19T09:12:58.663398Z","steps":["trace[1231562459] 'range keys from in-memory index tree'  (duration: 187.8192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.663489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.927912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:58.663546Z","caller":"traceutil/trace.go:171","msg":"trace[938684061] range","detail":"{range_begin:/registry/jobs/openstack/barbican-rabbit-init; range_end:; response_count:0; response_revision:6832; }","duration":"188.001454ms","start":"2026-03-19T09:12:58.475532Z","end":"2026-03-19T09:12:58.663533Z","steps":["trace[938684061] 'range keys from in-memory index tree'  (duration: 187.893072ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.663508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.595135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:58.663615Z","caller":"traceutil/trace.go:171","msg":"trace[661870070] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-endpoints; range_end:; response_count:0; response_revision:6832; }","duration":"187.732318ms","start":"2026-03-19T09:12:58.47586Z","end":"2026-03-19T09:12:58.663592Z","steps":["trace[661870070] 'range keys from in-memory index tree'  (duration: 187.549243ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.663616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.162655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T09:12:58.663623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.221959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:12:58.663689Z","caller":"traceutil/trace.go:171","msg":"trace[552223559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6832; }","duration":"204.317858ms","start":"2026-03-19T09:12:58.45935Z","end":"2026-03-19T09:12:58.663668Z","steps":["trace[552223559] 'range keys from in-memory index tree'  (duration: 204.077183ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:58.663701Z","caller":"traceutil/trace.go:171","msg":"trace[1467690799] range","detail":"{range_begin:/registry/jobs/openstack/barbican-db-sync; range_end:; response_count:0; response_revision:6832; }","duration":"188.311631ms","start":"2026-03-19T09:12:58.475369Z","end":"2026-03-19T09:12:58.66368Z","steps":["trace[1467690799] 'range keys from in-memory index tree'  (duration: 188.170087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.66414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.336716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-03-19T09:12:58.664261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.692995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"warn","ts":"2026-03-19T09:12:58.664209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.9747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-03-19T09:12:58.664284Z","caller":"traceutil/trace.go:171","msg":"trace[297562690] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6832; }","duration":"530.747257ms","start":"2026-03-19T09:12:58.13353Z","end":"2026-03-19T09:12:58.664277Z","steps":["trace[297562690] 'range keys from in-memory index tree'  (duration: 529.942598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:58.664297Z","caller":"traceutil/trace.go:171","msg":"trace[343901351] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6832; }","duration":"483.281568ms","start":"2026-03-19T09:12:58.181002Z","end":"2026-03-19T09:12:58.664283Z","steps":["trace[343901351] 'range keys from in-memory index tree'  (duration: 482.195412ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.664308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:12:58.13351Z","time spent":"530.793268ms","remote":"127.0.0.1:52024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12232,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-03-19T09:12:58.66425Z","caller":"traceutil/trace.go:171","msg":"trace[1204142300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6832; }","duration":"164.46898ms","start":"2026-03-19T09:12:58.499764Z","end":"2026-03-19T09:12:58.664232Z","steps":["trace[1204142300] 'range keys from in-memory index tree'  (duration: 163.603009ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.664344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:12:58.180981Z","time spent":"483.344299ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-03-19T09:12:58.7866Z","caller":"traceutil/trace.go:171","msg":"trace[998599907] linearizableReadLoop","detail":"{readStateIndex:7084; appliedIndex:7083; }","duration":"117.205354ms","start":"2026-03-19T09:12:58.669365Z","end":"2026-03-19T09:12:58.786571Z","steps":["trace[998599907] 'read index received'  (duration: 116.903647ms)","trace[998599907] 'applied index is now lower than readState.Index'  (duration: 300.187µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:58.786726Z","caller":"traceutil/trace.go:171","msg":"trace[1153954949] transaction","detail":"{read_only:false; response_revision:6833; number_of_response:1; }","duration":"117.846089ms","start":"2026-03-19T09:12:58.668854Z","end":"2026-03-19T09:12:58.7867Z","steps":["trace[1153954949] 'process raft request'  (duration: 117.44955ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:12:58.78699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.586943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19583"}
{"level":"info","ts":"2026-03-19T09:12:58.787077Z","caller":"traceutil/trace.go:171","msg":"trace[1961205289] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:6833; }","duration":"117.708367ms","start":"2026-03-19T09:12:58.669348Z","end":"2026-03-19T09:12:58.787057Z","steps":["trace[1961205289] 'agreement among raft nodes before linearized reading'  (duration: 117.40014ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:58.810422Z","caller":"traceutil/trace.go:171","msg":"trace[1324408939] transaction","detail":"{read_only:false; response_revision:6834; number_of_response:1; }","duration":"141.004816ms","start":"2026-03-19T09:12:58.669385Z","end":"2026-03-19T09:12:58.81039Z","steps":["trace[1324408939] 'process raft request'  (duration: 140.671678ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:12:59.757799Z","caller":"traceutil/trace.go:171","msg":"trace[757208489] transaction","detail":"{read_only:false; response_revision:6839; number_of_response:1; }","duration":"142.997783ms","start":"2026-03-19T09:12:59.614774Z","end":"2026-03-19T09:12:59.757771Z","steps":["trace[757208489] 'process raft request'  (duration: 101.084764ms)","trace[757208489] 'compare'  (duration: 41.625772ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:12:59.758037Z","caller":"traceutil/trace.go:171","msg":"trace[1676860983] transaction","detail":"{read_only:false; response_revision:6840; number_of_response:1; }","duration":"120.071531ms","start":"2026-03-19T09:12:59.637923Z","end":"2026-03-19T09:12:59.757994Z","steps":["trace[1676860983] 'process raft request'  (duration: 119.779574ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:00.995356Z","caller":"traceutil/trace.go:171","msg":"trace[1624770728] linearizableReadLoop","detail":"{readStateIndex:7099; appliedIndex:7098; }","duration":"132.72184ms","start":"2026-03-19T09:13:00.862611Z","end":"2026-03-19T09:13:00.995333Z","steps":["trace[1624770728] 'read index received'  (duration: 21.896367ms)","trace[1624770728] 'applied index is now lower than readState.Index'  (duration: 110.824573ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:00.995451Z","caller":"traceutil/trace.go:171","msg":"trace[1246056981] transaction","detail":"{read_only:false; response_revision:6847; number_of_response:1; }","duration":"173.071182ms","start":"2026-03-19T09:13:00.822319Z","end":"2026-03-19T09:13:00.99539Z","steps":["trace[1246056981] 'process raft request'  (duration: 172.856277ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:00.995607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.976576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-19T09:13:00.995656Z","caller":"traceutil/trace.go:171","msg":"trace[2139115401] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6847; }","duration":"133.084858ms","start":"2026-03-19T09:13:00.862561Z","end":"2026-03-19T09:13:00.995646Z","steps":["trace[2139115401] 'agreement among raft nodes before linearized reading'  (duration: 132.917964ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:01.600013Z","caller":"traceutil/trace.go:171","msg":"trace[2136137805] linearizableReadLoop","detail":"{readStateIndex:7104; appliedIndex:7103; }","duration":"100.535312ms","start":"2026-03-19T09:13:01.499452Z","end":"2026-03-19T09:13:01.599987Z","steps":["trace[2136137805] 'read index received'  (duration: 100.277906ms)","trace[2136137805] 'applied index is now lower than readState.Index'  (duration: 256.026µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:01.600121Z","caller":"traceutil/trace.go:171","msg":"trace[1859006966] transaction","detail":"{read_only:false; response_revision:6852; number_of_response:1; }","duration":"104.525565ms","start":"2026-03-19T09:13:01.495563Z","end":"2026-03-19T09:13:01.600089Z","steps":["trace[1859006966] 'process raft request'  (duration: 104.257589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:01.600251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.782467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:13:01.600293Z","caller":"traceutil/trace.go:171","msg":"trace[1679189938] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:6852; }","duration":"100.865019ms","start":"2026-03-19T09:13:01.49941Z","end":"2026-03-19T09:13:01.600275Z","steps":["trace[1679189938] 'agreement among raft nodes before linearized reading'  (duration: 100.677335ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:02.123375Z","caller":"traceutil/trace.go:171","msg":"trace[2099523181] transaction","detail":"{read_only:false; response_revision:6856; number_of_response:1; }","duration":"116.930868ms","start":"2026-03-19T09:13:02.006404Z","end":"2026-03-19T09:13:02.123335Z","steps":["trace[2099523181] 'process raft request'  (duration: 96.214359ms)","trace[2099523181] 'compare'  (duration: 19.89387ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:02.292959Z","caller":"traceutil/trace.go:171","msg":"trace[1877805728] transaction","detail":"{read_only:false; response_revision:6857; number_of_response:1; }","duration":"164.570211ms","start":"2026-03-19T09:13:02.128358Z","end":"2026-03-19T09:13:02.292929Z","steps":["trace[1877805728] 'process raft request'  (duration: 154.286189ms)","trace[1877805728] 'compare'  (duration: 10.164779ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:02.354864Z","caller":"traceutil/trace.go:171","msg":"trace[1551073002] transaction","detail":"{read_only:false; response_revision:6858; number_of_response:1; }","duration":"220.429898ms","start":"2026-03-19T09:13:02.134422Z","end":"2026-03-19T09:13:02.354852Z","steps":["trace[1551073002] 'process raft request'  (duration: 220.340066ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:02.715222Z","caller":"traceutil/trace.go:171","msg":"trace[144785212] transaction","detail":"{read_only:false; response_revision:6863; number_of_response:1; }","duration":"100.850269ms","start":"2026-03-19T09:13:02.614342Z","end":"2026-03-19T09:13:02.715192Z","steps":["trace[144785212] 'process raft request'  (duration: 90.879314ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:03.243364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.901454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933144295149242772 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:6849 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T09:13:03.24349Z","caller":"traceutil/trace.go:171","msg":"trace[1076683816] transaction","detail":"{read_only:false; response_revision:6871; number_of_response:1; }","duration":"171.428754ms","start":"2026-03-19T09:13:03.07204Z","end":"2026-03-19T09:13:03.243468Z","steps":["trace[1076683816] 'process raft request'  (duration: 27.319555ms)","trace[1076683816] 'compare'  (duration: 143.767771ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:03.288153Z","caller":"traceutil/trace.go:171","msg":"trace[1329117463] transaction","detail":"{read_only:false; response_revision:6872; number_of_response:1; }","duration":"127.082647ms","start":"2026-03-19T09:13:03.161051Z","end":"2026-03-19T09:13:03.288133Z","steps":["trace[1329117463] 'process raft request'  (duration: 126.978305ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:03.561618Z","caller":"traceutil/trace.go:171","msg":"trace[2036338629] linearizableReadLoop","detail":"{readStateIndex:7126; appliedIndex:7125; }","duration":"104.087164ms","start":"2026-03-19T09:13:03.457503Z","end":"2026-03-19T09:13:03.56159Z","steps":["trace[2036338629] 'read index received'  (duration: 85.396914ms)","trace[2036338629] 'applied index is now lower than readState.Index'  (duration: 18.6891ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:13:03.561778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.260459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:13:03.56183Z","caller":"traceutil/trace.go:171","msg":"trace[1391669170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6874; }","duration":"104.361891ms","start":"2026-03-19T09:13:03.457456Z","end":"2026-03-19T09:13:03.561818Z","steps":["trace[1391669170] 'agreement among raft nodes before linearized reading'  (duration: 104.244388ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:13:03.561722Z","caller":"traceutil/trace.go:171","msg":"trace[1858718809] transaction","detail":"{read_only:false; response_revision:6874; number_of_response:1; }","duration":"116.278932ms","start":"2026-03-19T09:13:03.445406Z","end":"2026-03-19T09:13:03.561685Z","steps":["trace[1858718809] 'process raft request'  (duration: 97.598682ms)","trace[1858718809] 'compare'  (duration: 18.441205ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:04.918757Z","caller":"traceutil/trace.go:171","msg":"trace[448999983] transaction","detail":"{read_only:false; response_revision:6884; number_of_response:1; }","duration":"132.919605ms","start":"2026-03-19T09:13:04.785812Z","end":"2026-03-19T09:13:04.918732Z","steps":["trace[448999983] 'process raft request'  (duration: 106.049201ms)","trace[448999983] 'compare'  (duration: 26.622858ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:13:06.498147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.279648ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933144295149242824 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:6878 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T09:13:06.498268Z","caller":"traceutil/trace.go:171","msg":"trace[1635201018] linearizableReadLoop","detail":"{readStateIndex:7144; appliedIndex:7143; }","duration":"169.945547ms","start":"2026-03-19T09:13:06.328302Z","end":"2026-03-19T09:13:06.498247Z","steps":["trace[1635201018] 'read index received'  (duration: 43.487345ms)","trace[1635201018] 'applied index is now lower than readState.Index'  (duration: 126.456642ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:13:06.498543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.234935ms","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-03-19T09:13:06.498631Z","caller":"traceutil/trace.go:171","msg":"trace[1857052643] transaction","detail":"{read_only:false; response_revision:6891; number_of_response:1; }","duration":"406.364933ms","start":"2026-03-19T09:13:06.092234Z","end":"2026-03-19T09:13:06.498599Z","steps":["trace[1857052643] 'process raft request'  (duration: 279.541061ms)","trace[1857052643] 'compare'  (duration: 125.979071ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:06.498635Z","caller":"traceutil/trace.go:171","msg":"trace[1880221193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6891; }","duration":"170.374568ms","start":"2026-03-19T09:13:06.328243Z","end":"2026-03-19T09:13:06.498617Z","steps":["trace[1880221193] 'agreement among raft nodes before linearized reading'  (duration: 170.135773ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:06.498786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:13:06.092209Z","time spent":"406.495086ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:6878 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-19T09:13:09.952404Z","caller":"traceutil/trace.go:171","msg":"trace[918657599] linearizableReadLoop","detail":"{readStateIndex:7162; appliedIndex:7161; }","duration":"168.532355ms","start":"2026-03-19T09:13:09.78385Z","end":"2026-03-19T09:13:09.952383Z","steps":["trace[918657599] 'read index received'  (duration: 168.36916ms)","trace[918657599] 'applied index is now lower than readState.Index'  (duration: 162.365µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:13:09.952467Z","caller":"traceutil/trace.go:171","msg":"trace[937591297] transaction","detail":"{read_only:false; response_revision:6908; number_of_response:1; }","duration":"356.335794ms","start":"2026-03-19T09:13:09.596092Z","end":"2026-03-19T09:13:09.952427Z","steps":["trace[937591297] 'process raft request'  (duration: 356.147729ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:09.952644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.789061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-03-19T09:13:09.952652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:13:09.596073Z","time spent":"356.477918ms","remote":"127.0.0.1:51886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.12\" mod_revision:6840 > success:<request_put:<key:\"/registry/masterleases/199.19.213.12\" value_size:66 lease:7709772258294467077 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.12\" > >"}
{"level":"info","ts":"2026-03-19T09:13:09.952694Z","caller":"traceutil/trace.go:171","msg":"trace[2026622383] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6908; }","duration":"168.885913ms","start":"2026-03-19T09:13:09.783793Z","end":"2026-03-19T09:13:09.952679Z","steps":["trace[2026622383] 'agreement among raft nodes before linearized reading'  (duration: 168.712719ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:13:09.952687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.701205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:13:09.952757Z","caller":"traceutil/trace.go:171","msg":"trace[1082776065] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:6908; }","duration":"100.814447ms","start":"2026-03-19T09:13:09.851925Z","end":"2026-03-19T09:13:09.95274Z","steps":["trace[1082776065] 'agreement among raft nodes before linearized reading'  (duration: 100.616733ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:14:48.920448Z","caller":"traceutil/trace.go:171","msg":"trace[571704599] linearizableReadLoop","detail":"{readStateIndex:7945; appliedIndex:7944; }","duration":"194.710431ms","start":"2026-03-19T09:14:48.725711Z","end":"2026-03-19T09:14:48.920421Z","steps":["trace[571704599] 'read index received'  (duration: 194.486026ms)","trace[571704599] 'applied index is now lower than readState.Index'  (duration: 222.985µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:14:48.920593Z","caller":"traceutil/trace.go:171","msg":"trace[571807106] transaction","detail":"{read_only:false; response_revision:7666; number_of_response:1; }","duration":"251.000754ms","start":"2026-03-19T09:14:48.669581Z","end":"2026-03-19T09:14:48.920582Z","steps":["trace[571807106] 'process raft request'  (duration: 250.700367ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:14:48.920798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.07886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-03-19T09:14:48.920829Z","caller":"traceutil/trace.go:171","msg":"trace[398820040] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7666; }","duration":"195.153172ms","start":"2026-03-19T09:14:48.725666Z","end":"2026-03-19T09:14:48.920819Z","steps":["trace[398820040] 'agreement among raft nodes before linearized reading'  (duration: 195.029409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:14:48.92104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.399981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:14:48.921131Z","caller":"traceutil/trace.go:171","msg":"trace[291926421] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:7666; }","duration":"188.534503ms","start":"2026-03-19T09:14:48.732578Z","end":"2026-03-19T09:14:48.921113Z","steps":["trace[291926421] 'agreement among raft nodes before linearized reading'  (duration: 188.318388ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:14:49.113155Z","caller":"traceutil/trace.go:171","msg":"trace[1304363682] transaction","detail":"{read_only:false; response_revision:7667; number_of_response:1; }","duration":"186.317292ms","start":"2026-03-19T09:14:48.926814Z","end":"2026-03-19T09:14:49.113131Z","steps":["trace[1304363682] 'process raft request'  (duration: 180.498945ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:00.459767Z","caller":"traceutil/trace.go:171","msg":"trace[711083535] linearizableReadLoop","detail":"{readStateIndex:8003; appliedIndex:8002; }","duration":"463.129036ms","start":"2026-03-19T09:14:59.996613Z","end":"2026-03-19T09:15:00.459742Z","steps":["trace[711083535] 'read index received'  (duration: 368.442064ms)","trace[711083535] 'applied index is now lower than readState.Index'  (duration: 94.685912ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:00.459853Z","caller":"traceutil/trace.go:171","msg":"trace[1090784799] transaction","detail":"{read_only:false; response_revision:7721; number_of_response:1; }","duration":"508.916231ms","start":"2026-03-19T09:14:59.950896Z","end":"2026-03-19T09:15:00.459812Z","steps":["trace[1090784799] 'process raft request'  (duration: 414.178267ms)","trace[1090784799] 'compare'  (duration: 94.454997ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:15:00.459972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.347381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-19T09:15:00.459999Z","caller":"traceutil/trace.go:171","msg":"trace[1121357682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7721; }","duration":"463.389422ms","start":"2026-03-19T09:14:59.996602Z","end":"2026-03-19T09:15:00.459991Z","steps":["trace[1121357682] 'agreement among raft nodes before linearized reading'  (duration: 463.253729ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:00.459999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:14:59.950871Z","time spent":"509.043944ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7710 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-03-19T09:15:00.46002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:14:59.996571Z","time spent":"463.444083ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-19T09:15:00.489076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.18699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:15:00.489145Z","caller":"traceutil/trace.go:171","msg":"trace[1546929620] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:7722; }","duration":"216.339083ms","start":"2026-03-19T09:15:00.272793Z","end":"2026-03-19T09:15:00.489132Z","steps":["trace[1546929620] 'agreement among raft nodes before linearized reading'  (duration: 216.181279ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:00.489325Z","caller":"traceutil/trace.go:171","msg":"trace[2010490038] transaction","detail":"{read_only:false; response_revision:7722; number_of_response:1; }","duration":"437.202862ms","start":"2026-03-19T09:15:00.052096Z","end":"2026-03-19T09:15:00.489299Z","steps":["trace[2010490038] 'process raft request'  (duration: 436.755001ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:00.489466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T09:15:00.052077Z","time spent":"437.320995ms","remote":"127.0.0.1:52104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:7685 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-03-19T09:15:01.373877Z","caller":"traceutil/trace.go:171","msg":"trace[2104530583] transaction","detail":"{read_only:false; response_revision:7727; number_of_response:1; }","duration":"114.186873ms","start":"2026-03-19T09:15:01.259624Z","end":"2026-03-19T09:15:01.373811Z","steps":["trace[2104530583] 'process raft request'  (duration: 42.742692ms)","trace[2104530583] 'compare'  (duration: 70.98117ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:02.63573Z","caller":"traceutil/trace.go:171","msg":"trace[2146693265] transaction","detail":"{read_only:false; response_revision:7732; number_of_response:1; }","duration":"124.818486ms","start":"2026-03-19T09:15:02.510864Z","end":"2026-03-19T09:15:02.635682Z","steps":["trace[2146693265] 'process raft request'  (duration: 53.957627ms)","trace[2146693265] 'compare'  (duration: 70.633263ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:03.298877Z","caller":"traceutil/trace.go:171","msg":"trace[1140115501] transaction","detail":"{read_only:false; response_revision:7734; number_of_response:1; }","duration":"104.550265ms","start":"2026-03-19T09:15:03.194215Z","end":"2026-03-19T09:15:03.298765Z","steps":["trace[1140115501] 'process raft request'  (duration: 104.279329ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:06.593775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5741}
{"level":"info","ts":"2026-03-19T09:15:06.70259Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5741,"took":"105.083349ms","hash":4114743793,"current-db-size-bytes":43380736,"current-db-size":"43 MB","current-db-size-in-use-bytes":22953984,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-19T09:15:06.702655Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4114743793,"revision":5741,"compact-revision":2782}
{"level":"warn","ts":"2026-03-19T09:15:30.729403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.267769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:15:30.729493Z","caller":"traceutil/trace.go:171","msg":"trace[324636878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7922; }","duration":"270.406572ms","start":"2026-03-19T09:15:30.459067Z","end":"2026-03-19T09:15:30.729474Z","steps":["trace[324636878] 'range keys from in-memory index tree'  (duration: 270.207128ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:30.729834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.277671ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16933144295149245735 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:7837 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T09:15:30.729887Z","caller":"traceutil/trace.go:171","msg":"trace[493069946] transaction","detail":"{read_only:false; response_revision:7923; number_of_response:1; }","duration":"198.996343ms","start":"2026-03-19T09:15:30.530876Z","end":"2026-03-19T09:15:30.729872Z","steps":["trace[493069946] 'process raft request'  (duration: 20.631189ms)","trace[493069946] 'compare'  (duration: 177.479703ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:30.781718Z","caller":"traceutil/trace.go:171","msg":"trace[1917121826] linearizableReadLoop","detail":"{readStateIndex:8215; appliedIndex:8214; }","duration":"132.141988ms","start":"2026-03-19T09:15:30.649542Z","end":"2026-03-19T09:15:30.781684Z","steps":["trace[1917121826] 'read index received'  (duration: 131.885092ms)","trace[1917121826] 'applied index is now lower than readState.Index'  (duration: 255.616µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:30.781742Z","caller":"traceutil/trace.go:171","msg":"trace[824214268] transaction","detail":"{read_only:false; response_revision:7924; number_of_response:1; }","duration":"133.686006ms","start":"2026-03-19T09:15:30.64802Z","end":"2026-03-19T09:15:30.781706Z","steps":["trace[824214268] 'process raft request'  (duration: 133.495411ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:30.781994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.431075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-74878b475f-fv7df.189e334663ebeb07\" ","response":"range_response_count:1 size:1134"}
{"level":"info","ts":"2026-03-19T09:15:30.782055Z","caller":"traceutil/trace.go:171","msg":"trace[2000619751] range","detail":"{range_begin:/registry/events/openstack/barbican-api-74878b475f-fv7df.189e334663ebeb07; range_end:; response_count:1; response_revision:7924; }","duration":"132.528838ms","start":"2026-03-19T09:15:30.649507Z","end":"2026-03-19T09:15:30.782036Z","steps":["trace[2000619751] 'agreement among raft nodes before linearized reading'  (duration: 132.301272ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:32.178106Z","caller":"traceutil/trace.go:171","msg":"trace[1948642595] transaction","detail":"{read_only:false; response_revision:7931; number_of_response:1; }","duration":"124.434266ms","start":"2026-03-19T09:15:32.05364Z","end":"2026-03-19T09:15:32.178074Z","steps":["trace[1948642595] 'process raft request'  (duration: 124.237412ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:32.9507Z","caller":"traceutil/trace.go:171","msg":"trace[731029147] linearizableReadLoop","detail":"{readStateIndex:8225; appliedIndex:8224; }","duration":"104.448553ms","start":"2026-03-19T09:15:32.846232Z","end":"2026-03-19T09:15:32.95068Z","steps":["trace[731029147] 'read index received'  (duration: 104.34681ms)","trace[731029147] 'applied index is now lower than readState.Index'  (duration: 100.843µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:32.950817Z","caller":"traceutil/trace.go:171","msg":"trace[1676866203] transaction","detail":"{read_only:false; response_revision:7933; number_of_response:1; }","duration":"163.696486ms","start":"2026-03-19T09:15:32.787081Z","end":"2026-03-19T09:15:32.950778Z","steps":["trace[1676866203] 'process raft request'  (duration: 163.488031ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:32.950862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.610476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-19T09:15:32.950901Z","caller":"traceutil/trace.go:171","msg":"trace[749444931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7933; }","duration":"104.699248ms","start":"2026-03-19T09:15:32.846191Z","end":"2026-03-19T09:15:32.95089Z","steps":["trace[749444931] 'agreement among raft nodes before linearized reading'  (duration: 104.566645ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:33.219212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.153522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"}
{"level":"info","ts":"2026-03-19T09:15:33.219298Z","caller":"traceutil/trace.go:171","msg":"trace[1977818739] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:7934; }","duration":"149.278345ms","start":"2026-03-19T09:15:33.070001Z","end":"2026-03-19T09:15:33.21928Z","steps":["trace[1977818739] 'range keys from in-memory index tree'  (duration: 148.961537ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:33.414544Z","caller":"traceutil/trace.go:171","msg":"trace[561631320] linearizableReadLoop","detail":"{readStateIndex:8227; appliedIndex:8226; }","duration":"204.749938ms","start":"2026-03-19T09:15:33.20977Z","end":"2026-03-19T09:15:33.414519Z","steps":["trace[561631320] 'read index received'  (duration: 204.612375ms)","trace[561631320] 'applied index is now lower than readState.Index'  (duration: 136.733µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:33.414669Z","caller":"traceutil/trace.go:171","msg":"trace[1231527581] transaction","detail":"{read_only:false; response_revision:7935; number_of_response:1; }","duration":"208.248611ms","start":"2026-03-19T09:15:33.206405Z","end":"2026-03-19T09:15:33.414653Z","steps":["trace[1231527581] 'process raft request'  (duration: 207.958494ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:33.415081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.01387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a374c613-6249-4143-a377-9b6d2470899a\" ","response":"range_response_count:1 size:1293"}
{"level":"info","ts":"2026-03-19T09:15:33.415209Z","caller":"traceutil/trace.go:171","msg":"trace[1338115000] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a374c613-6249-4143-a377-9b6d2470899a; range_end:; response_count:1; response_revision:7935; }","duration":"193.178834ms","start":"2026-03-19T09:15:33.221997Z","end":"2026-03-19T09:15:33.415176Z","steps":["trace[1338115000] 'agreement among raft nodes before linearized reading'  (duration: 192.824736ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:33.415641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.084535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:15:33.415702Z","caller":"traceutil/trace.go:171","msg":"trace[1331200955] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:7935; }","duration":"205.960156ms","start":"2026-03-19T09:15:33.209726Z","end":"2026-03-19T09:15:33.415686Z","steps":["trace[1331200955] 'agreement among raft nodes before linearized reading'  (duration: 204.915112ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:33.575862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.539879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:15:33.575938Z","caller":"traceutil/trace.go:171","msg":"trace[406552182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7935; }","duration":"116.675242ms","start":"2026-03-19T09:15:33.459246Z","end":"2026-03-19T09:15:33.575921Z","steps":["trace[406552182] 'range keys from in-memory index tree'  (duration: 116.456487ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:33.5761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.197179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228519"}
{"level":"info","ts":"2026-03-19T09:15:33.576133Z","caller":"traceutil/trace.go:171","msg":"trace[82325303] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:7935; }","duration":"156.23343ms","start":"2026-03-19T09:15:33.419893Z","end":"2026-03-19T09:15:33.576127Z","steps":["trace[82325303] 'range keys from in-memory index tree'  (duration: 155.8613ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:34.095118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.944817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:15:34.095202Z","caller":"traceutil/trace.go:171","msg":"trace[304822800] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:7938; }","duration":"187.06919ms","start":"2026-03-19T09:15:33.90811Z","end":"2026-03-19T09:15:34.09518Z","steps":["trace[304822800] 'count revisions from in-memory index tree'  (duration: 186.814013ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:44.248329Z","caller":"traceutil/trace.go:171","msg":"trace[1614572511] transaction","detail":"{read_only:false; response_revision:8028; number_of_response:1; }","duration":"146.344455ms","start":"2026-03-19T09:15:44.10196Z","end":"2026-03-19T09:15:44.248305Z","steps":["trace[1614572511] 'process raft request'  (duration: 146.172871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:44.522551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.431172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T09:15:44.522652Z","caller":"traceutil/trace.go:171","msg":"trace[1140107322] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8028; }","duration":"199.606936ms","start":"2026-03-19T09:15:44.323026Z","end":"2026-03-19T09:15:44.522633Z","steps":["trace[1140107322] 'count revisions from in-memory index tree'  (duration: 199.298509ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:44.522708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.986406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-19T09:15:44.522775Z","caller":"traceutil/trace.go:171","msg":"trace[1063670422] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8028; }","duration":"192.078497ms","start":"2026-03-19T09:15:44.330683Z","end":"2026-03-19T09:15:44.522761Z","steps":["trace[1063670422] 'range keys from in-memory index tree'  (duration: 191.870883ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:44.522989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.305849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-19T09:15:44.523034Z","caller":"traceutil/trace.go:171","msg":"trace[617405246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8028; }","duration":"270.391012ms","start":"2026-03-19T09:15:44.252632Z","end":"2026-03-19T09:15:44.523023Z","steps":["trace[617405246] 'range keys from in-memory index tree'  (duration: 270.135056ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:44.634433Z","caller":"traceutil/trace.go:171","msg":"trace[749347317] transaction","detail":"{read_only:false; response_revision:8029; number_of_response:1; }","duration":"106.296366ms","start":"2026-03-19T09:15:44.528114Z","end":"2026-03-19T09:15:44.63441Z","steps":["trace[749347317] 'process raft request'  (duration: 106.158583ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:44.669812Z","caller":"traceutil/trace.go:171","msg":"trace[289433018] transaction","detail":"{read_only:false; response_revision:8030; number_of_response:1; }","duration":"141.170134ms","start":"2026-03-19T09:15:44.528581Z","end":"2026-03-19T09:15:44.669751Z","steps":["trace[289433018] 'process raft request'  (duration: 140.971489ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:45.344522Z","caller":"traceutil/trace.go:171","msg":"trace[1646068912] transaction","detail":"{read_only:false; response_revision:8038; number_of_response:1; }","duration":"155.953452ms","start":"2026-03-19T09:15:45.188539Z","end":"2026-03-19T09:15:45.344492Z","steps":["trace[1646068912] 'process raft request'  (duration: 138.313225ms)","trace[1646068912] 'compare'  (duration: 17.497024ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:15:45.617746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.338597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T09:15:45.617831Z","caller":"traceutil/trace.go:171","msg":"trace[303870211] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8038; }","duration":"160.453109ms","start":"2026-03-19T09:15:45.457349Z","end":"2026-03-19T09:15:45.617802Z","steps":["trace[303870211] 'range keys from in-memory index tree'  (duration: 160.271954ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:45.618163Z","caller":"traceutil/trace.go:171","msg":"trace[43879297] transaction","detail":"{read_only:false; response_revision:8039; number_of_response:1; }","duration":"127.061248ms","start":"2026-03-19T09:15:45.491066Z","end":"2026-03-19T09:15:45.618127Z","steps":["trace[43879297] 'process raft request'  (duration: 92.530311ms)","trace[43879297] 'compare'  (duration: 34.074767ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T09:15:45.867028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.237917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nnnvv\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-03-19T09:15:45.867096Z","caller":"traceutil/trace.go:171","msg":"trace[602091066] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nnnvv; range_end:; response_count:1; response_revision:8039; }","duration":"139.32959ms","start":"2026-03-19T09:15:45.727749Z","end":"2026-03-19T09:15:45.867079Z","steps":["trace[602091066] 'range keys from in-memory index tree'  (duration: 139.100925ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:15:45.867081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.578073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-03-19T09:15:45.867178Z","caller":"traceutil/trace.go:171","msg":"trace[839191481] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8039; }","duration":"141.723386ms","start":"2026-03-19T09:15:45.725433Z","end":"2026-03-19T09:15:45.867156Z","steps":["trace[839191481] 'range keys from in-memory index tree'  (duration: 141.363708ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:45.867516Z","caller":"traceutil/trace.go:171","msg":"trace[1868659098] transaction","detail":"{read_only:false; response_revision:8040; number_of_response:1; }","duration":"128.023002ms","start":"2026-03-19T09:15:45.739469Z","end":"2026-03-19T09:15:45.867492Z","steps":["trace[1868659098] 'process raft request'  (duration: 61.762152ms)","trace[1868659098] 'compare'  (duration: 65.531403ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:15:46.019163Z","caller":"traceutil/trace.go:171","msg":"trace[1584794574] transaction","detail":"{read_only:false; response_revision:8043; number_of_response:1; }","duration":"145.830563ms","start":"2026-03-19T09:15:45.8733Z","end":"2026-03-19T09:15:46.01913Z","steps":["trace[1584794574] 'process raft request'  (duration: 145.68679ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:15:46.019248Z","caller":"traceutil/trace.go:171","msg":"trace[51748614] transaction","detail":"{read_only:false; response_revision:8042; number_of_response:1; }","duration":"146.475718ms","start":"2026-03-19T09:15:45.872689Z","end":"2026-03-19T09:15:46.019165Z","steps":["trace[51748614] 'process raft request'  (duration: 146.14526ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:17:03.660688Z","caller":"traceutil/trace.go:171","msg":"trace[1562434564] linearizableReadLoop","detail":"{readStateIndex:9072; appliedIndex:9071; }","duration":"119.956962ms","start":"2026-03-19T09:17:03.540708Z","end":"2026-03-19T09:17:03.660665Z","steps":["trace[1562434564] 'read index received'  (duration: 119.790098ms)","trace[1562434564] 'applied index is now lower than readState.Index'  (duration: 165.984µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T09:17:03.660771Z","caller":"traceutil/trace.go:171","msg":"trace[1423135643] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"223.817662ms","start":"2026-03-19T09:17:03.436907Z","end":"2026-03-19T09:17:03.660725Z","steps":["trace[1423135643] 'process raft request'  (duration: 223.620917ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T09:17:03.660887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.162027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-19T09:17:03.660941Z","caller":"traceutil/trace.go:171","msg":"trace[1524540826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8755; }","duration":"120.268899ms","start":"2026-03-19T09:17:03.540661Z","end":"2026-03-19T09:17:03.66093Z","steps":["trace[1524540826] 'agreement among raft nodes before linearized reading'  (duration: 120.090225ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T09:19:12.680927Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"790561176553eafe","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-19T09:19:12.693129Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-19T09:19:12.693261Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-19T09:20:06.600046Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7756}
{"level":"info","ts":"2026-03-19T09:20:06.659085Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7756,"took":"57.222782ms","hash":3911200081,"current-db-size-bytes":43380736,"current-db-size":"43 MB","current-db-size-in-use-bytes":26132480,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-19T09:20:06.659142Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3911200081,"revision":7756,"compact-revision":5741}
{"level":"info","ts":"2026-03-19T09:25:06.605894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9996}
{"level":"info","ts":"2026-03-19T09:25:06.682067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9996,"took":"74.099857ms","hash":3870339995,"current-db-size-bytes":43380736,"current-db-size":"43 MB","current-db-size-in-use-bytes":17571840,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-03-19T09:25:06.682156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3870339995,"revision":9996,"compact-revision":7756}