{"level":"warn","ts":"2026-09-03T05:19:19.106121Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-03T05:19:19.106243Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.111: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://162.253.55.111:2380","--initial-cluster=instance=https://162.253.55.111:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.111:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.111: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-09-03T05:19:19.106319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-03T05:19:19.106329Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.111:2380"]}
{"level":"info","ts":"2026-09-03T05:19:19.106361Z","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-09-03T05:19:19.107186Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"]}
{"level":"info","ts":"2026-09-03T05:19:19.107295Z","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://162.253.55.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.111: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-09-03T05:19:19.110961Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.402527ms"}
{"level":"info","ts":"2026-09-03T05:19:19.124555Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"299bf3744060cbd","cluster-id":"83d94f04ddaf7996"}
{"level":"info","ts":"2026-09-03T05:19:19.124661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=()"}
{"level":"info","ts":"2026-09-03T05:19:19.124691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 0"}
{"level":"info","ts":"2026-09-03T05:19:19.124713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 299bf3744060cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-03T05:19:19.124726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 1"}
{"level":"info","ts":"2026-09-03T05:19:19.124773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"}
{"level":"warn","ts":"2026-09-03T05:19:19.130593Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-03T05:19:19.132315Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-03T05:19:19.133907Z","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-09-03T05:19:19.13632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"299bf3744060cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-03T05:19:19.136529Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"299bf3744060cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-03T05:19:19.136669Z","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-09-03T05:19:19.136779Z","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-09-03T05:19:19.136797Z","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-09-03T05:19:19.138449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"}
{"level":"info","ts":"2026-09-03T05:19:19.139486Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","added-peer-id":"299bf3744060cbd","added-peer-peer-urls":["https://162.253.55.111:2380"]}
{"level":"info","ts":"2026-09-03T05:19:19.142518Z","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-09-03T05:19:19.142936Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"299bf3744060cbd","initial-advertise-peer-urls":["https://162.253.55.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-03T05:19:19.142986Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-03T05:19:19.143124Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.111:2380"}
{"level":"info","ts":"2026-09-03T05:19:19.143152Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.111:2380"}
{"level":"info","ts":"2026-09-03T05:19:20.125866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd is starting a new election at term 1"}
{"level":"info","ts":"2026-09-03T05:19:20.125966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-03T05:19:20.126001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgPreVoteResp from 299bf3744060cbd at term 1"}
{"level":"info","ts":"2026-09-03T05:19:20.12602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became candidate at term 2"}
{"level":"info","ts":"2026-09-03T05:19:20.12603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgVoteResp from 299bf3744060cbd at term 2"}
{"level":"info","ts":"2026-09-03T05:19:20.126045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became leader at term 2"}
{"level":"info","ts":"2026-09-03T05:19:20.126058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 299bf3744060cbd elected leader 299bf3744060cbd at term 2"}
{"level":"info","ts":"2026-09-03T05:19:20.12728Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-03T05:19:20.128779Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"299bf3744060cbd","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.111:2379]}","request-path":"/0/members/299bf3744060cbd/attributes","cluster-id":"83d94f04ddaf7996","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-03T05:19:20.128873Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-03T05:19:20.128824Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-03T05:19:20.129133Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-03T05:19:20.129174Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-03T05:19:20.129673Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-03T05:19:20.129967Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-03T05:19:20.130033Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-03T05:19:20.132925Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-03T05:19:20.133132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.111:2379"}
{"level":"info","ts":"2026-09-03T05:19:32.335705Z","caller":"traceutil/trace.go:171","msg":"trace[177265593] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"111.213343ms","start":"2026-09-03T05:19:32.22446Z","end":"2026-09-03T05:19:32.335674Z","steps":["trace[177265593] 'process raft request'  (duration: 111.006779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:20:12.208465Z","caller":"traceutil/trace.go:171","msg":"trace[1745636342] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"217.430801ms","start":"2026-09-03T05:20:11.991Z","end":"2026-09-03T05:20:12.208431Z","steps":["trace[1745636342] 'process raft request'  (duration: 217.151735ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:20:12.312896Z","caller":"traceutil/trace.go:171","msg":"trace[672277644] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"242.612419ms","start":"2026-09-03T05:20:12.070254Z","end":"2026-09-03T05:20:12.312867Z","steps":["trace[672277644] 'read index received'  (duration: 137.956039ms)","trace[672277644] 'applied index is now lower than readState.Index'  (duration: 104.65494ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:20:12.313013Z","caller":"traceutil/trace.go:171","msg":"trace[243955362] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"299.778746ms","start":"2026-09-03T05:20:12.013194Z","end":"2026-09-03T05:20:12.312973Z","steps":["trace[243955362] 'process raft request'  (duration: 298.913557ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:20:12.313124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.836294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-03T05:20:12.31321Z","caller":"traceutil/trace.go:171","msg":"trace[1225496987] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"242.986057ms","start":"2026-09-03T05:20:12.07021Z","end":"2026-09-03T05:20:12.313196Z","steps":["trace[1225496987] 'agreement among raft nodes before linearized reading'  (duration: 242.761922ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:20:12.618667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.992683ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743075624 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:593 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:20:12.619124Z","caller":"traceutil/trace.go:171","msg":"trace[1674270995] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"301.064974ms","start":"2026-09-03T05:20:12.317954Z","end":"2026-09-03T05:20:12.619019Z","steps":["trace[1674270995] 'process raft request'  (duration: 155.446535ms)","trace[1674270995] 'compare'  (duration: 143.721578ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:20:12.619239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:20:12.317925Z","time spent":"301.263979ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:593 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-03T05:20:12.619269Z","caller":"traceutil/trace.go:171","msg":"trace[1567276423] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"235.47807ms","start":"2026-09-03T05:20:12.383736Z","end":"2026-09-03T05:20:12.619214Z","steps":["trace[1567276423] 'process raft request'  (duration: 235.191924ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:20:13.195225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.385181ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743075630 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-4hlzs\" mod_revision:492 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-4hlzs\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-4hlzs\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:20:13.195358Z","caller":"traceutil/trace.go:171","msg":"trace[1408663955] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"530.585343ms","start":"2026-09-03T05:20:12.664749Z","end":"2026-09-03T05:20:13.195334Z","steps":["trace[1408663955] 'process raft request'  (duration: 376.989618ms)","trace[1408663955] 'compare'  (duration: 153.214436ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:20:13.195431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:20:12.664716Z","time spent":"530.674635ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-4hlzs\" mod_revision:492 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-4hlzs\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-4hlzs\" > >"}
{"level":"info","ts":"2026-09-03T05:20:13.295354Z","caller":"traceutil/trace.go:171","msg":"trace[1846810900] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"266.262793ms","start":"2026-09-03T05:20:13.029061Z","end":"2026-09-03T05:20:13.295323Z","steps":["trace[1846810900] 'process raft request'  (duration: 265.663179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:00.072339Z","caller":"traceutil/trace.go:171","msg":"trace[213821141] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"148.449088ms","start":"2026-09-03T05:20:59.923861Z","end":"2026-09-03T05:21:00.07231Z","steps":["trace[213821141] 'process raft request'  (duration: 148.294864ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:17.121763Z","caller":"traceutil/trace.go:171","msg":"trace[1545879146] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"111.905662ms","start":"2026-09-03T05:21:17.009827Z","end":"2026-09-03T05:21:17.121733Z","steps":["trace[1545879146] 'process raft request'  (duration: 111.714217ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:25.280321Z","caller":"traceutil/trace.go:171","msg":"trace[855489692] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"114.08264ms","start":"2026-09-03T05:21:25.166206Z","end":"2026-09-03T05:21:25.280288Z","steps":["trace[855489692] 'process raft request'  (duration: 113.918807ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:50.536303Z","caller":"traceutil/trace.go:171","msg":"trace[1616092858] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"100.18291ms","start":"2026-09-03T05:21:50.436091Z","end":"2026-09-03T05:21:50.536274Z","steps":["trace[1616092858] 'read index received'  (duration: 99.935455ms)","trace[1616092858] 'applied index is now lower than readState.Index'  (duration: 246.615µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:21:50.536544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.442897ms","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-09-03T05:21:50.536592Z","caller":"traceutil/trace.go:171","msg":"trace[800086353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1867; }","duration":"100.552919ms","start":"2026-09-03T05:21:50.436025Z","end":"2026-09-03T05:21:50.536578Z","steps":["trace[800086353] 'agreement among raft nodes before linearized reading'  (duration: 100.405336ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:50.536442Z","caller":"traceutil/trace.go:171","msg":"trace[1936156992] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"265.250225ms","start":"2026-09-03T05:21:50.271161Z","end":"2026-09-03T05:21:50.536412Z","steps":["trace[1936156992] 'process raft request'  (duration: 264.959529ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:21:50.92582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.872846ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743078134 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1844 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:21:50.926104Z","caller":"traceutil/trace.go:171","msg":"trace[1176782378] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"384.000624ms","start":"2026-09-03T05:21:50.542063Z","end":"2026-09-03T05:21:50.926064Z","steps":["trace[1176782378] 'process raft request'  (duration: 48.799821ms)","trace[1176782378] 'compare'  (duration: 334.61598ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:21:50.926145Z","caller":"traceutil/trace.go:171","msg":"trace[454461843] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"371.123384ms","start":"2026-09-03T05:21:50.554996Z","end":"2026-09-03T05:21:50.926119Z","steps":["trace[454461843] 'process raft request'  (duration: 370.994991ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:21:50.926252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:21:50.554967Z","time spent":"371.238497ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1821 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"warn","ts":"2026-09-03T05:21:50.926287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:21:50.542041Z","time spent":"384.153558ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1844 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-03T05:21:50.946795Z","caller":"traceutil/trace.go:171","msg":"trace[1213057211] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"212.004493ms","start":"2026-09-03T05:21:50.734774Z","end":"2026-09-03T05:21:50.946778Z","steps":["trace[1213057211] 'process raft request'  (duration: 211.908421ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:21:50.946947Z","caller":"traceutil/trace.go:171","msg":"trace[454387895] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1943; }","duration":"184.155705ms","start":"2026-09-03T05:21:50.762678Z","end":"2026-09-03T05:21:50.946834Z","steps":["trace[454387895] 'read index received'  (duration: 184.140065ms)","trace[454387895] 'applied index is now lower than readState.Index'  (duration: 12.2µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:21:50.947183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.498522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-03T05:21:50.947254Z","caller":"traceutil/trace.go:171","msg":"trace[318477503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1870; }","duration":"184.715518ms","start":"2026-09-03T05:21:50.762522Z","end":"2026-09-03T05:21:50.947238Z","steps":["trace[318477503] 'agreement among raft nodes before linearized reading'  (duration: 184.477863ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:04.170629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.544276ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743078373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1973 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:22:04.170913Z","caller":"traceutil/trace.go:171","msg":"trace[1074503596] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"492.160125ms","start":"2026-09-03T05:22:03.678716Z","end":"2026-09-03T05:22:04.170876Z","steps":["trace[1074503596] 'process raft request'  (duration: 189.176689ms)","trace[1074503596] 'compare'  (duration: 302.374942ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:22:04.170969Z","caller":"traceutil/trace.go:171","msg":"trace[1329455594] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"440.390636ms","start":"2026-09-03T05:22:03.73053Z","end":"2026-09-03T05:22:04.17092Z","steps":["trace[1329455594] 'process raft request'  (duration: 440.256833ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:04.171154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:22:03.678696Z","time spent":"492.315798ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1973 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-03T05:22:04.171404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:22:03.730492Z","time spent":"440.616021ms","remote":"127.0.0.1:36724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.111\" mod_revision:1900 > success:<request_put:<key:\"/registry/masterleases/162.253.55.111\" value_size:67 lease:918066257743078371 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.111\" > >"}
{"level":"info","ts":"2026-09-03T05:22:04.299875Z","caller":"traceutil/trace.go:171","msg":"trace[1421574958] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"119.283162ms","start":"2026-09-03T05:22:04.18056Z","end":"2026-09-03T05:22:04.299843Z","steps":["trace[1421574958] 'process raft request'  (duration: 110.909173ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:22:04.432408Z","caller":"traceutil/trace.go:171","msg":"trace[121272112] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"121.199204ms","start":"2026-09-03T05:22:04.311164Z","end":"2026-09-03T05:22:04.432363Z","steps":["trace[121272112] 'process raft request'  (duration: 120.943069ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:22:07.418911Z","caller":"traceutil/trace.go:171","msg":"trace[1616908198] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"216.283869ms","start":"2026-09-03T05:22:07.2026Z","end":"2026-09-03T05:22:07.418884Z","steps":["trace[1616908198] 'process raft request'  (duration: 216.129486ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:22:07.42086Z","caller":"traceutil/trace.go:171","msg":"trace[1358916481] linearizableReadLoop","detail":"{readStateIndex:2087; appliedIndex:2086; }","duration":"161.956224ms","start":"2026-09-03T05:22:07.258871Z","end":"2026-09-03T05:22:07.420827Z","steps":["trace[1358916481] 'read index received'  (duration: 160.00656ms)","trace[1358916481] 'applied index is now lower than readState.Index'  (duration: 1.948424ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:22:07.420962Z","caller":"traceutil/trace.go:171","msg":"trace[65471653] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"217.660161ms","start":"2026-09-03T05:22:07.203273Z","end":"2026-09-03T05:22:07.420933Z","steps":["trace[65471653] 'process raft request'  (duration: 217.370474ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:07.421131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.23897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-03T05:22:07.421181Z","caller":"traceutil/trace.go:171","msg":"trace[668331335] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2011; }","duration":"162.351393ms","start":"2026-09-03T05:22:07.258818Z","end":"2026-09-03T05:22:07.42117Z","steps":["trace[668331335] 'agreement among raft nodes before linearized reading'  (duration: 162.133008ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:46.781894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.619291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:22:46.782008Z","caller":"traceutil/trace.go:171","msg":"trace[235232630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2225; }","duration":"143.881417ms","start":"2026-09-03T05:22:46.638101Z","end":"2026-09-03T05:22:46.781982Z","steps":["trace[235232630] 'range keys from in-memory index tree'  (duration: 143.513759ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:46.782284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.026023ms","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-09-03T05:22:46.782432Z","caller":"traceutil/trace.go:171","msg":"trace[264849963] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2225; }","duration":"301.231487ms","start":"2026-09-03T05:22:46.481162Z","end":"2026-09-03T05:22:46.782393Z","steps":["trace[264849963] 'range keys from in-memory index tree'  (duration: 300.186233ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:22:46.782497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:22:46.481129Z","time spent":"301.35187ms","remote":"127.0.0.1:59600","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":"info","ts":"2026-09-03T05:22:46.933708Z","caller":"traceutil/trace.go:171","msg":"trace[1895356163] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"104.957848ms","start":"2026-09-03T05:22:46.828698Z","end":"2026-09-03T05:22:46.933656Z","steps":["trace[1895356163] 'process raft request'  (duration: 104.738113ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:23:20.796156Z","caller":"traceutil/trace.go:171","msg":"trace[1908304407] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"296.73735ms","start":"2026-09-03T05:23:20.499388Z","end":"2026-09-03T05:23:20.796126Z","steps":["trace[1908304407] 'process raft request'  (duration: 296.550465ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:23:20.837124Z","caller":"traceutil/trace.go:171","msg":"trace[1017509672] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"206.701431ms","start":"2026-09-03T05:23:20.6304Z","end":"2026-09-03T05:23:20.837102Z","steps":["trace[1017509672] 'process raft request'  (duration: 192.052791ms)","trace[1017509672] 'compare'  (duration: 14.335883ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:23:20.837315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.590008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-03T05:23:20.837395Z","caller":"traceutil/trace.go:171","msg":"trace[2116213925] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2587; }","duration":"206.694331ms","start":"2026-09-03T05:23:20.630684Z","end":"2026-09-03T05:23:20.837378Z","steps":["trace[2116213925] 'agreement among raft nodes before linearized reading'  (duration: 206.537647ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:23:20.837007Z","caller":"traceutil/trace.go:171","msg":"trace[907460066] linearizableReadLoop","detail":"{readStateIndex:2687; appliedIndex:2685; }","duration":"206.275292ms","start":"2026-09-03T05:23:20.630713Z","end":"2026-09-03T05:23:20.836988Z","steps":["trace[907460066] 'read index received'  (duration: 165.242466ms)","trace[907460066] 'applied index is now lower than readState.Index'  (duration: 41.030456ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:23:20.83815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.04638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:23:20.838254Z","caller":"traceutil/trace.go:171","msg":"trace[2041787921] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2587; }","duration":"114.202425ms","start":"2026-09-03T05:23:20.724018Z","end":"2026-09-03T05:23:20.83822Z","steps":["trace[2041787921] 'agreement among raft nodes before linearized reading'  (duration: 113.935318ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:23:54.099203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.679159ms","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-09-03T05:23:54.099352Z","caller":"traceutil/trace.go:171","msg":"trace[1440374784] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2790; }","duration":"107.875933ms","start":"2026-09-03T05:23:53.991453Z","end":"2026-09-03T05:23:54.099329Z","steps":["trace[1440374784] 'range keys from in-memory index tree'  (duration: 107.473054ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:23:54.099329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.733755ms","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-09-03T05:23:54.099439Z","caller":"traceutil/trace.go:171","msg":"trace[139252532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2790; }","duration":"113.889338ms","start":"2026-09-03T05:23:53.98552Z","end":"2026-09-03T05:23:54.099409Z","steps":["trace[139252532] 'range keys from in-memory index tree'  (duration: 113.579631ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:23:54.099329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.741104ms","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-09-03T05:23:54.099597Z","caller":"traceutil/trace.go:171","msg":"trace[1243168039] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2790; }","duration":"106.072542ms","start":"2026-09-03T05:23:53.993516Z","end":"2026-09-03T05:23:54.099588Z","steps":["trace[1243168039] 'range keys from in-memory index tree'  (duration: 105.55473ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:26:37.214468Z","caller":"traceutil/trace.go:171","msg":"trace[472393866] transaction","detail":"{read_only:false; response_revision:3769; number_of_response:1; }","duration":"119.090697ms","start":"2026-09-03T05:26:37.095344Z","end":"2026-09-03T05:26:37.214434Z","steps":["trace[472393866] 'process raft request'  (duration: 118.559414ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:27:11.580732Z","caller":"traceutil/trace.go:171","msg":"trace[1469528612] transaction","detail":"{read_only:false; response_revision:4031; number_of_response:1; }","duration":"308.707023ms","start":"2026-09-03T05:27:11.271989Z","end":"2026-09-03T05:27:11.580696Z","steps":["trace[1469528612] 'process raft request'  (duration: 308.491918ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:27:11.580967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:27:11.271956Z","time spent":"308.907698ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4022 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-03T05:27:11.580965Z","caller":"traceutil/trace.go:171","msg":"trace[210364107] linearizableReadLoop","detail":"{readStateIndex:4186; appliedIndex:4184; }","duration":"172.883799ms","start":"2026-09-03T05:27:11.408031Z","end":"2026-09-03T05:27:11.580914Z","steps":["trace[210364107] 'read index received'  (duration: 172.434689ms)","trace[210364107] 'applied index is now lower than readState.Index'  (duration: 447.37µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:27:11.581027Z","caller":"traceutil/trace.go:171","msg":"trace[1115812722] transaction","detail":"{read_only:false; response_revision:4032; number_of_response:1; }","duration":"308.962649ms","start":"2026-09-03T05:27:11.272036Z","end":"2026-09-03T05:27:11.580999Z","steps":["trace[1115812722] 'process raft request'  (duration: 308.619701ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:27:11.581213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:27:11.272003Z","time spent":"309.078222ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4021 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-09-03T05:27:11.581236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.195406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:27:11.581288Z","caller":"traceutil/trace.go:171","msg":"trace[620612769] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:4032; }","duration":"173.283058ms","start":"2026-09-03T05:27:11.407987Z","end":"2026-09-03T05:27:11.58127Z","steps":["trace[620612769] 'agreement among raft nodes before linearized reading'  (duration: 173.079853ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:27:11.657644Z","caller":"traceutil/trace.go:171","msg":"trace[890102861] transaction","detail":"{read_only:false; response_revision:4033; number_of_response:1; }","duration":"152.103201ms","start":"2026-09-03T05:27:11.50549Z","end":"2026-09-03T05:27:11.657594Z","steps":["trace[890102861] 'process raft request'  (duration: 127.870665ms)","trace[890102861] 'compare'  (duration: 23.911029ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:28:43.711976Z","caller":"traceutil/trace.go:171","msg":"trace[518869921] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"214.904258ms","start":"2026-09-03T05:28:43.497049Z","end":"2026-09-03T05:28:43.711954Z","steps":["trace[518869921] 'process raft request'  (duration: 214.675783ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:28:43.781269Z","caller":"traceutil/trace.go:171","msg":"trace[508064919] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5415; }","duration":"181.674948ms","start":"2026-09-03T05:28:43.599567Z","end":"2026-09-03T05:28:43.781242Z","steps":["trace[508064919] 'read index received'  (duration: 112.249042ms)","trace[508064919] 'applied index is now lower than readState.Index'  (duration: 69.424756ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:28:43.78137Z","caller":"traceutil/trace.go:171","msg":"trace[568337873] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"237.776634ms","start":"2026-09-03T05:28:43.543564Z","end":"2026-09-03T05:28:43.781341Z","steps":["trace[568337873] 'process raft request'  (duration: 237.551669ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:28:43.781538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.948195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.111\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-09-03T05:28:43.781587Z","caller":"traceutil/trace.go:171","msg":"trace[752964870] range","detail":"{range_begin:/registry/masterleases/162.253.55.111; range_end:; response_count:1; response_revision:5220; }","duration":"182.053077ms","start":"2026-09-03T05:28:43.599522Z","end":"2026-09-03T05:28:43.781576Z","steps":["trace[752964870] 'agreement among raft nodes before linearized reading'  (duration: 181.855062ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:28:43.826514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.317238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:28:43.826594Z","caller":"traceutil/trace.go:171","msg":"trace[1848138251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5221; }","duration":"188.41984ms","start":"2026-09-03T05:28:43.638158Z","end":"2026-09-03T05:28:43.826578Z","steps":["trace[1848138251] 'agreement among raft nodes before linearized reading'  (duration: 188.259096ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:28:43.827036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.09818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728959"}
{"level":"info","ts":"2026-09-03T05:28:43.827139Z","caller":"traceutil/trace.go:171","msg":"trace[633007805] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5221; }","duration":"144.267194ms","start":"2026-09-03T05:28:43.682855Z","end":"2026-09-03T05:28:43.827122Z","steps":["trace[633007805] 'agreement among raft nodes before linearized reading'  (duration: 143.598119ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:28:59.310561Z","caller":"traceutil/trace.go:171","msg":"trace[250978083] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"248.28955ms","start":"2026-09-03T05:28:59.06225Z","end":"2026-09-03T05:28:59.31054Z","steps":["trace[250978083] 'process raft request'  (duration: 153.262507ms)","trace[250978083] 'compare'  (duration: 94.672536ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:28:59.326115Z","caller":"traceutil/trace.go:171","msg":"trace[993571822] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"251.558916ms","start":"2026-09-03T05:28:59.074533Z","end":"2026-09-03T05:28:59.326092Z","steps":["trace[993571822] 'process raft request'  (duration: 251.404332ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:28:59.32643Z","caller":"traceutil/trace.go:171","msg":"trace[199346962] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"202.806755ms","start":"2026-09-03T05:28:59.123599Z","end":"2026-09-03T05:28:59.326406Z","steps":["trace[199346962] 'process raft request'  (duration: 202.723853ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:28:59.326475Z","caller":"traceutil/trace.go:171","msg":"trace[472668669] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"206.421577ms","start":"2026-09-03T05:28:59.119966Z","end":"2026-09-03T05:28:59.326388Z","steps":["trace[472668669] 'process raft request'  (duration: 206.0906ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:29:08.43503Z","caller":"traceutil/trace.go:171","msg":"trace[1314572435] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"240.587607ms","start":"2026-09-03T05:29:08.1944Z","end":"2026-09-03T05:29:08.434987Z","steps":["trace[1314572435] 'process raft request'  (duration: 240.423863ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:29:08.435256Z","caller":"traceutil/trace.go:171","msg":"trace[1748999950] linearizableReadLoop","detail":"{readStateIndex:5897; appliedIndex:5897; }","duration":"187.296745ms","start":"2026-09-03T05:29:08.247944Z","end":"2026-09-03T05:29:08.435241Z","steps":["trace[1748999950] 'read index received'  (duration: 187.290845ms)","trace[1748999950] 'applied index is now lower than readState.Index'  (duration: 4.35µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:29:08.435538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.592128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-09-03T05:29:08.435532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.130131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cea975fa-d520-4ab3-8d0f-54c049519594\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-09-03T05:29:08.435571Z","caller":"traceutil/trace.go:171","msg":"trace[193026812] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:5687; }","duration":"158.651329ms","start":"2026-09-03T05:29:08.27691Z","end":"2026-09-03T05:29:08.435562Z","steps":["trace[193026812] 'agreement among raft nodes before linearized reading'  (duration: 158.567908ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:29:08.435615Z","caller":"traceutil/trace.go:171","msg":"trace[945053973] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cea975fa-d520-4ab3-8d0f-54c049519594; range_end:; response_count:1; response_revision:5687; }","duration":"187.254984ms","start":"2026-09-03T05:29:08.24834Z","end":"2026-09-03T05:29:08.435595Z","steps":["trace[945053973] 'agreement among raft nodes before linearized reading'  (duration: 187.05905ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.435627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.953473ms","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-09-03T05:29:08.435675Z","caller":"traceutil/trace.go:171","msg":"trace[1970034386] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5687; }","duration":"177.043245ms","start":"2026-09-03T05:29:08.258617Z","end":"2026-09-03T05:29:08.435661Z","steps":["trace[1970034386] 'agreement among raft nodes before linearized reading'  (duration: 176.911112ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.435648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.541958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2102"}
{"level":"info","ts":"2026-09-03T05:29:08.435733Z","caller":"traceutil/trace.go:171","msg":"trace[630377120] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5687; }","duration":"166.66086ms","start":"2026-09-03T05:29:08.26905Z","end":"2026-09-03T05:29:08.435711Z","steps":["trace[630377120] 'agreement among raft nodes before linearized reading'  (duration: 166.420514ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.435428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.477339ms","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-09-03T05:29:08.436071Z","caller":"traceutil/trace.go:171","msg":"trace[333504578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5687; }","duration":"188.209425ms","start":"2026-09-03T05:29:08.247849Z","end":"2026-09-03T05:29:08.436059Z","steps":["trace[333504578] 'agreement among raft nodes before linearized reading'  (duration: 187.466149ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.662323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.76576ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743087250 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5616 > 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-09-03T05:29:08.662789Z","caller":"traceutil/trace.go:171","msg":"trace[1730654829] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"222.536001ms","start":"2026-09-03T05:29:08.440224Z","end":"2026-09-03T05:29:08.66276Z","steps":["trace[1730654829] 'process raft request'  (duration: 79.258169ms)","trace[1730654829] 'compare'  (duration: 142.671438ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:29:08.671708Z","caller":"traceutil/trace.go:171","msg":"trace[619167736] linearizableReadLoop","detail":"{readStateIndex:5899; appliedIndex:5897; }","duration":"229.347444ms","start":"2026-09-03T05:29:08.442344Z","end":"2026-09-03T05:29:08.671692Z","steps":["trace[619167736] 'read index received'  (duration: 77.149451ms)","trace[619167736] 'applied index is now lower than readState.Index'  (duration: 152.197033ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:29:08.67179Z","caller":"traceutil/trace.go:171","msg":"trace[89717367] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"230.963861ms","start":"2026-09-03T05:29:08.440796Z","end":"2026-09-03T05:29:08.67176Z","steps":["trace[89717367] 'process raft request'  (duration: 230.814337ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.671915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.558949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4788"}
{"level":"info","ts":"2026-09-03T05:29:08.671961Z","caller":"traceutil/trace.go:171","msg":"trace[1193784901] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5689; }","duration":"229.62927ms","start":"2026-09-03T05:29:08.442318Z","end":"2026-09-03T05:29:08.671947Z","steps":["trace[1193784901] 'agreement among raft nodes before linearized reading'  (duration: 229.470616ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:29:08.672011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.030264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80202"}
{"level":"info","ts":"2026-09-03T05:29:08.67205Z","caller":"traceutil/trace.go:171","msg":"trace[1575136730] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5689; }","duration":"228.108146ms","start":"2026-09-03T05:29:08.443933Z","end":"2026-09-03T05:29:08.672041Z","steps":["trace[1575136730] 'agreement among raft nodes before linearized reading'  (duration: 227.85946ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:29:08.871402Z","caller":"traceutil/trace.go:171","msg":"trace[1182804805] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"123.263421ms","start":"2026-09-03T05:29:08.748113Z","end":"2026-09-03T05:29:08.871377Z","steps":["trace[1182804805] 'process raft request'  (duration: 123.098297ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:29:20.172478Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2933}
{"level":"info","ts":"2026-09-03T05:29:20.26624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2933,"took":"92.395255ms","hash":2698444799,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":31989760,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-03T05:29:20.266303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2698444799,"revision":2933,"compact-revision":-1}
{"level":"info","ts":"2026-09-03T05:29:24.523445Z","caller":"traceutil/trace.go:171","msg":"trace[1642748206] linearizableReadLoop","detail":"{readStateIndex:6055; appliedIndex:6054; }","duration":"112.006928ms","start":"2026-09-03T05:29:24.411402Z","end":"2026-09-03T05:29:24.523409Z","steps":["trace[1642748206] 'read index received'  (duration: 73.106994ms)","trace[1642748206] 'applied index is now lower than readState.Index'  (duration: 38.898134ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:29:24.523466Z","caller":"traceutil/trace.go:171","msg":"trace[620456813] transaction","detail":"{read_only:false; response_revision:5839; number_of_response:1; }","duration":"114.375961ms","start":"2026-09-03T05:29:24.409064Z","end":"2026-09-03T05:29:24.52344Z","steps":["trace[620456813] 'process raft request'  (duration: 75.507738ms)","trace[620456813] 'compare'  (duration: 38.669838ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:29:24.523812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.381967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-09-03T05:29:24.523882Z","caller":"traceutil/trace.go:171","msg":"trace[795617775] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5839; }","duration":"112.49697ms","start":"2026-09-03T05:29:24.411365Z","end":"2026-09-03T05:29:24.523862Z","steps":["trace[795617775] 'agreement among raft nodes before linearized reading'  (duration: 112.279345ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:34:20.186521Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5804}
{"level":"info","ts":"2026-09-03T05:34:20.282189Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5804,"took":"94.010388ms","hash":3920029145,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":26353664,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-03T05:34:20.282254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3920029145,"revision":5804,"compact-revision":2933}
{"level":"info","ts":"2026-09-03T05:35:32.347043Z","caller":"traceutil/trace.go:171","msg":"trace[871878802] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"136.060957ms","start":"2026-09-03T05:35:32.21096Z","end":"2026-09-03T05:35:32.347021Z","steps":["trace[871878802] 'process raft request'  (duration: 135.904523ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:35:32.561117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.44623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-09-03T05:35:32.561201Z","caller":"traceutil/trace.go:171","msg":"trace[987902135] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8595; }","duration":"145.574643ms","start":"2026-09-03T05:35:32.415608Z","end":"2026-09-03T05:35:32.561183Z","steps":["trace[987902135] 'range keys from in-memory index tree'  (duration: 145.284156ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:35:44.063235Z","caller":"traceutil/trace.go:171","msg":"trace[1768892349] transaction","detail":"{read_only:false; response_revision:8657; number_of_response:1; }","duration":"111.475809ms","start":"2026-09-03T05:35:43.951731Z","end":"2026-09-03T05:35:44.063206Z","steps":["trace[1768892349] 'process raft request'  (duration: 111.240324ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:35:45.025598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.416474ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743095034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:35:45.025736Z","caller":"traceutil/trace.go:171","msg":"trace[1880727078] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"301.976441ms","start":"2026-09-03T05:35:44.723733Z","end":"2026-09-03T05:35:45.025709Z","steps":["trace[1880727078] 'process raft request'  (duration: 31.359482ms)","trace[1880727078] 'compare'  (duration: 270.23342ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:35:45.025888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:35:44.723714Z","time spent":"302.089464ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-03T05:35:45.102836Z","caller":"traceutil/trace.go:171","msg":"trace[463359807] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"286.026149ms","start":"2026-09-03T05:35:44.816788Z","end":"2026-09-03T05:35:45.102814Z","steps":["trace[463359807] 'process raft request'  (duration: 285.905987ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:35:45.114541Z","caller":"traceutil/trace.go:171","msg":"trace[466864463] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"206.69342ms","start":"2026-09-03T05:35:44.907824Z","end":"2026-09-03T05:35:45.114518Z","steps":["trace[466864463] 'process raft request'  (duration: 206.507566ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:35:45.114657Z","caller":"traceutil/trace.go:171","msg":"trace[988680136] linearizableReadLoop","detail":"{readStateIndex:8969; appliedIndex:8966; }","duration":"159.069199ms","start":"2026-09-03T05:35:44.955575Z","end":"2026-09-03T05:35:45.114644Z","steps":["trace[988680136] 'read index received'  (duration: 147.16718ms)","trace[988680136] 'applied index is now lower than readState.Index'  (duration: 11.900859ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:35:45.11471Z","caller":"traceutil/trace.go:171","msg":"trace[773067846] transaction","detail":"{read_only:false; response_revision:8664; number_of_response:1; }","duration":"204.818537ms","start":"2026-09-03T05:35:44.909864Z","end":"2026-09-03T05:35:45.114682Z","steps":["trace[773067846] 'process raft request'  (duration: 204.614043ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:35:45.114793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.203582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:35:45.114817Z","caller":"traceutil/trace.go:171","msg":"trace[1664781074] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:8664; }","duration":"159.267843ms","start":"2026-09-03T05:35:44.955542Z","end":"2026-09-03T05:35:45.11481Z","steps":["trace[1664781074] 'agreement among raft nodes before linearized reading'  (duration: 159.14302ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:35:46.747443Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000230f.wal"}
{"level":"info","ts":"2026-09-03T05:36:14.768966Z","caller":"traceutil/trace.go:171","msg":"trace[1485276315] linearizableReadLoop","detail":"{readStateIndex:9186; appliedIndex:9185; }","duration":"207.060923ms","start":"2026-09-03T05:36:14.561882Z","end":"2026-09-03T05:36:14.768943Z","steps":["trace[1485276315] 'read index received'  (duration: 206.849468ms)","trace[1485276315] 'applied index is now lower than readState.Index'  (duration: 210.655µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:14.7691Z","caller":"traceutil/trace.go:171","msg":"trace[1919558098] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"245.072694ms","start":"2026-09-03T05:36:14.523985Z","end":"2026-09-03T05:36:14.769058Z","steps":["trace[1919558098] 'process raft request'  (duration: 244.805038ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:14.7692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.306449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-03T05:36:14.769242Z","caller":"traceutil/trace.go:171","msg":"trace[501041168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8873; }","duration":"207.405181ms","start":"2026-09-03T05:36:14.561826Z","end":"2026-09-03T05:36:14.769231Z","steps":["trace[501041168] 'agreement among raft nodes before linearized reading'  (duration: 207.258588ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:14.76935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.028196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:36:14.769445Z","caller":"traceutil/trace.go:171","msg":"trace[1301583713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8873; }","duration":"132.160719ms","start":"2026-09-03T05:36:14.637264Z","end":"2026-09-03T05:36:14.769425Z","steps":["trace[1301583713] 'agreement among raft nodes before linearized reading'  (duration: 132.014726ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:36:14.989063Z","caller":"traceutil/trace.go:171","msg":"trace[1262879608] linearizableReadLoop","detail":"{readStateIndex:9187; appliedIndex:9186; }","duration":"205.427195ms","start":"2026-09-03T05:36:14.783601Z","end":"2026-09-03T05:36:14.989028Z","steps":["trace[1262879608] 'read index received'  (duration: 204.944324ms)","trace[1262879608] 'applied index is now lower than readState.Index'  (duration: 476.2µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:14.989228Z","caller":"traceutil/trace.go:171","msg":"trace[1219736883] transaction","detail":"{read_only:false; response_revision:8874; number_of_response:1; }","duration":"215.388056ms","start":"2026-09-03T05:36:14.773822Z","end":"2026-09-03T05:36:14.98921Z","steps":["trace[1219736883] 'process raft request'  (duration: 214.917014ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:14.989441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.824095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:36:14.989491Z","caller":"traceutil/trace.go:171","msg":"trace[70900643] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8874; }","duration":"205.925208ms","start":"2026-09-03T05:36:14.783551Z","end":"2026-09-03T05:36:14.989476Z","steps":["trace[70900643] 'agreement among raft nodes before linearized reading'  (duration: 205.820655ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:14.989478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.036239ms","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-09-03T05:36:14.989559Z","caller":"traceutil/trace.go:171","msg":"trace[947363782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8874; }","duration":"101.163422ms","start":"2026-09-03T05:36:14.888376Z","end":"2026-09-03T05:36:14.98954Z","steps":["trace[947363782] 'agreement among raft nodes before linearized reading'  (duration: 100.925427ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:17.733346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.687422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228851"}
{"level":"info","ts":"2026-09-03T05:36:17.733447Z","caller":"traceutil/trace.go:171","msg":"trace[2095125721] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8887; }","duration":"332.823394ms","start":"2026-09-03T05:36:17.400599Z","end":"2026-09-03T05:36:17.733423Z","steps":["trace[2095125721] 'range keys from in-memory index tree'  (duration: 332.273692ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:17.733505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:36:17.400586Z","time spent":"332.900387ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228874,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-09-03T05:36:17.739651Z","caller":"traceutil/trace.go:171","msg":"trace[1366688303] linearizableReadLoop","detail":"{readStateIndex:9201; appliedIndex:9200; }","duration":"102.368499ms","start":"2026-09-03T05:36:17.63726Z","end":"2026-09-03T05:36:17.739629Z","steps":["trace[1366688303] 'read index received'  (duration: 102.181895ms)","trace[1366688303] 'applied index is now lower than readState.Index'  (duration: 185.814µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:17.739758Z","caller":"traceutil/trace.go:171","msg":"trace[824831442] transaction","detail":"{read_only:false; response_revision:8888; number_of_response:1; }","duration":"338.24738ms","start":"2026-09-03T05:36:17.401472Z","end":"2026-09-03T05:36:17.739719Z","steps":["trace[824831442] 'process raft request'  (duration: 338.027445ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:17.739855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.585494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:36:17.739904Z","caller":"traceutil/trace.go:171","msg":"trace[89648932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8888; }","duration":"102.679276ms","start":"2026-09-03T05:36:17.637211Z","end":"2026-09-03T05:36:17.739891Z","steps":["trace[89648932] 'agreement among raft nodes before linearized reading'  (duration: 102.521172ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:17.739938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:36:17.401455Z","time spent":"338.392133ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8879 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-03T05:36:25.970361Z","caller":"traceutil/trace.go:171","msg":"trace[1560514659] linearizableReadLoop","detail":"{readStateIndex:9247; appliedIndex:9246; }","duration":"191.3854ms","start":"2026-09-03T05:36:25.778949Z","end":"2026-09-03T05:36:25.970334Z","steps":["trace[1560514659] 'read index received'  (duration: 191.212916ms)","trace[1560514659] 'applied index is now lower than readState.Index'  (duration: 171.154µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:25.970802Z","caller":"traceutil/trace.go:171","msg":"trace[2036390122] transaction","detail":"{read_only:false; response_revision:8932; number_of_response:1; }","duration":"193.765936ms","start":"2026-09-03T05:36:25.777001Z","end":"2026-09-03T05:36:25.970767Z","steps":["trace[2036390122] 'process raft request'  (duration: 193.158882ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:25.970934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.975525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:36:25.970995Z","caller":"traceutil/trace.go:171","msg":"trace[1385303285] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:8932; }","duration":"192.128457ms","start":"2026-09-03T05:36:25.778852Z","end":"2026-09-03T05:36:25.970981Z","steps":["trace[1385303285] 'agreement among raft nodes before linearized reading'  (duration: 191.941683ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:26.257433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.310179ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743095825 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8923 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:36:26.257647Z","caller":"traceutil/trace.go:171","msg":"trace[1330302425] linearizableReadLoop","detail":"{readStateIndex:9249; appliedIndex:9247; }","duration":"281.515547ms","start":"2026-09-03T05:36:25.976109Z","end":"2026-09-03T05:36:26.257625Z","steps":["trace[1330302425] 'read index received'  (duration: 124.936183ms)","trace[1330302425] 'applied index is now lower than readState.Index'  (duration: 156.578214ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:26.257698Z","caller":"traceutil/trace.go:171","msg":"trace[1100351319] transaction","detail":"{read_only:false; response_revision:8934; number_of_response:1; }","duration":"281.797154ms","start":"2026-09-03T05:36:25.97585Z","end":"2026-09-03T05:36:26.257647Z","steps":["trace[1100351319] 'process raft request'  (duration: 281.702022ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:36:26.257649Z","caller":"traceutil/trace.go:171","msg":"trace[1977365545] transaction","detail":"{read_only:false; response_revision:8933; number_of_response:1; }","duration":"282.194612ms","start":"2026-09-03T05:36:25.975426Z","end":"2026-09-03T05:36:26.25762Z","steps":["trace[1977365545] 'process raft request'  (duration: 125.603937ms)","trace[1977365545] 'compare'  (duration: 156.186876ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:36:26.258118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.961537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228851"}
{"level":"info","ts":"2026-09-03T05:36:26.258212Z","caller":"traceutil/trace.go:171","msg":"trace[532490951] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8934; }","duration":"282.109731ms","start":"2026-09-03T05:36:25.976081Z","end":"2026-09-03T05:36:26.258191Z","steps":["trace[532490951] 'agreement among raft nodes before linearized reading'  (duration: 281.660371ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:36:26.278274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.851556ms","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-09-03T05:36:26.278349Z","caller":"traceutil/trace.go:171","msg":"trace[1105410739] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8936; }","duration":"107.982249ms","start":"2026-09-03T05:36:26.170351Z","end":"2026-09-03T05:36:26.278333Z","steps":["trace[1105410739] 'agreement among raft nodes before linearized reading'  (duration: 107.833086ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:36:28.406415Z","caller":"traceutil/trace.go:171","msg":"trace[874320599] transaction","detail":"{read_only:false; response_revision:8955; number_of_response:1; }","duration":"104.627202ms","start":"2026-09-03T05:36:28.30176Z","end":"2026-09-03T05:36:28.406387Z","steps":["trace[874320599] 'process raft request'  (duration: 83.094463ms)","trace[874320599] 'compare'  (duration: 21.336785ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:36:28.444645Z","caller":"traceutil/trace.go:171","msg":"trace[281054342] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8956; }","duration":"141.468535ms","start":"2026-09-03T05:36:28.303154Z","end":"2026-09-03T05:36:28.444622Z","steps":["trace[281054342] 'process raft request'  (duration: 141.332242ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:37:36.288794Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-03T05:37:36.295928Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-03T05:37:36.296028Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-03T05:37:57.938382Z","caller":"traceutil/trace.go:171","msg":"trace[1436602710] transaction","detail":"{read_only:false; response_revision:9806; number_of_response:1; }","duration":"143.725015ms","start":"2026-09-03T05:37:57.79463Z","end":"2026-09-03T05:37:57.938355Z","steps":["trace[1436602710] 'process raft request'  (duration: 143.660873ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:37:57.938468Z","caller":"traceutil/trace.go:171","msg":"trace[2016770535] transaction","detail":"{read_only:false; response_revision:9805; number_of_response:1; }","duration":"171.353975ms","start":"2026-09-03T05:37:57.767087Z","end":"2026-09-03T05:37:57.938441Z","steps":["trace[2016770535] 'process raft request'  (duration: 171.052198ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:39:20.1953Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7979}
{"level":"info","ts":"2026-09-03T05:39:20.269783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7979,"took":"71.347199ms","hash":2287229481,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":27979776,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-03T05:39:20.269869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2287229481,"revision":7979,"compact-revision":5804}
{"level":"info","ts":"2026-09-03T05:43:17.384701Z","caller":"traceutil/trace.go:171","msg":"trace[298383260] linearizableReadLoop","detail":"{readStateIndex:12548; appliedIndex:12547; }","duration":"126.857983ms","start":"2026-09-03T05:43:17.257801Z","end":"2026-09-03T05:43:17.384659Z","steps":["trace[298383260] 'read index received'  (duration: 107.691525ms)","trace[298383260] 'applied index is now lower than readState.Index'  (duration: 19.158597ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:43:17.385013Z","caller":"traceutil/trace.go:171","msg":"trace[1233669365] transaction","detail":"{read_only:false; response_revision:12132; number_of_response:1; }","duration":"129.632426ms","start":"2026-09-03T05:43:17.255345Z","end":"2026-09-03T05:43:17.384977Z","steps":["trace[1233669365] 'process raft request'  (duration: 110.191402ms)","trace[1233669365] 'compare'  (duration: 18.921442ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:43:17.385054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.20832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:43:17.385113Z","caller":"traceutil/trace.go:171","msg":"trace[1788128451] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:12132; }","duration":"127.328584ms","start":"2026-09-03T05:43:17.257771Z","end":"2026-09-03T05:43:17.3851Z","steps":["trace[1788128451] 'agreement among raft nodes before linearized reading'  (duration: 127.047577ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:43:37.730908Z","caller":"traceutil/trace.go:171","msg":"trace[339218672] linearizableReadLoop","detail":"{readStateIndex:12663; appliedIndex:12662; }","duration":"197.616696ms","start":"2026-09-03T05:43:37.533261Z","end":"2026-09-03T05:43:37.730878Z","steps":["trace[339218672] 'read index received'  (duration: 197.431852ms)","trace[339218672] 'applied index is now lower than readState.Index'  (duration: 183.354µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:43:37.730977Z","caller":"traceutil/trace.go:171","msg":"trace[192202924] transaction","detail":"{read_only:false; response_revision:12243; number_of_response:1; }","duration":"237.007575ms","start":"2026-09-03T05:43:37.493925Z","end":"2026-09-03T05:43:37.730932Z","steps":["trace[192202924] 'process raft request'  (duration: 236.747749ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:43:37.731222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.934874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:43:37.731265Z","caller":"traceutil/trace.go:171","msg":"trace[2139956230] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:12243; }","duration":"198.151049ms","start":"2026-09-03T05:43:37.533102Z","end":"2026-09-03T05:43:37.731253Z","steps":["trace[2139956230] 'agreement among raft nodes before linearized reading'  (duration: 197.911713ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:44:20.202737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10348}
{"level":"info","ts":"2026-09-03T05:44:20.283568Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10348,"took":"78.619002ms","hash":1526672650,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":26337280,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-03T05:44:20.283647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1526672650,"revision":10348,"compact-revision":7979}
{"level":"info","ts":"2026-09-03T05:49:20.209333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12550}
{"level":"info","ts":"2026-09-03T05:49:20.300828Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12550,"took":"88.963745ms","hash":1715423930,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":27652096,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-03T05:49:20.300919Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1715423930,"revision":12550,"compact-revision":10348}
{"level":"info","ts":"2026-09-03T05:50:12.359626Z","caller":"traceutil/trace.go:171","msg":"trace[564322672] transaction","detail":"{read_only:false; response_revision:14868; number_of_response:1; }","duration":"106.193387ms","start":"2026-09-03T05:50:12.253405Z","end":"2026-09-03T05:50:12.359599Z","steps":["trace[564322672] 'process raft request'  (duration: 106.026593ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:50:35.798718Z","caller":"traceutil/trace.go:171","msg":"trace[881938271] linearizableReadLoop","detail":"{readStateIndex:15509; appliedIndex:15508; }","duration":"160.540719ms","start":"2026-09-03T05:50:35.63815Z","end":"2026-09-03T05:50:35.798691Z","steps":["trace[881938271] 'read index received'  (duration: 160.350524ms)","trace[881938271] 'applied index is now lower than readState.Index'  (duration: 189.455µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:50:35.79878Z","caller":"traceutil/trace.go:171","msg":"trace[2127779036] transaction","detail":"{read_only:false; response_revision:14989; number_of_response:1; }","duration":"199.704117ms","start":"2026-09-03T05:50:35.599027Z","end":"2026-09-03T05:50:35.798731Z","steps":["trace[2127779036] 'process raft request'  (duration: 199.526483ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:50:35.798874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.704703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:50:35.798914Z","caller":"traceutil/trace.go:171","msg":"trace[364764474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14989; }","duration":"160.825125ms","start":"2026-09-03T05:50:35.638078Z","end":"2026-09-03T05:50:35.798903Z","steps":["trace[364764474] 'agreement among raft nodes before linearized reading'  (duration: 160.713853ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:50:36.124015Z","caller":"traceutil/trace.go:171","msg":"trace[1947234089] transaction","detail":"{read_only:false; response_revision:14990; number_of_response:1; }","duration":"114.650258ms","start":"2026-09-03T05:50:36.009339Z","end":"2026-09-03T05:50:36.123989Z","steps":["trace[1947234089] 'process raft request'  (duration: 114.496985ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:50:44.786111Z","caller":"traceutil/trace.go:171","msg":"trace[1114148005] linearizableReadLoop","detail":"{readStateIndex:15556; appliedIndex:15555; }","duration":"149.300514ms","start":"2026-09-03T05:50:44.636782Z","end":"2026-09-03T05:50:44.786082Z","steps":["trace[1114148005] 'read index received'  (duration: 117.740149ms)","trace[1114148005] 'applied index is now lower than readState.Index'  (duration: 31.558765ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:50:44.786281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.478318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:50:44.786328Z","caller":"traceutil/trace.go:171","msg":"trace[2094552387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15034; }","duration":"149.58518ms","start":"2026-09-03T05:50:44.63673Z","end":"2026-09-03T05:50:44.786315Z","steps":["trace[2094552387] 'agreement among raft nodes before linearized reading'  (duration: 149.449967ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:50:44.78639Z","caller":"traceutil/trace.go:171","msg":"trace[1653569347] transaction","detail":"{read_only:false; response_revision:15034; number_of_response:1; }","duration":"172.294134ms","start":"2026-09-03T05:50:44.614063Z","end":"2026-09-03T05:50:44.786357Z","steps":["trace[1653569347] 'process raft request'  (duration: 140.489824ms)","trace[1653569347] 'compare'  (duration: 31.271658ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:50:53.221301Z","caller":"traceutil/trace.go:171","msg":"trace[861690137] transaction","detail":"{read_only:false; response_revision:15093; number_of_response:1; }","duration":"154.43938ms","start":"2026-09-03T05:50:53.066836Z","end":"2026-09-03T05:50:53.221275Z","steps":["trace[861690137] 'process raft request'  (duration: 154.272946ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:50:54.094523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.260769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.111\" ","response":"range_response_count:1 size:138"}
{"level":"warn","ts":"2026-09-03T05:50:54.094564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.383704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-03T05:50:54.094601Z","caller":"traceutil/trace.go:171","msg":"trace[731589308] range","detail":"{range_begin:/registry/masterleases/162.253.55.111; range_end:; response_count:1; response_revision:15097; }","duration":"415.389112ms","start":"2026-09-03T05:50:53.679194Z","end":"2026-09-03T05:50:54.094583Z","steps":["trace[731589308] 'range keys from in-memory index tree'  (duration: 415.083956ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:50:54.094648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:50:53.679173Z","time spent":"415.465744ms","remote":"127.0.0.1:36724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/162.253.55.111\" "}
{"level":"info","ts":"2026-09-03T05:50:54.094651Z","caller":"traceutil/trace.go:171","msg":"trace[1999741455] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15097; }","duration":"407.530038ms","start":"2026-09-03T05:50:53.6871Z","end":"2026-09-03T05:50:54.09463Z","steps":["trace[1999741455] 'count revisions from in-memory index tree'  (duration: 407.234882ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:50:54.094698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:50:53.687084Z","time spent":"407.601309ms","remote":"127.0.0.1:59548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-09-03T05:51:03.797032Z","caller":"traceutil/trace.go:171","msg":"trace[1026367961] linearizableReadLoop","detail":"{readStateIndex:15798; appliedIndex:15796; }","duration":"115.758044ms","start":"2026-09-03T05:51:03.681246Z","end":"2026-09-03T05:51:03.797004Z","steps":["trace[1026367961] 'read index received'  (duration: 24.179991ms)","trace[1026367961] 'applied index is now lower than readState.Index'  (duration: 91.576333ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:51:03.797204Z","caller":"traceutil/trace.go:171","msg":"trace[552189010] transaction","detail":"{read_only:false; response_revision:15270; number_of_response:1; }","duration":"116.50828ms","start":"2026-09-03T05:51:03.680678Z","end":"2026-09-03T05:51:03.797186Z","steps":["trace[552189010] 'process raft request'  (duration: 116.162083ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:51:03.797446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.171613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3286224-8a83-452d-8b29-df4e2528f7fa\" ","response":"range_response_count:1 size:3607"}
{"level":"info","ts":"2026-09-03T05:51:03.797542Z","caller":"traceutil/trace.go:171","msg":"trace[1750625629] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b3286224-8a83-452d-8b29-df4e2528f7fa; range_end:; response_count:1; response_revision:15270; }","duration":"116.279465ms","start":"2026-09-03T05:51:03.681239Z","end":"2026-09-03T05:51:03.797519Z","steps":["trace[1750625629] 'agreement among raft nodes before linearized reading'  (duration: 116.02265ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:51:03.797899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.071511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:67 size:630289"}
{"level":"info","ts":"2026-09-03T05:51:03.797955Z","caller":"traceutil/trace.go:171","msg":"trace[943073921] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:67; response_revision:15270; }","duration":"116.173204ms","start":"2026-09-03T05:51:03.68177Z","end":"2026-09-03T05:51:03.797944Z","steps":["trace[943073921] 'agreement among raft nodes before linearized reading'  (duration: 115.494308ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:51:04.042963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.166126ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743113157 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.111\" mod_revision:15098 > success:<request_put:<key:\"/registry/masterleases/162.253.55.111\" value_size:68 lease:918066257743113152 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.111\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-03T05:51:04.043141Z","caller":"traceutil/trace.go:171","msg":"trace[976996336] transaction","detail":"{read_only:false; response_revision:15271; number_of_response:1; }","duration":"244.832465ms","start":"2026-09-03T05:51:03.798287Z","end":"2026-09-03T05:51:04.04312Z","steps":["trace[976996336] 'process raft request'  (duration: 101.402243ms)","trace[976996336] 'compare'  (duration: 142.996553ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:51:04.188268Z","caller":"traceutil/trace.go:171","msg":"trace[1632747317] linearizableReadLoop","detail":"{readStateIndex:15800; appliedIndex:15799; }","duration":"142.998562ms","start":"2026-09-03T05:51:04.045244Z","end":"2026-09-03T05:51:04.188242Z","steps":["trace[1632747317] 'read index received'  (duration: 124.688762ms)","trace[1632747317] 'applied index is now lower than readState.Index'  (duration: 18.30829ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:51:04.188397Z","caller":"traceutil/trace.go:171","msg":"trace[570393206] transaction","detail":"{read_only:false; response_revision:15272; number_of_response:1; }","duration":"383.385429ms","start":"2026-09-03T05:51:03.805Z","end":"2026-09-03T05:51:04.188385Z","steps":["trace[570393206] 'process raft request'  (duration: 364.944667ms)","trace[570393206] 'compare'  (duration: 18.136745ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:51:04.188513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:51:03.804975Z","time spent":"383.45472ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3709,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3286224-8a83-452d-8b29-df4e2528f7fa\" mod_revision:15242 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3286224-8a83-452d-8b29-df4e2528f7fa\" value_size:3609 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3286224-8a83-452d-8b29-df4e2528f7fa\" > >"}
{"level":"warn","ts":"2026-09-03T05:51:04.188634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.539533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-kqvhv.18d1b9a90097bc9b\" ","response":"range_response_count:1 size:783"}
{"level":"info","ts":"2026-09-03T05:51:04.188717Z","caller":"traceutil/trace.go:171","msg":"trace[292024665] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-kqvhv.18d1b9a90097bc9b; range_end:; response_count:1; response_revision:15272; }","duration":"104.665616ms","start":"2026-09-03T05:51:04.084029Z","end":"2026-09-03T05:51:04.188694Z","steps":["trace[292024665] 'agreement among raft nodes before linearized reading'  (duration: 104.471481ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:51:04.188993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.755159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-09-03T05:51:04.189037Z","caller":"traceutil/trace.go:171","msg":"trace[1332316682] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:15272; }","duration":"143.79977ms","start":"2026-09-03T05:51:04.045226Z","end":"2026-09-03T05:51:04.189026Z","steps":["trace[1332316682] 'agreement among raft nodes before linearized reading'  (duration: 143.660157ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.25482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.409966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:52:45.254908Z","caller":"traceutil/trace.go:171","msg":"trace[1258067246] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16361; }","duration":"317.548088ms","start":"2026-09-03T05:52:44.937338Z","end":"2026-09-03T05:52:45.254886Z","steps":["trace[1258067246] 'range keys from in-memory index tree'  (duration: 317.254201ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.254958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:44.937317Z","time spent":"317.62607ms","remote":"127.0.0.1:36964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-09-03T05:52:45.255242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.652704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:52:45.255291Z","caller":"traceutil/trace.go:171","msg":"trace[175283150] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16361; }","duration":"123.707815ms","start":"2026-09-03T05:52:45.131568Z","end":"2026-09-03T05:52:45.255276Z","steps":["trace[175283150] 'range keys from in-memory index tree'  (duration: 123.620764ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.25543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.117224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-03T05:52:45.255493Z","caller":"traceutil/trace.go:171","msg":"trace[1260148916] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16361; }","duration":"315.211146ms","start":"2026-09-03T05:52:44.940263Z","end":"2026-09-03T05:52:45.255474Z","steps":["trace[1260148916] 'range keys from in-memory index tree'  (duration: 314.95138ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.255532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:44.940246Z","time spent":"315.274627ms","remote":"127.0.0.1:36964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-09-03T05:52:45.255536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.087772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"warn","ts":"2026-09-03T05:52:45.255604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.116614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"}
{"level":"warn","ts":"2026-09-03T05:52:45.255597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.256764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-03T05:52:45.255631Z","caller":"traceutil/trace.go:171","msg":"trace[29866172] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16361; }","duration":"318.205554ms","start":"2026-09-03T05:52:44.937397Z","end":"2026-09-03T05:52:45.255603Z","steps":["trace[29866172] 'range keys from in-memory index tree'  (duration: 317.852276ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:52:45.255655Z","caller":"traceutil/trace.go:171","msg":"trace[1967376764] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16361; }","duration":"124.194556ms","start":"2026-09-03T05:52:45.131447Z","end":"2026-09-03T05:52:45.255641Z","steps":["trace[1967376764] 'range keys from in-memory index tree'  (duration: 124.019212ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:52:45.25567Z","caller":"traceutil/trace.go:171","msg":"trace[1937046023] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16361; }","duration":"116.339106ms","start":"2026-09-03T05:52:45.139312Z","end":"2026-09-03T05:52:45.255651Z","steps":["trace[1937046023] 'range keys from in-memory index tree'  (duration: 116.158973ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.255705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:44.937317Z","time spent":"318.355998ms","remote":"127.0.0.1:36860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-09-03T05:52:45.255747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.091444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kx8xf\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-03T05:52:45.255819Z","caller":"traceutil/trace.go:171","msg":"trace[1075056931] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kx8xf; range_end:; response_count:1; response_revision:16361; }","duration":"287.203296ms","start":"2026-09-03T05:52:44.968596Z","end":"2026-09-03T05:52:45.255799Z","steps":["trace[1075056931] 'range keys from in-memory index tree'  (duration: 286.868749ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.255847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.719131ms","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-09-03T05:52:45.255872Z","caller":"traceutil/trace.go:171","msg":"trace[1241322737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16361; }","duration":"104.742342ms","start":"2026-09-03T05:52:45.151121Z","end":"2026-09-03T05:52:45.255863Z","steps":["trace[1241322737] 'range keys from in-memory index tree'  (duration: 104.660429ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:52:45.465413Z","caller":"traceutil/trace.go:171","msg":"trace[27694211] linearizableReadLoop","detail":"{readStateIndex:16926; appliedIndex:16925; }","duration":"254.549541ms","start":"2026-09-03T05:52:45.210823Z","end":"2026-09-03T05:52:45.465372Z","steps":["trace[27694211] 'read index received'  (duration: 254.271364ms)","trace[27694211] 'applied index is now lower than readState.Index'  (duration: 276.157µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:52:45.466194Z","caller":"traceutil/trace.go:171","msg":"trace[1005335149] transaction","detail":"{read_only:false; response_revision:16362; number_of_response:1; }","duration":"260.424965ms","start":"2026-09-03T05:52:45.205681Z","end":"2026-09-03T05:52:45.466105Z","steps":["trace[1005335149] 'process raft request'  (duration: 259.36547ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.46624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.40556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wgpk8\" ","response":"range_response_count:1 size:22093"}
{"level":"info","ts":"2026-09-03T05:52:45.466316Z","caller":"traceutil/trace.go:171","msg":"trace[1062181479] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wgpk8; range_end:; response_count:1; response_revision:16362; }","duration":"255.528543ms","start":"2026-09-03T05:52:45.210771Z","end":"2026-09-03T05:52:45.466299Z","steps":["trace[1062181479] 'agreement among raft nodes before linearized reading'  (duration: 255.246387ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:52:45.625673Z","caller":"traceutil/trace.go:171","msg":"trace[758648257] transaction","detail":"{read_only:false; response_revision:16363; number_of_response:1; }","duration":"360.196713ms","start":"2026-09-03T05:52:45.265453Z","end":"2026-09-03T05:52:45.62565Z","steps":["trace[758648257] 'process raft request'  (duration: 339.441669ms)","trace[758648257] 'compare'  (duration: 20.597801ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:52:45.625893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.26542Z","time spent":"360.359416ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:16352 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-03T05:52:45.626099Z","caller":"traceutil/trace.go:171","msg":"trace[248292037] linearizableReadLoop","detail":"{readStateIndex:16929; appliedIndex:16926; }","duration":"160.564825ms","start":"2026-09-03T05:52:45.465511Z","end":"2026-09-03T05:52:45.626075Z","steps":["trace[248292037] 'read index received'  (duration: 139.317239ms)","trace[248292037] 'applied index is now lower than readState.Index'  (duration: 21.246326ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:52:45.626219Z","caller":"traceutil/trace.go:171","msg":"trace[1767727676] transaction","detail":"{read_only:false; response_revision:16365; number_of_response:1; }","duration":"358.693658ms","start":"2026-09-03T05:52:45.267512Z","end":"2026-09-03T05:52:45.626206Z","steps":["trace[1767727676] 'process raft request'  (duration: 358.437563ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:52:45.626216Z","caller":"traceutil/trace.go:171","msg":"trace[1073249629] transaction","detail":"{read_only:false; response_revision:16364; number_of_response:1; }","duration":"360.689064ms","start":"2026-09-03T05:52:45.265484Z","end":"2026-09-03T05:52:45.626173Z","steps":["trace[1073249629] 'process raft request'  (duration: 360.124611ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.626339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.267485Z","time spent":"358.765199ms","remote":"127.0.0.1:36996","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:16355 > 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-09-03T05:52:45.626439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.265461Z","time spent":"360.855488ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:16354 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-03T05:52:45.626483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.176344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-kdfp2\" ","response":"range_response_count:1 size:20637"}
{"level":"info","ts":"2026-09-03T05:52:45.626531Z","caller":"traceutil/trace.go:171","msg":"trace[904366173] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-kdfp2; range_end:; response_count:1; response_revision:16365; }","duration":"269.270577ms","start":"2026-09-03T05:52:45.357248Z","end":"2026-09-03T05:52:45.626519Z","steps":["trace[904366173] 'agreement among raft nodes before linearized reading'  (duration: 269.122463ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.626632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.255273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-03T05:52:45.62667Z","caller":"traceutil/trace.go:171","msg":"trace[79090415] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16365; }","duration":"360.334295ms","start":"2026-09-03T05:52:45.266325Z","end":"2026-09-03T05:52:45.626659Z","steps":["trace[79090415] 'agreement among raft nodes before linearized reading'  (duration: 360.201112ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.62673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.266312Z","time spent":"360.411646ms","remote":"127.0.0.1:36964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5544,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-09-03T05:52:45.626791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.51086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-03T05:52:45.626837Z","caller":"traceutil/trace.go:171","msg":"trace[504692232] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16365; }","duration":"201.606222ms","start":"2026-09-03T05:52:45.425219Z","end":"2026-09-03T05:52:45.626825Z","steps":["trace[504692232] 'agreement among raft nodes before linearized reading'  (duration: 201.461659ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.627111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.582513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:52:45.627153Z","caller":"traceutil/trace.go:171","msg":"trace[243924990] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16365; }","duration":"205.654134ms","start":"2026-09-03T05:52:45.421488Z","end":"2026-09-03T05:52:45.627143Z","steps":["trace[243924990] 'agreement among raft nodes before linearized reading'  (duration: 205.557792ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.627289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.757647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:52:45.627344Z","caller":"traceutil/trace.go:171","msg":"trace[1606204006] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16365; }","duration":"205.867089ms","start":"2026-09-03T05:52:45.421462Z","end":"2026-09-03T05:52:45.627329Z","steps":["trace[1606204006] 'agreement among raft nodes before linearized reading'  (duration: 205.779827ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.627489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.025222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-03T05:52:45.627536Z","caller":"traceutil/trace.go:171","msg":"trace[32924632] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16365; }","duration":"206.133215ms","start":"2026-09-03T05:52:45.42139Z","end":"2026-09-03T05:52:45.627523Z","steps":["trace[32924632] 'agreement among raft nodes before linearized reading'  (duration: 206.061753ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.627821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.77412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769775"}
{"level":"info","ts":"2026-09-03T05:52:45.627877Z","caller":"traceutil/trace.go:171","msg":"trace[777154243] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16365; }","duration":"153.865463ms","start":"2026-09-03T05:52:45.473999Z","end":"2026-09-03T05:52:45.627865Z","steps":["trace[777154243] 'agreement among raft nodes before linearized reading'  (duration: 152.827508ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.628232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.550327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wgpk8\" ","response":"range_response_count:1 size:22093"}
{"level":"info","ts":"2026-09-03T05:52:45.628278Z","caller":"traceutil/trace.go:171","msg":"trace[1497485322] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wgpk8; range_end:; response_count:1; response_revision:16365; }","duration":"394.596018ms","start":"2026-09-03T05:52:45.233671Z","end":"2026-09-03T05:52:45.628267Z","steps":["trace[1497485322] 'agreement among raft nodes before linearized reading'  (duration: 394.477555ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.628304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.233634Z","time spent":"394.66377ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22116,"request content":"key:\"/registry/pods/openstack/nova-compute-default-wgpk8\" "}
{"level":"warn","ts":"2026-09-03T05:52:45.632282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.715141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769775"}
{"level":"info","ts":"2026-09-03T05:52:45.632338Z","caller":"traceutil/trace.go:171","msg":"trace[1759507153] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16365; }","duration":"366.933196ms","start":"2026-09-03T05:52:45.265391Z","end":"2026-09-03T05:52:45.632324Z","steps":["trace[1759507153] 'agreement among raft nodes before linearized reading'  (duration: 362.625388ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:52:45.632595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T05:52:45.265365Z","time spent":"367.212913ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":79,"response size":769798,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-09-03T05:52:45.782907Z","caller":"traceutil/trace.go:171","msg":"trace[1250486895] transaction","detail":"{read_only:false; response_revision:16366; number_of_response:1; }","duration":"104.754651ms","start":"2026-09-03T05:52:45.67812Z","end":"2026-09-03T05:52:45.782874Z","steps":["trace[1250486895] 'process raft request'  (duration: 94.314382ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:54:20.216289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14551}
{"level":"info","ts":"2026-09-03T05:54:20.297681Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14551,"took":"78.396717ms","hash":2913127562,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":31485952,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-03T05:54:20.297776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2913127562,"revision":14551,"compact-revision":12550}
{"level":"warn","ts":"2026-09-03T05:58:22.336997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.299334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-lh96h\" ","response":"range_response_count:1 size:9789"}
{"level":"info","ts":"2026-09-03T05:58:22.337081Z","caller":"traceutil/trace.go:171","msg":"trace[955712528] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-lh96h; range_end:; response_count:1; response_revision:18775; }","duration":"121.438747ms","start":"2026-09-03T05:58:22.215625Z","end":"2026-09-03T05:58:22.337064Z","steps":["trace[955712528] 'range keys from in-memory index tree'  (duration: 121.09383ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:58:22.337403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.744583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-03T05:58:22.337447Z","caller":"traceutil/trace.go:171","msg":"trace[992490643] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:18775; }","duration":"113.848706ms","start":"2026-09-03T05:58:22.223587Z","end":"2026-09-03T05:58:22.337435Z","steps":["trace[992490643] 'count revisions from in-memory index tree'  (duration: 113.645931ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:58:23.860537Z","caller":"traceutil/trace.go:171","msg":"trace[1287844605] transaction","detail":"{read_only:false; response_revision:18785; number_of_response:1; }","duration":"130.36937ms","start":"2026-09-03T05:58:23.730087Z","end":"2026-09-03T05:58:23.860456Z","steps":["trace[1287844605] 'process raft request'  (duration: 102.231814ms)","trace[1287844605] 'compare'  (duration: 27.891901ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:58:26.272867Z","caller":"traceutil/trace.go:171","msg":"trace[825367938] transaction","detail":"{read_only:false; response_revision:18799; number_of_response:1; }","duration":"115.748549ms","start":"2026-09-03T05:58:26.157081Z","end":"2026-09-03T05:58:26.272829Z","steps":["trace[825367938] 'process raft request'  (duration: 115.608806ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:58:29.823145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.24051ms","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-09-03T05:58:29.823226Z","caller":"traceutil/trace.go:171","msg":"trace[1135178980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18826; }","duration":"200.369183ms","start":"2026-09-03T05:58:29.62284Z","end":"2026-09-03T05:58:29.823209Z","steps":["trace[1135178980] 'range keys from in-memory index tree'  (duration: 200.071856ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T05:58:29.82342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.253487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-03T05:58:29.823513Z","caller":"traceutil/trace.go:171","msg":"trace[1933373678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18826; }","duration":"168.37344ms","start":"2026-09-03T05:58:29.655116Z","end":"2026-09-03T05:58:29.82349Z","steps":["trace[1933373678] 'range keys from in-memory index tree'  (duration: 168.088723ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:58:29.953296Z","caller":"traceutil/trace.go:171","msg":"trace[1241708865] transaction","detail":"{read_only:false; response_revision:18827; number_of_response:1; }","duration":"116.304502ms","start":"2026-09-03T05:58:29.83697Z","end":"2026-09-03T05:58:29.953275Z","steps":["trace[1241708865] 'process raft request'  (duration: 116.163469ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:58:29.974297Z","caller":"traceutil/trace.go:171","msg":"trace[1337563435] transaction","detail":"{read_only:false; response_revision:18828; number_of_response:1; }","duration":"134.963933ms","start":"2026-09-03T05:58:29.839302Z","end":"2026-09-03T05:58:29.974266Z","steps":["trace[1337563435] 'process raft request'  (duration: 134.778589ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T05:59:17.822637Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-03T05:59:17.828773Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-03T05:59:17.828935Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-03T05:59:20.236148Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16981}
{"level":"info","ts":"2026-09-03T05:59:20.381986Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16981,"took":"142.673738ms","hash":2141759169,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":32624640,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-09-03T05:59:20.382044Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2141759169,"revision":16981,"compact-revision":14551}
{"level":"info","ts":"2026-09-03T05:59:21.33637Z","caller":"traceutil/trace.go:171","msg":"trace[659118983] linearizableReadLoop","detail":"{readStateIndex:20044; appliedIndex:20042; }","duration":"110.011278ms","start":"2026-09-03T05:59:21.226308Z","end":"2026-09-03T05:59:21.336319Z","steps":["trace[659118983] 'read index received'  (duration: 41.756863ms)","trace[659118983] 'applied index is now lower than readState.Index'  (duration: 68.253545ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T05:59:21.336433Z","caller":"traceutil/trace.go:171","msg":"trace[1583740146] transaction","detail":"{read_only:false; response_revision:19378; number_of_response:1; }","duration":"112.793922ms","start":"2026-09-03T05:59:21.223606Z","end":"2026-09-03T05:59:21.3364Z","steps":["trace[1583740146] 'process raft request'  (duration: 93.796772ms)","trace[1583740146] 'compare'  (duration: 18.772585ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T05:59:21.336493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.170923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-03T05:59:21.336529Z","caller":"traceutil/trace.go:171","msg":"trace[143558018] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:19378; }","duration":"110.222704ms","start":"2026-09-03T05:59:21.226295Z","end":"2026-09-03T05:59:21.336518Z","steps":["trace[143558018] 'agreement among raft nodes before linearized reading'  (duration: 110.145112ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:04:20.243782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19367}
{"level":"info","ts":"2026-09-03T06:04:20.364405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19367,"took":"116.607665ms","hash":752461790,"current-db-size-bytes":57139200,"current-db-size":"57 MB","current-db-size-in-use-bytes":30478336,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-03T06:04:20.364482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":752461790,"revision":19367,"compact-revision":16981}
{"level":"info","ts":"2026-09-03T06:04:43.368028Z","caller":"traceutil/trace.go:171","msg":"trace[309448816] transaction","detail":"{read_only:false; response_revision:21798; number_of_response:1; }","duration":"131.445842ms","start":"2026-09-03T06:04:43.236551Z","end":"2026-09-03T06:04:43.367997Z","steps":["trace[309448816] 'process raft request'  (duration: 131.276918ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:04:59.138337Z","caller":"traceutil/trace.go:171","msg":"trace[342972142] transaction","detail":"{read_only:false; response_revision:21878; number_of_response:1; }","duration":"206.875327ms","start":"2026-09-03T06:04:58.931385Z","end":"2026-09-03T06:04:59.138261Z","steps":["trace[342972142] 'process raft request'  (duration: 206.593381ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:04:59.45172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.090043ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743134921 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21869 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-03T06:04:59.452068Z","caller":"traceutil/trace.go:171","msg":"trace[1361949706] transaction","detail":"{read_only:false; response_revision:21879; number_of_response:1; }","duration":"462.320523ms","start":"2026-09-03T06:04:58.989702Z","end":"2026-09-03T06:04:59.452023Z","steps":["trace[1361949706] 'process raft request'  (duration: 315.812531ms)","trace[1361949706] 'compare'  (duration: 145.446899ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T06:04:59.452259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:04:58.989684Z","time spent":"462.475866ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21869 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-03T06:04:59.618482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.623148ms","expected-duration":"100ms","prefix":"","request":"header:<ID:918066257743134922 > lease_revoke:<id:0cbda065b50d3ff3>","response":"size:29"}
{"level":"info","ts":"2026-09-03T06:04:59.618632Z","caller":"traceutil/trace.go:171","msg":"trace[1153250446] linearizableReadLoop","detail":"{readStateIndex:22630; appliedIndex:22627; }","duration":"548.991512ms","start":"2026-09-03T06:04:59.069617Z","end":"2026-09-03T06:04:59.618608Z","steps":["trace[1153250446] 'read index received'  (duration: 68.388626ms)","trace[1153250446] 'applied index is now lower than readState.Index'  (duration: 480.601186ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-03T06:04:59.618904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.285919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-03T06:04:59.618962Z","caller":"traceutil/trace.go:171","msg":"trace[903093794] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21879; }","duration":"549.35168ms","start":"2026-09-03T06:04:59.069593Z","end":"2026-09-03T06:04:59.618944Z","steps":["trace[903093794] 'agreement among raft nodes before linearized reading'  (duration: 549.129586ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:04:59.619019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:04:59.069536Z","time spent":"549.470503ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-03T06:04:59.619155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.976873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-03T06:04:59.619302Z","caller":"traceutil/trace.go:171","msg":"trace[680017197] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:21879; }","duration":"335.350452ms","start":"2026-09-03T06:04:59.283903Z","end":"2026-09-03T06:04:59.619253Z","steps":["trace[680017197] 'agreement among raft nodes before linearized reading'  (duration: 334.871602ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:04:59.619387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:04:59.283868Z","time spent":"335.504416ms","remote":"127.0.0.1:37168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":45,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}
{"level":"info","ts":"2026-09-03T06:04:59.74491Z","caller":"traceutil/trace.go:171","msg":"trace[1622667090] linearizableReadLoop","detail":"{readStateIndex:22631; appliedIndex:22630; }","duration":"121.19432ms","start":"2026-09-03T06:04:59.623671Z","end":"2026-09-03T06:04:59.744866Z","steps":["trace[1622667090] 'read index received'  (duration: 120.717339ms)","trace[1622667090] 'applied index is now lower than readState.Index'  (duration: 474.831µs)"],"step_count":2}
{"level":"info","ts":"2026-09-03T06:04:59.745041Z","caller":"traceutil/trace.go:171","msg":"trace[305938492] transaction","detail":"{read_only:false; response_revision:21880; number_of_response:1; }","duration":"121.684562ms","start":"2026-09-03T06:04:59.623307Z","end":"2026-09-03T06:04:59.744992Z","steps":["trace[305938492] 'process raft request'  (duration: 121.267892ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:04:59.745188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.232624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-03T06:04:59.745182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.500807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-03T06:04:59.745238Z","caller":"traceutil/trace.go:171","msg":"trace[68467794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21880; }","duration":"107.338197ms","start":"2026-09-03T06:04:59.637888Z","end":"2026-09-03T06:04:59.745226Z","steps":["trace[68467794] 'agreement among raft nodes before linearized reading'  (duration: 107.213184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:04:59.745293Z","caller":"traceutil/trace.go:171","msg":"trace[2113065097] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21880; }","duration":"121.64358ms","start":"2026-09-03T06:04:59.623599Z","end":"2026-09-03T06:04:59.745242Z","steps":["trace[2113065097] 'agreement among raft nodes before linearized reading'  (duration: 121.412085ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:05:00.137393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.11322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-03T06:05:00.137489Z","caller":"traceutil/trace.go:171","msg":"trace[1695513110] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21880; }","duration":"252.220022ms","start":"2026-09-03T06:04:59.885246Z","end":"2026-09-03T06:05:00.137466Z","steps":["trace[1695513110] 'range keys from in-memory index tree'  (duration: 251.998678ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.319323Z","caller":"traceutil/trace.go:171","msg":"trace[1874564327] transaction","detail":"{read_only:false; response_revision:21881; number_of_response:1; }","duration":"179.373776ms","start":"2026-09-03T06:05:00.139887Z","end":"2026-09-03T06:05:00.319261Z","steps":["trace[1874564327] 'process raft request'  (duration: 179.100419ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.516674Z","caller":"traceutil/trace.go:171","msg":"trace[1955416457] transaction","detail":"{read_only:false; response_revision:21882; number_of_response:1; }","duration":"376.015791ms","start":"2026-09-03T06:05:00.140631Z","end":"2026-09-03T06:05:00.516647Z","steps":["trace[1955416457] 'process raft request'  (duration: 375.694424ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:05:00.516819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:00.140584Z","time spent":"376.165104ms","remote":"127.0.0.1:36964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5161,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/cinder-volume-usage-audit-29806925\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/openstack/cinder-volume-usage-audit-29806925\" value_size:5094 >> failure:<>"}
{"level":"info","ts":"2026-09-03T06:05:00.516928Z","caller":"traceutil/trace.go:171","msg":"trace[1765966446] linearizableReadLoop","detail":"{readStateIndex:22634; appliedIndex:22631; }","duration":"373.497754ms","start":"2026-09-03T06:05:00.143405Z","end":"2026-09-03T06:05:00.516902Z","steps":["trace[1765966446] 'read index received'  (duration: 175.555569ms)","trace[1765966446] 'applied index is now lower than readState.Index'  (duration: 197.940955ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T06:05:00.51698Z","caller":"traceutil/trace.go:171","msg":"trace[120686620] transaction","detail":"{read_only:false; response_revision:21884; number_of_response:1; }","duration":"372.277836ms","start":"2026-09-03T06:05:00.144651Z","end":"2026-09-03T06:05:00.516929Z","steps":["trace[120686620] 'process raft request'  (duration: 371.940079ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:05:00.517083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.672788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-03T06:05:00.517378Z","caller":"traceutil/trace.go:171","msg":"trace[99993469] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21884; }","duration":"373.992946ms","start":"2026-09-03T06:05:00.143348Z","end":"2026-09-03T06:05:00.517341Z","steps":["trace[99993469] 'agreement among raft nodes before linearized reading'  (duration: 373.677218ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:05:00.517476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:00.143333Z","time spent":"374.109539ms","remote":"127.0.0.1:36898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-09-03T06:05:00.517103Z","caller":"traceutil/trace.go:171","msg":"trace[1109578690] transaction","detail":"{read_only:false; response_revision:21883; number_of_response:1; }","duration":"374.606949ms","start":"2026-09-03T06:05:00.142479Z","end":"2026-09-03T06:05:00.517086Z","steps":["trace[1109578690] 'process raft request'  (duration: 374.029956ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-03T06:05:00.517293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:00.144637Z","time spent":"372.574504ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:21873 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-03T06:05:00.517706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T06:05:00.142449Z","time spent":"375.149582ms","remote":"127.0.0.1:36996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:21872 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-03T06:05:00.52194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.279565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-09-03T06:05:00.522034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.554391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-03T06:05:00.52204Z","caller":"traceutil/trace.go:171","msg":"trace[1686790331] transaction","detail":"{read_only:false; response_revision:21887; number_of_response:1; }","duration":"164.165211ms","start":"2026-09-03T06:05:00.357853Z","end":"2026-09-03T06:05:00.522018Z","steps":["trace[1686790331] 'process raft request'  (duration: 163.864745ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.521934Z","caller":"traceutil/trace.go:171","msg":"trace[752694368] transaction","detail":"{read_only:false; response_revision:21885; number_of_response:1; }","duration":"197.525726ms","start":"2026-09-03T06:05:00.324367Z","end":"2026-09-03T06:05:00.521892Z","steps":["trace[752694368] 'process raft request'  (duration: 197.143127ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.522107Z","caller":"traceutil/trace.go:171","msg":"trace[1897577652] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:21887; }","duration":"195.665954ms","start":"2026-09-03T06:05:00.326418Z","end":"2026-09-03T06:05:00.522084Z","steps":["trace[1897577652] 'agreement among raft nodes before linearized reading'  (duration: 195.562362ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.52203Z","caller":"traceutil/trace.go:171","msg":"trace[1864436881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21887; }","duration":"199.427848ms","start":"2026-09-03T06:05:00.322581Z","end":"2026-09-03T06:05:00.522009Z","steps":["trace[1864436881] 'agreement among raft nodes before linearized reading'  (duration: 199.195083ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:05:00.522569Z","caller":"traceutil/trace.go:171","msg":"trace[1225546725] transaction","detail":"{read_only:false; response_revision:21886; number_of_response:1; }","duration":"193.497925ms","start":"2026-09-03T06:05:00.328448Z","end":"2026-09-03T06:05:00.521946Z","steps":["trace[1225546725] 'process raft request'  (duration: 193.206998ms)"],"step_count":1}
{"level":"info","ts":"2026-09-03T06:09:20.251104Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21678}
{"level":"info","ts":"2026-09-03T06:09:20.364467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21678,"took":"109.585637ms","hash":721928265,"current-db-size-bytes":57511936,"current-db-size":"58 MB","current-db-size-in-use-bytes":42610688,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-09-03T06:09:20.364537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":721928265,"revision":21678,"compact-revision":19367}
{"level":"info","ts":"2026-09-03T06:10:18.367961Z","caller":"traceutil/trace.go:171","msg":"trace[736770610] transaction","detail":"{read_only:false; response_revision:25262; number_of_response:1; }","duration":"100.377619ms","start":"2026-09-03T06:10:18.267545Z","end":"2026-09-03T06:10:18.367922Z","steps":["trace[736770610] 'process raft request'  (duration: 84.277235ms)","trace[736770610] 'compare'  (duration: 15.796737ms)"],"step_count":2}
{"level":"info","ts":"2026-09-03T06:10:56.909642Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006735.wal"}
{"level":"info","ts":"2026-09-03T06:14:20.25744Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24548}
{"level":"info","ts":"2026-09-03T06:14:20.402378Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24548,"took":"140.939499ms","hash":2725334217,"current-db-size-bytes":57511936,"current-db-size":"58 MB","current-db-size-in-use-bytes":34435072,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-03T06:14:20.402453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2725334217,"revision":24548,"compact-revision":21678}
{"level":"info","ts":"2026-09-03T06:18:47.876424Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"299bf3744060cbd","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-03T06:18:47.882682Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-03T06:18:47.8829Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-09-03T06:19:20.293749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27057}
{"level":"info","ts":"2026-09-03T06:19:20.444097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27057,"took":"145.360283ms","hash":71532686,"current-db-size-bytes":57511936,"current-db-size":"58 MB","current-db-size-in-use-bytes":29556736,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-03T06:19:20.444165Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":71532686,"revision":27057,"compact-revision":24548}