{"level":"warn","ts":"2026-07-30T21:02:36.873398Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-30T21:02:36.873496Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.163: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.163:2380","--initial-cluster=instance=https://199.19.213.163:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.163:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.163:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-07-30T21:02:36.873561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-30T21:02:36.873573Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.163:2380"]}
{"level":"info","ts":"2026-07-30T21:02:36.873589Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-07-30T21:02:36.874132Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"]}
{"level":"info","ts":"2026-07-30T21:02:36.874205Z","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.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.163:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-07-30T21:02:36.877663Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.254497ms"}
{"level":"info","ts":"2026-07-30T21:02:36.882764Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e7941a908d261618","cluster-id":"5b6cb15db6ea8c10"}
{"level":"info","ts":"2026-07-30T21:02:36.882833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-30T21:02:36.882861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 0"}
{"level":"info","ts":"2026-07-30T21:02:36.882875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e7941a908d261618 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-30T21:02:36.882891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 1"}
{"level":"info","ts":"2026-07-30T21:02:36.882926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"}
{"level":"warn","ts":"2026-07-30T21:02:36.887888Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-30T21:02:36.88981Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-30T21:02:36.890923Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-07-30T21:02:36.893993Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e7941a908d261618","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-30T21:02:36.894246Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e7941a908d261618","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-30T21:02:36.894299Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-30T21:02:36.89445Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-30T21:02:36.894468Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-07-30T21:02:36.895804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"}
{"level":"info","ts":"2026-07-30T21:02:36.896374Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","added-peer-id":"e7941a908d261618","added-peer-peer-urls":["https://199.19.213.163:2380"]}
{"level":"info","ts":"2026-07-30T21:02:36.898874Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-07-30T21:02:36.899016Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.163:2380"}
{"level":"info","ts":"2026-07-30T21:02:36.899086Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.163:2380"}
{"level":"info","ts":"2026-07-30T21:02:36.899175Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e7941a908d261618","initial-advertise-peer-urls":["https://199.19.213.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-30T21:02:36.899239Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-30T21:02:37.183609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-30T21:02:37.183685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-30T21:02:37.183727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgPreVoteResp from e7941a908d261618 at term 1"}
{"level":"info","ts":"2026-07-30T21:02:37.183747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became candidate at term 2"}
{"level":"info","ts":"2026-07-30T21:02:37.183764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgVoteResp from e7941a908d261618 at term 2"}
{"level":"info","ts":"2026-07-30T21:02:37.183785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became leader at term 2"}
{"level":"info","ts":"2026-07-30T21:02:37.183803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e7941a908d261618 elected leader e7941a908d261618 at term 2"}
{"level":"info","ts":"2026-07-30T21:02:37.184873Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T21:02:37.185734Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e7941a908d261618","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.163:2379]}","request-path":"/0/members/e7941a908d261618/attributes","cluster-id":"5b6cb15db6ea8c10","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-30T21:02:37.185739Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-30T21:02:37.185789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-30T21:02:37.185994Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-30T21:02:37.186308Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-30T21:02:37.188808Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.163:2379"}
{"level":"info","ts":"2026-07-30T21:02:37.18898Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T21:02:37.189455Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T21:02:37.189573Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T21:02:37.192503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-30T21:03:03.054585Z","caller":"traceutil/trace.go:171","msg":"trace[939232294] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"119.157586ms","start":"2026-07-30T21:03:02.935404Z","end":"2026-07-30T21:03:03.054562Z","steps":["trace[939232294] 'process raft request'  (duration: 119.013063ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:03:20.967481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.605728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-30T21:03:20.967627Z","caller":"traceutil/trace.go:171","msg":"trace[895908982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"159.796752ms","start":"2026-07-30T21:03:20.807811Z","end":"2026-07-30T21:03:20.967608Z","steps":["trace[895908982] 'range keys from in-memory index tree'  (duration: 159.513917ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:04:38.960733Z","caller":"traceutil/trace.go:171","msg":"trace[1386267862] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"170.355016ms","start":"2026-07-30T21:04:38.790349Z","end":"2026-07-30T21:04:38.960704Z","steps":["trace[1386267862] 'process raft request'  (duration: 169.640302ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:04:39.812732Z","caller":"traceutil/trace.go:171","msg":"trace[781127715] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1365; }","duration":"206.568806ms","start":"2026-07-30T21:04:39.606135Z","end":"2026-07-30T21:04:39.812704Z","steps":["trace[781127715] 'read index received'  (duration: 206.390033ms)","trace[781127715] 'applied index is now lower than readState.Index'  (duration: 177.353µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T21:04:39.812883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.726649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-30T21:04:39.81293Z","caller":"traceutil/trace.go:171","msg":"trace[568650167] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1326; }","duration":"206.837802ms","start":"2026-07-30T21:04:39.606082Z","end":"2026-07-30T21:04:39.81292Z","steps":["trace[568650167] 'agreement among raft nodes before linearized reading'  (duration: 206.725129ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:04:39.812902Z","caller":"traceutil/trace.go:171","msg":"trace[964720279] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"259.784621ms","start":"2026-07-30T21:04:39.552994Z","end":"2026-07-30T21:04:39.812778Z","steps":["trace[964720279] 'process raft request'  (duration: 259.532446ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:05:29.742555Z","caller":"traceutil/trace.go:171","msg":"trace[724743040] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"191.403019ms","start":"2026-07-30T21:05:29.551122Z","end":"2026-07-30T21:05:29.742525Z","steps":["trace[724743040] 'process raft request'  (duration: 191.162734ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:05:29.742632Z","caller":"traceutil/trace.go:171","msg":"trace[592032258] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2176; }","duration":"168.720237ms","start":"2026-07-30T21:05:29.573865Z","end":"2026-07-30T21:05:29.742585Z","steps":["trace[592032258] 'read index received'  (duration: 167.584043ms)","trace[592032258] 'applied index is now lower than readState.Index'  (duration: 1.134254ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:05:29.742625Z","caller":"traceutil/trace.go:171","msg":"trace[461841992] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"109.567991ms","start":"2026-07-30T21:05:29.633025Z","end":"2026-07-30T21:05:29.742593Z","steps":["trace[461841992] 'process raft request'  (duration: 109.439639ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:05:29.742955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.072214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-30T21:05:29.742999Z","caller":"traceutil/trace.go:171","msg":"trace[1779656698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2103; }","duration":"169.176596ms","start":"2026-07-30T21:05:29.573811Z","end":"2026-07-30T21:05:29.742987Z","steps":["trace[1779656698] 'agreement among raft nodes before linearized reading'  (duration: 168.908831ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:05:44.426966Z","caller":"traceutil/trace.go:171","msg":"trace[2117121747] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"186.575079ms","start":"2026-07-30T21:05:44.240367Z","end":"2026-07-30T21:05:44.426942Z","steps":["trace[2117121747] 'process raft request'  (duration: 186.413986ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:06:08.332937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.567372ms","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-07-30T21:06:08.333039Z","caller":"traceutil/trace.go:171","msg":"trace[1031915173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2402; }","duration":"119.730155ms","start":"2026-07-30T21:06:08.213287Z","end":"2026-07-30T21:06:08.333017Z","steps":["trace[1031915173] 'range keys from in-memory index tree'  (duration: 119.344627ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:06:08.898421Z","caller":"traceutil/trace.go:171","msg":"trace[80740582] linearizableReadLoop","detail":"{readStateIndex:2490; appliedIndex:2489; }","duration":"275.671717ms","start":"2026-07-30T21:06:08.622723Z","end":"2026-07-30T21:06:08.898394Z","steps":["trace[80740582] 'read index received'  (duration: 275.498744ms)","trace[80740582] 'applied index is now lower than readState.Index'  (duration: 171.713µs)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:06:08.898576Z","caller":"traceutil/trace.go:171","msg":"trace[2135849569] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"307.166939ms","start":"2026-07-30T21:06:08.591351Z","end":"2026-07-30T21:06:08.898518Z","steps":["trace[2135849569] 'process raft request'  (duration: 306.880943ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:06:08.89882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.048655ms","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-07-30T21:06:08.898921Z","caller":"traceutil/trace.go:171","msg":"trace[1826339060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2405; }","duration":"276.217357ms","start":"2026-07-30T21:06:08.622682Z","end":"2026-07-30T21:06:08.898899Z","steps":["trace[1826339060] 'agreement among raft nodes before linearized reading'  (duration: 275.883581ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:06:08.899395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:08.591325Z","time spent":"307.384483ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2392 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-07-30T21:06:09.146061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.501035ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1592198067310126671 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2394 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-30T21:06:09.146314Z","caller":"traceutil/trace.go:171","msg":"trace[324935968] transaction","detail":"{read_only:false; response_revision:2407; number_of_response:1; }","duration":"242.539403ms","start":"2026-07-30T21:06:08.903757Z","end":"2026-07-30T21:06:09.146297Z","steps":["trace[324935968] 'process raft request'  (duration: 242.476311ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:06:09.146347Z","caller":"traceutil/trace.go:171","msg":"trace[1204120338] linearizableReadLoop","detail":"{readStateIndex:2491; appliedIndex:2490; }","duration":"247.74642ms","start":"2026-07-30T21:06:08.898565Z","end":"2026-07-30T21:06:09.146312Z","steps":["trace[1204120338] 'read index received'  (duration: 83.772574ms)","trace[1204120338] 'applied index is now lower than readState.Index'  (duration: 163.969686ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:06:09.146381Z","caller":"traceutil/trace.go:171","msg":"trace[252786666] transaction","detail":"{read_only:false; response_revision:2406; number_of_response:1; }","duration":"425.860333ms","start":"2026-07-30T21:06:08.720495Z","end":"2026-07-30T21:06:09.146355Z","steps":["trace[252786666] 'process raft request'  (duration: 261.785915ms)","trace[252786666] 'compare'  (duration: 163.401203ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T21:06:09.146522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:08.720478Z","time spent":"425.962434ms","remote":"127.0.0.1:38600","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:2394 > 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-07-30T21:06:09.146496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.26951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-07-30T21:06:09.14657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.748991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-07-30T21:06:09.146592Z","caller":"traceutil/trace.go:171","msg":"trace[1247257309] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2407; }","duration":"362.430753ms","start":"2026-07-30T21:06:08.78414Z","end":"2026-07-30T21:06:09.146571Z","steps":["trace[1247257309] 'agreement among raft nodes before linearized reading'  (duration: 362.198088ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:06:09.146624Z","caller":"traceutil/trace.go:171","msg":"trace[2027882939] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2407; }","duration":"456.824162ms","start":"2026-07-30T21:06:08.689773Z","end":"2026-07-30T21:06:09.146598Z","steps":["trace[2027882939] 'agreement among raft nodes before linearized reading'  (duration: 456.659059ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:06:09.146642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:08.784116Z","time spent":"362.516085ms","remote":"127.0.0.1:38604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":17,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-07-30T21:06:09.146667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:08.68976Z","time spent":"456.898104ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-07-30T21:06:09.146744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.259562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-07-30T21:06:09.146802Z","caller":"traceutil/trace.go:171","msg":"trace[837291142] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2407; }","duration":"401.379885ms","start":"2026-07-30T21:06:08.745406Z","end":"2026-07-30T21:06:09.146786Z","steps":["trace[837291142] 'agreement among raft nodes before linearized reading'  (duration: 401.185121ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:06:09.146835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:08.745395Z","time spent":"401.431546ms","remote":"127.0.0.1:60670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-07-30T21:07:57.078414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.639592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c72d5d84ed631f\" ","response":"range_response_count:1 size:779"}
{"level":"info","ts":"2026-07-30T21:07:57.078505Z","caller":"traceutil/trace.go:171","msg":"trace[1085211262] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c72d5d84ed631f; range_end:; response_count:1; response_revision:3178; }","duration":"114.772654ms","start":"2026-07-30T21:07:56.963716Z","end":"2026-07-30T21:07:57.078489Z","steps":["trace[1085211262] 'range keys from in-memory index tree'  (duration: 114.490608ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:07:57.263318Z","caller":"traceutil/trace.go:171","msg":"trace[17625406] transaction","detail":"{read_only:false; response_revision:3180; number_of_response:1; }","duration":"180.953051ms","start":"2026-07-30T21:07:57.082338Z","end":"2026-07-30T21:07:57.263291Z","steps":["trace[17625406] 'process raft request'  (duration: 177.594903ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:12:37.22539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3049}
{"level":"info","ts":"2026-07-30T21:12:37.328496Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3049,"took":"101.811867ms","hash":2911301238,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":8478720,"current-db-size-in-use":"8.5 MB"}
{"level":"info","ts":"2026-07-30T21:12:37.328602Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2911301238,"revision":3049,"compact-revision":-1}
{"level":"info","ts":"2026-07-30T21:16:32.96722Z","caller":"traceutil/trace.go:171","msg":"trace[1567897372] transaction","detail":"{read_only:false; response_revision:6790; number_of_response:1; }","duration":"103.594427ms","start":"2026-07-30T21:16:32.863572Z","end":"2026-07-30T21:16:32.967166Z","steps":["trace[1567897372] 'process raft request'  (duration: 103.037135ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:17:37.231719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4975}
{"level":"info","ts":"2026-07-30T21:17:37.270962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4975,"took":"37.956695ms","hash":3350578924,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":12251136,"current-db-size-in-use":"12 MB"}
{"level":"info","ts":"2026-07-30T21:17:37.271045Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3350578924,"revision":4975,"compact-revision":3049}
{"level":"info","ts":"2026-07-30T21:19:03.854582Z","caller":"traceutil/trace.go:171","msg":"trace[371549304] transaction","detail":"{read_only:false; response_revision:7936; number_of_response:1; }","duration":"128.705749ms","start":"2026-07-30T21:19:03.725841Z","end":"2026-07-30T21:19:03.854547Z","steps":["trace[371549304] 'process raft request'  (duration: 128.494125ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:20:30.398196Z","caller":"traceutil/trace.go:171","msg":"trace[407611328] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"141.360706ms","start":"2026-07-30T21:20:30.256817Z","end":"2026-07-30T21:20:30.398178Z","steps":["trace[407611328] 'read index received'  (duration: 46.374151ms)","trace[407611328] 'applied index is now lower than readState.Index'  (duration: 94.985665ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:20:30.398267Z","caller":"traceutil/trace.go:171","msg":"trace[1899958571] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"213.715457ms","start":"2026-07-30T21:20:30.184493Z","end":"2026-07-30T21:20:30.398208Z","steps":["trace[1899958571] 'process raft request'  (duration: 118.690172ms)","trace[1899958571] 'compare'  (duration: 94.790841ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T21:20:30.398451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.614811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.163\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-07-30T21:20:30.398499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.892233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-30T21:20:30.39854Z","caller":"traceutil/trace.go:171","msg":"trace[64029856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8706; }","duration":"133.987395ms","start":"2026-07-30T21:20:30.264541Z","end":"2026-07-30T21:20:30.398529Z","steps":["trace[64029856] 'agreement among raft nodes before linearized reading'  (duration: 133.853772ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:20:30.398549Z","caller":"traceutil/trace.go:171","msg":"trace[26172142] range","detail":"{range_begin:/registry/masterleases/199.19.213.163; range_end:; response_count:1; response_revision:8706; }","duration":"141.767295ms","start":"2026-07-30T21:20:30.256757Z","end":"2026-07-30T21:20:30.398524Z","steps":["trace[26172142] 'agreement among raft nodes before linearized reading'  (duration: 141.491568ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:20:30.398588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.684024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-07-30T21:20:30.398639Z","caller":"traceutil/trace.go:171","msg":"trace[620562729] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:8706; }","duration":"122.754595ms","start":"2026-07-30T21:20:30.275868Z","end":"2026-07-30T21:20:30.398623Z","steps":["trace[620562729] 'agreement among raft nodes before linearized reading'  (duration: 122.622772ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:21:59.727257Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592198067310143663,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-30T21:22:00.163184Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.008920938s","expected-duration":"1s"}
{"level":"info","ts":"2026-07-30T21:22:00.16435Z","caller":"traceutil/trace.go:171","msg":"trace[1564964261] transaction","detail":"{read_only:false; response_revision:9390; number_of_response:1; }","duration":"1.009752964s","start":"2026-07-30T21:21:59.154138Z","end":"2026-07-30T21:22:00.163891Z","steps":["trace[1564964261] 'process raft request'  (duration: 1.009567251s)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:22:00.164541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:21:59.154112Z","time spent":"1.010315186s","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9379 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-30T21:22:00.164753Z","caller":"traceutil/trace.go:171","msg":"trace[632488533] linearizableReadLoop","detail":"{readStateIndex:9687; appliedIndex:9685; }","duration":"937.524215ms","start":"2026-07-30T21:21:59.2272Z","end":"2026-07-30T21:22:00.164724Z","steps":["trace[632488533] 'read index received'  (duration: 936.229809ms)","trace[632488533] 'applied index is now lower than readState.Index'  (duration: 1.293126ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:22:00.164852Z","caller":"traceutil/trace.go:171","msg":"trace[403320873] transaction","detail":"{read_only:false; response_revision:9391; number_of_response:1; }","duration":"1.008677382s","start":"2026-07-30T21:21:59.156163Z","end":"2026-07-30T21:22:00.16484Z","steps":["trace[403320873] 'process raft request'  (duration: 1.008421727s)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:22:00.165029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:21:59.156135Z","time spent":"1.008780255s","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9380 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-30T21:22:00.165255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.238668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-30T21:22:00.165225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.452179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"warn","ts":"2026-07-30T21:22:00.16529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.067096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-07-30T21:22:00.165401Z","caller":"traceutil/trace.go:171","msg":"trace[649323391] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:9391; }","duration":"938.24459ms","start":"2026-07-30T21:21:59.227139Z","end":"2026-07-30T21:22:00.165384Z","steps":["trace[649323391] 'agreement among raft nodes before linearized reading'  (duration: 938.020445ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:22:00.165404Z","caller":"traceutil/trace.go:171","msg":"trace[1325978517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9391; }","duration":"257.331802ms","start":"2026-07-30T21:21:59.907974Z","end":"2026-07-30T21:22:00.165305Z","steps":["trace[1325978517] 'agreement among raft nodes before linearized reading'  (duration: 257.228239ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:22:00.1654Z","caller":"traceutil/trace.go:171","msg":"trace[438792042] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:9391; }","duration":"331.680625ms","start":"2026-07-30T21:21:59.833688Z","end":"2026-07-30T21:22:00.165369Z","steps":["trace[438792042] 'agreement among raft nodes before linearized reading'  (duration: 331.288086ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:22:00.165438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:21:59.227116Z","time spent":"938.314461ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-07-30T21:22:00.165493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:21:59.83367Z","time spent":"331.809737ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-07-30T21:22:00.165708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.872535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-07-30T21:22:00.165806Z","caller":"traceutil/trace.go:171","msg":"trace[1965035048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9391; }","duration":"242.012459ms","start":"2026-07-30T21:21:59.923776Z","end":"2026-07-30T21:22:00.165789Z","steps":["trace[1965035048] 'agreement among raft nodes before linearized reading'  (duration: 241.462506ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:22:37.242141Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7309}
{"level":"info","ts":"2026-07-30T21:22:37.249295Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e7941a908d261618","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-30T21:22:37.25369Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-30T21:22:37.253758Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-30T21:22:37.299934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7309,"took":"56.71018ms","hash":2410762944,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":13082624,"current-db-size-in-use":"13 MB"}
{"level":"info","ts":"2026-07-30T21:22:37.300008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2410762944,"revision":7309,"compact-revision":4975}
{"level":"info","ts":"2026-07-30T21:26:26.615968Z","caller":"traceutil/trace.go:171","msg":"trace[784393867] linearizableReadLoop","detail":"{readStateIndex:11839; appliedIndex:11838; }","duration":"196.656751ms","start":"2026-07-30T21:26:26.419287Z","end":"2026-07-30T21:26:26.615944Z","steps":["trace[784393867] 'read index received'  (duration: 196.459197ms)","trace[784393867] 'applied index is now lower than readState.Index'  (duration: 196.784µs)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:26:26.616116Z","caller":"traceutil/trace.go:171","msg":"trace[2136849110] transaction","detail":"{read_only:false; response_revision:11477; number_of_response:1; }","duration":"228.178996ms","start":"2026-07-30T21:26:26.387882Z","end":"2026-07-30T21:26:26.616061Z","steps":["trace[2136849110] 'process raft request'  (duration: 227.919291ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:26:26.616213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.911176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12463"}
{"level":"info","ts":"2026-07-30T21:26:26.616256Z","caller":"traceutil/trace.go:171","msg":"trace[636438446] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11477; }","duration":"197.030438ms","start":"2026-07-30T21:26:26.419215Z","end":"2026-07-30T21:26:26.616245Z","steps":["trace[636438446] 'agreement among raft nodes before linearized reading'  (duration: 196.833204ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:27:37.249215Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9694}
{"level":"info","ts":"2026-07-30T21:27:37.307023Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9694,"took":"56.2857ms","hash":1062480123,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":16875520,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-07-30T21:27:37.307116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1062480123,"revision":9694,"compact-revision":7309}
{"level":"info","ts":"2026-07-30T21:28:00.996288Z","caller":"traceutil/trace.go:171","msg":"trace[161620470] transaction","detail":"{read_only:false; response_revision:12630; number_of_response:1; }","duration":"100.418341ms","start":"2026-07-30T21:28:00.895842Z","end":"2026-07-30T21:28:00.99626Z","steps":["trace[161620470] 'process raft request'  (duration: 100.160585ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:28:01.233339Z","caller":"traceutil/trace.go:171","msg":"trace[131510326] transaction","detail":"{read_only:false; response_revision:12632; number_of_response:1; }","duration":"181.272422ms","start":"2026-07-30T21:28:01.052006Z","end":"2026-07-30T21:28:01.233279Z","steps":["trace[131510326] 'process raft request'  (duration: 108.353613ms)","trace[131510326] 'compare'  (duration: 72.611043ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T21:28:02.497334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.742996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-07-30T21:28:02.497442Z","caller":"traceutil/trace.go:171","msg":"trace[1921259964] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:12641; }","duration":"214.895139ms","start":"2026-07-30T21:28:02.282517Z","end":"2026-07-30T21:28:02.497412Z","steps":["trace[1921259964] 'range keys from in-memory index tree'  (duration: 214.571212ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:32:18.551052Z","caller":"traceutil/trace.go:171","msg":"trace[489152069] transaction","detail":"{read_only:false; response_revision:14368; number_of_response:1; }","duration":"114.094352ms","start":"2026-07-30T21:32:18.436926Z","end":"2026-07-30T21:32:18.55102Z","steps":["trace[489152069] 'process raft request'  (duration: 113.861017ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:32:18.575949Z","caller":"traceutil/trace.go:171","msg":"trace[1064160666] transaction","detail":"{read_only:false; response_revision:14369; number_of_response:1; }","duration":"138.767565ms","start":"2026-07-30T21:32:18.437155Z","end":"2026-07-30T21:32:18.575922Z","steps":["trace[1064160666] 'process raft request'  (duration: 138.596151ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:32:18.576199Z","caller":"traceutil/trace.go:171","msg":"trace[363586850] transaction","detail":"{read_only:false; response_revision:14370; number_of_response:1; }","duration":"138.942318ms","start":"2026-07-30T21:32:18.437195Z","end":"2026-07-30T21:32:18.576137Z","steps":["trace[363586850] 'process raft request'  (duration: 138.687563ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:32:37.255071Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12474}
{"level":"info","ts":"2026-07-30T21:32:37.334487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12474,"took":"77.539588ms","hash":4072531648,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":13651968,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-07-30T21:32:37.334553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4072531648,"revision":12474,"compact-revision":9694}
{"level":"info","ts":"2026-07-30T21:37:37.26172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14520}
{"level":"info","ts":"2026-07-30T21:37:37.316597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14520,"took":"53.132411ms","hash":3720472527,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":17252352,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-07-30T21:37:37.316668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3720472527,"revision":14520,"compact-revision":12474}
{"level":"info","ts":"2026-07-30T21:40:37.689451Z","caller":"traceutil/trace.go:171","msg":"trace[1453662087] linearizableReadLoop","detail":"{readStateIndex:18796; appliedIndex:18795; }","duration":"202.514354ms","start":"2026-07-30T21:40:37.486914Z","end":"2026-07-30T21:40:37.689428Z","steps":["trace[1453662087] 'read index received'  (duration: 202.342051ms)","trace[1453662087] 'applied index is now lower than readState.Index'  (duration: 170.163µs)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:40:37.689726Z","caller":"traceutil/trace.go:171","msg":"trace[1060704504] transaction","detail":"{read_only:false; response_revision:18232; number_of_response:1; }","duration":"204.697528ms","start":"2026-07-30T21:40:37.485016Z","end":"2026-07-30T21:40:37.689714Z","steps":["trace[1060704504] 'process raft request'  (duration: 204.29615ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:37.689918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.987923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-30T21:40:37.689955Z","caller":"traceutil/trace.go:171","msg":"trace[1942655988] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:18232; }","duration":"203.053705ms","start":"2026-07-30T21:40:37.48689Z","end":"2026-07-30T21:40:37.689944Z","steps":["trace[1942655988] 'agreement among raft nodes before linearized reading'  (duration: 202.980184ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:37.69018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.465712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-30T21:40:37.690208Z","caller":"traceutil/trace.go:171","msg":"trace[860049925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18232; }","duration":"167.529473ms","start":"2026-07-30T21:40:37.52267Z","end":"2026-07-30T21:40:37.6902Z","steps":["trace[860049925] 'agreement among raft nodes before linearized reading'  (duration: 167.435931ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:37.690901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.405178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-07-30T21:40:37.690971Z","caller":"traceutil/trace.go:171","msg":"trace[832269672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18232; }","duration":"125.506369ms","start":"2026-07-30T21:40:37.565447Z","end":"2026-07-30T21:40:37.690953Z","steps":["trace[832269672] 'agreement among raft nodes before linearized reading'  (duration: 125.368337ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:40:37.980916Z","caller":"traceutil/trace.go:171","msg":"trace[969581682] transaction","detail":"{read_only:false; response_revision:18233; number_of_response:1; }","duration":"285.619202ms","start":"2026-07-30T21:40:37.695281Z","end":"2026-07-30T21:40:37.9809Z","steps":["trace[969581682] 'process raft request'  (duration: 285.52038ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:40:38.025325Z","caller":"traceutil/trace.go:171","msg":"trace[1081679536] linearizableReadLoop","detail":"{readStateIndex:18799; appliedIndex:18797; }","duration":"322.550361ms","start":"2026-07-30T21:40:37.702748Z","end":"2026-07-30T21:40:38.025299Z","steps":["trace[1081679536] 'read index received'  (duration: 278.226612ms)","trace[1081679536] 'applied index is now lower than readState.Index'  (duration: 44.322699ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T21:40:38.025668Z","caller":"traceutil/trace.go:171","msg":"trace[803171243] transaction","detail":"{read_only:false; response_revision:18234; number_of_response:1; }","duration":"329.897541ms","start":"2026-07-30T21:40:37.695754Z","end":"2026-07-30T21:40:38.025651Z","steps":["trace[803171243] 'process raft request'  (duration: 329.273378ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.025798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:40:37.695723Z","time spent":"329.991253ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:18203 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-07-30T21:40:38.025946Z","caller":"traceutil/trace.go:171","msg":"trace[1496895850] transaction","detail":"{read_only:false; response_revision:18235; number_of_response:1; }","duration":"329.537014ms","start":"2026-07-30T21:40:37.696394Z","end":"2026-07-30T21:40:38.025931Z","steps":["trace[1496895850] 'process raft request'  (duration: 328.770667ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.026027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:40:37.696383Z","time spent":"329.603896ms","remote":"127.0.0.1:38600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:18220 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-30T21:40:38.026219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.68676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-30T21:40:38.026323Z","caller":"traceutil/trace.go:171","msg":"trace[180344543] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:18236; }","duration":"276.799712ms","start":"2026-07-30T21:40:37.749474Z","end":"2026-07-30T21:40:38.026274Z","steps":["trace[180344543] 'agreement among raft nodes before linearized reading'  (duration: 276.69286ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.02672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.014097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-30T21:40:38.026745Z","caller":"traceutil/trace.go:171","msg":"trace[1706953055] transaction","detail":"{read_only:false; response_revision:18236; number_of_response:1; }","duration":"309.16753ms","start":"2026-07-30T21:40:37.717561Z","end":"2026-07-30T21:40:38.026729Z","steps":["trace[1706953055] 'process raft request'  (duration: 307.660329ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T21:40:38.026779Z","caller":"traceutil/trace.go:171","msg":"trace[1750875209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18236; }","duration":"117.106099ms","start":"2026-07-30T21:40:37.909658Z","end":"2026-07-30T21:40:38.026764Z","steps":["trace[1750875209] 'agreement among raft nodes before linearized reading'  (duration: 117.024998ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.02683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:40:37.717522Z","time spent":"309.263832ms","remote":"127.0.0.1:38502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20785,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-nzc8r\" mod_revision:18171 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-nzc8r\" value_size:20721 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-nzc8r\" > >"}
{"level":"warn","ts":"2026-07-30T21:40:38.027079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.347825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-30T21:40:38.027125Z","caller":"traceutil/trace.go:171","msg":"trace[1210588184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18236; }","duration":"218.426766ms","start":"2026-07-30T21:40:37.808685Z","end":"2026-07-30T21:40:38.027112Z","steps":["trace[1210588184] 'agreement among raft nodes before linearized reading'  (duration: 218.285283ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.027717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.964801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:63 size:638233"}
{"level":"info","ts":"2026-07-30T21:40:38.027769Z","caller":"traceutil/trace.go:171","msg":"trace[153731121] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:63; response_revision:18236; }","duration":"325.044002ms","start":"2026-07-30T21:40:37.702711Z","end":"2026-07-30T21:40:38.027755Z","steps":["trace[153731121] 'agreement among raft nodes before linearized reading'  (duration: 324.269817ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T21:40:38.027813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:40:37.702701Z","time spent":"325.097263ms","remote":"127.0.0.1:38502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":63,"response size":638256,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-07-30T21:42:37.268346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16858}
{"level":"info","ts":"2026-07-30T21:42:37.341436Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16858,"took":"71.096345ms","hash":2344727672,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":16474112,"current-db-size-in-use":"16 MB"}
{"level":"info","ts":"2026-07-30T21:42:37.341511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2344727672,"revision":16858,"compact-revision":14520}
{"level":"info","ts":"2026-07-30T21:43:19.126093Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e7941a908d261618","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-30T21:43:19.13045Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-30T21:43:19.130602Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-30T21:47:37.274746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19110}
{"level":"info","ts":"2026-07-30T21:47:37.350235Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19110,"took":"73.126925ms","hash":3149780334,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":14254080,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-07-30T21:47:37.350316Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3149780334,"revision":19110,"compact-revision":16858}
{"level":"info","ts":"2026-07-30T21:52:37.285886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21049}
{"level":"info","ts":"2026-07-30T21:52:37.358923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21049,"took":"70.781126ms","hash":4082964796,"current-db-size-bytes":35102720,"current-db-size":"35 MB","current-db-size-in-use-bytes":14131200,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-07-30T21:52:37.359002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4082964796,"revision":21049,"compact-revision":19110}