{"level":"warn","ts":"2026-08-11T08:13:36.873573Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-11T08:13:36.873684Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-08-11T08:13:36.873755Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-11T08:13:36.873763Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]}
{"level":"info","ts":"2026-08-11T08:13:36.873783Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-11T08:13:36.874605Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]}
{"level":"info","ts":"2026-08-11T08:13:36.874695Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-08-11T08:13:36.877384Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.453018ms"}
{"level":"info","ts":"2026-08-11T08:13:36.881748Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"}
{"level":"info","ts":"2026-08-11T08:13:36.881842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-11T08:13:36.88187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"}
{"level":"info","ts":"2026-08-11T08:13:36.881881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-11T08:13:36.881897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"}
{"level":"info","ts":"2026-08-11T08:13:36.88195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"}
{"level":"warn","ts":"2026-08-11T08:13:36.890784Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-11T08:13:36.892326Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-11T08:13:36.893574Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-08-11T08:13:36.895839Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-11T08:13:36.896251Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-11T08:13:36.89638Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-11T08:13:36.89635Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-11T08:13:36.896403Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-11T08:13:36.897237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"}
{"level":"info","ts":"2026-08-11T08:13:36.899233Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]}
{"level":"info","ts":"2026-08-11T08:13:36.902236Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-11T08:13:36.902462Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"}
{"level":"info","ts":"2026-08-11T08:13:36.90256Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"}
{"level":"info","ts":"2026-08-11T08:13:36.902831Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-11T08:13:36.903058Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-11T08:13:37.482793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-11T08:13:37.482883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-11T08:13:37.482941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"}
{"level":"info","ts":"2026-08-11T08:13:37.482968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"}
{"level":"info","ts":"2026-08-11T08:13:37.482989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"}
{"level":"info","ts":"2026-08-11T08:13:37.48301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"}
{"level":"info","ts":"2026-08-11T08:13:37.483033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"}
{"level":"info","ts":"2026-08-11T08:13:37.484281Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-11T08:13:37.484302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-11T08:13:37.484332Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-11T08:13:37.484529Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-11T08:13:37.484597Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-11T08:13:37.484688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-11T08:13:37.485971Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-11T08:13:37.486068Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-11T08:13:37.486093Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-11T08:13:37.488276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"}
{"level":"info","ts":"2026-08-11T08:13:37.489069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-11T08:13:56.199013Z","caller":"traceutil/trace.go:171","msg":"trace[1987226929] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"104.576042ms","start":"2026-08-11T08:13:56.094419Z","end":"2026-08-11T08:13:56.198995Z","steps":["trace[1987226929] 'process raft request'  (duration: 104.455789ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:13.367204Z","caller":"traceutil/trace.go:171","msg":"trace[646668550] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"181.905071ms","start":"2026-08-11T08:14:13.185266Z","end":"2026-08-11T08:14:13.367171Z","steps":["trace[646668550] 'process raft request'  (duration: 157.932149ms)","trace[646668550] 'compare'  (duration: 23.792629ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:14:13.373948Z","caller":"traceutil/trace.go:171","msg":"trace[817507640] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"170.313798ms","start":"2026-08-11T08:14:13.203618Z","end":"2026-08-11T08:14:13.373932Z","steps":["trace[817507640] 'process raft request'  (duration: 170.137314ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:13.373936Z","caller":"traceutil/trace.go:171","msg":"trace[592846187] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:558; }","duration":"155.890129ms","start":"2026-08-11T08:14:13.21802Z","end":"2026-08-11T08:14:13.37391Z","steps":["trace[592846187] 'read index received'  (duration: 125.27388ms)","trace[592846187] 'applied index is now lower than readState.Index'  (duration: 30.615089ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:14:13.37408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.038692ms","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-08-11T08:14:13.374161Z","caller":"traceutil/trace.go:171","msg":"trace[2062861155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"156.176855ms","start":"2026-08-11T08:14:13.217973Z","end":"2026-08-11T08:14:13.37415Z","steps":["trace[2062861155] 'agreement among raft nodes before linearized reading'  (duration: 156.035732ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:20.430337Z","caller":"traceutil/trace.go:171","msg":"trace[1364474512] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"136.511797ms","start":"2026-08-11T08:14:20.293784Z","end":"2026-08-11T08:14:20.430296Z","steps":["trace[1364474512] 'process raft request'  (duration: 136.311243ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:20.746264Z","caller":"traceutil/trace.go:171","msg":"trace[255382347] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"301.398491ms","start":"2026-08-11T08:14:20.444834Z","end":"2026-08-11T08:14:20.746232Z","steps":["trace[255382347] 'read index received'  (duration: 301.166746ms)","trace[255382347] 'applied index is now lower than readState.Index'  (duration: 230.835µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:14:20.746389Z","caller":"traceutil/trace.go:171","msg":"trace[1556377769] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"309.773962ms","start":"2026-08-11T08:14:20.436575Z","end":"2026-08-11T08:14:20.746349Z","steps":["trace[1556377769] 'process raft request'  (duration: 309.503097ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:20.746477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.166947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-08-11T08:14:20.746543Z","caller":"traceutil/trace.go:171","msg":"trace[41846527] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:597; }","duration":"207.297079ms","start":"2026-08-11T08:14:20.539228Z","end":"2026-08-11T08:14:20.746525Z","steps":["trace[41846527] 'agreement among raft nodes before linearized reading'  (duration: 207.174587ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:20.746525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.672276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-11T08:14:20.746614Z","caller":"traceutil/trace.go:171","msg":"trace[1356024201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"301.789869ms","start":"2026-08-11T08:14:20.444803Z","end":"2026-08-11T08:14:20.746593Z","steps":["trace[1356024201] 'agreement among raft nodes before linearized reading'  (duration: 301.574235ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:20.74666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:14:20.444793Z","time spent":"301.85888ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-11T08:14:20.747105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:14:20.436546Z","time spent":"309.928605ms","remote":"127.0.0.1:41922","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:578 > 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-08-11T08:14:20.916815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.870545ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984639299 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:7ce09fefe25af742>","response":"size:40"}
{"level":"info","ts":"2026-08-11T08:14:20.917224Z","caller":"traceutil/trace.go:171","msg":"trace[1353272237] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"165.951854ms","start":"2026-08-11T08:14:20.751242Z","end":"2026-08-11T08:14:20.917193Z","steps":["trace[1353272237] 'process raft request'  (duration: 165.73904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:21.222808Z","caller":"traceutil/trace.go:171","msg":"trace[434675543] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"299.549085ms","start":"2026-08-11T08:14:20.923216Z","end":"2026-08-11T08:14:21.222766Z","steps":["trace[434675543] 'read index received'  (duration: 80.178163ms)","trace[434675543] 'applied index is now lower than readState.Index'  (duration: 219.368662ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:14:21.22314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.908721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-11T08:14:21.223237Z","caller":"traceutil/trace.go:171","msg":"trace[1416220032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"300.046044ms","start":"2026-08-11T08:14:20.923169Z","end":"2026-08-11T08:14:21.223215Z","steps":["trace[1416220032] 'agreement among raft nodes before linearized reading'  (duration: 299.879911ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:21.22328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:14:20.923153Z","time spent":"300.118065ms","remote":"127.0.0.1:41642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-11T08:14:21.223337Z","caller":"traceutil/trace.go:171","msg":"trace[1812576139] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"301.42135ms","start":"2026-08-11T08:14:20.921884Z","end":"2026-08-11T08:14:21.223306Z","steps":["trace[1812576139] 'process raft request'  (duration: 204.918663ms)","trace[1812576139] 'compare'  (duration: 95.679392ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:14:21.223635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:14:20.921863Z","time spent":"301.655285ms","remote":"127.0.0.1:41922","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:583 > 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":"warn","ts":"2026-08-11T08:14:21.223382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.900423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-08-11T08:14:21.223714Z","caller":"traceutil/trace.go:171","msg":"trace[1087326496] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:600; }","duration":"218.296742ms","start":"2026-08-11T08:14:21.005404Z","end":"2026-08-11T08:14:21.223701Z","steps":["trace[1087326496] 'agreement among raft nodes before linearized reading'  (duration: 217.843413ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:21.541961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.546963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-11T08:14:21.54208Z","caller":"traceutil/trace.go:171","msg":"trace[1616549896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"130.695796ms","start":"2026-08-11T08:14:21.41135Z","end":"2026-08-11T08:14:21.542046Z","steps":["trace[1616549896] 'range keys from in-memory index tree'  (duration: 130.448361ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:14:21.542232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.47878ms","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-08-11T08:14:21.542362Z","caller":"traceutil/trace.go:171","msg":"trace[29713598] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"104.657874ms","start":"2026-08-11T08:14:21.437679Z","end":"2026-08-11T08:14:21.542337Z","steps":["trace[29713598] 'range keys from in-memory index tree'  (duration: 104.217566ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:14:21.703487Z","caller":"traceutil/trace.go:171","msg":"trace[1924938478] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"156.830168ms","start":"2026-08-11T08:14:21.54663Z","end":"2026-08-11T08:14:21.70346Z","steps":["trace[1924938478] 'process raft request'  (duration: 156.643245ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:15:49.696542Z","caller":"traceutil/trace.go:171","msg":"trace[1071012031] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"110.138286ms","start":"2026-08-11T08:15:49.586375Z","end":"2026-08-11T08:15:49.696514Z","steps":["trace[1071012031] 'process raft request'  (duration: 109.978023ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:15:50.025081Z","caller":"traceutil/trace.go:171","msg":"trace[559016337] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1892; }","duration":"293.761236ms","start":"2026-08-11T08:15:49.731293Z","end":"2026-08-11T08:15:50.025055Z","steps":["trace[559016337] 'read index received'  (duration: 247.966285ms)","trace[559016337] 'applied index is now lower than readState.Index'  (duration: 45.793571ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:15:50.025204Z","caller":"traceutil/trace.go:171","msg":"trace[840749498] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"323.568409ms","start":"2026-08-11T08:15:49.701621Z","end":"2026-08-11T08:15:50.025189Z","steps":["trace[840749498] 'process raft request'  (duration: 277.621995ms)","trace[840749498] 'compare'  (duration: 45.498256ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:15:50.025303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:15:49.701594Z","time spent":"323.636891ms","remote":"127.0.0.1:41922","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:1797 > 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":"warn","ts":"2026-08-11T08:15:50.02555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.80475ms","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-08-11T08:15:50.025671Z","caller":"traceutil/trace.go:171","msg":"trace[2029628236] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1824; }","duration":"237.963024ms","start":"2026-08-11T08:15:49.787686Z","end":"2026-08-11T08:15:50.025649Z","steps":["trace[2029628236] 'agreement among raft nodes before linearized reading'  (duration: 237.7427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:15:50.025593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.285446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-926d82b3-e80b-4e23-8cf7-281053c2e866\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-08-11T08:15:50.025823Z","caller":"traceutil/trace.go:171","msg":"trace[2021213717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-926d82b3-e80b-4e23-8cf7-281053c2e866; range_end:; response_count:1; response_revision:1824; }","duration":"294.534781ms","start":"2026-08-11T08:15:49.731233Z","end":"2026-08-11T08:15:50.025768Z","steps":["trace[2021213717] 'agreement among raft nodes before linearized reading'  (duration: 294.198445ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:16:33.609557Z","caller":"traceutil/trace.go:171","msg":"trace[1806384755] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"144.71942ms","start":"2026-08-11T08:16:33.464808Z","end":"2026-08-11T08:16:33.609528Z","steps":["trace[1806384755] 'process raft request'  (duration: 144.529806ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:16:39.857966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.287732ms","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-08-11T08:16:39.858095Z","caller":"traceutil/trace.go:171","msg":"trace[614958347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2141; }","duration":"105.488946ms","start":"2026-08-11T08:16:39.752582Z","end":"2026-08-11T08:16:39.858071Z","steps":["trace[614958347] 'range keys from in-memory index tree'  (duration: 104.685759ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:16:40.086968Z","caller":"traceutil/trace.go:171","msg":"trace[60639248] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"224.547022ms","start":"2026-08-11T08:16:39.862391Z","end":"2026-08-11T08:16:40.086938Z","steps":["trace[60639248] 'process raft request'  (duration: 224.369069ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:16:40.154824Z","caller":"traceutil/trace.go:171","msg":"trace[316305500] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"292.09817ms","start":"2026-08-11T08:16:39.862697Z","end":"2026-08-11T08:16:40.154796Z","steps":["trace[316305500] 'process raft request'  (duration: 291.881395ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:16:40.15502Z","caller":"traceutil/trace.go:171","msg":"trace[2145463459] linearizableReadLoop","detail":"{readStateIndex:2224; appliedIndex:2221; }","duration":"190.825265ms","start":"2026-08-11T08:16:39.964153Z","end":"2026-08-11T08:16:40.154979Z","steps":["trace[2145463459] 'read index received'  (duration: 122.634275ms)","trace[2145463459] 'applied index is now lower than readState.Index'  (duration: 68.18723ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:16:40.155077Z","caller":"traceutil/trace.go:171","msg":"trace[1678075431] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"257.628637ms","start":"2026-08-11T08:16:39.897404Z","end":"2026-08-11T08:16:40.155033Z","steps":["trace[1678075431] 'process raft request'  (duration: 257.345421ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:16:40.155288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.09144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-11T08:16:40.155418Z","caller":"traceutil/trace.go:171","msg":"trace[904890729] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2144; }","duration":"191.302554ms","start":"2026-08-11T08:16:39.964087Z","end":"2026-08-11T08:16:40.155389Z","steps":["trace[904890729] 'agreement among raft nodes before linearized reading'  (duration: 191.059989ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:16:45.455949Z","caller":"traceutil/trace.go:171","msg":"trace[566370473] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"121.166067ms","start":"2026-08-11T08:16:45.334749Z","end":"2026-08-11T08:16:45.455915Z","steps":["trace[566370473] 'process raft request'  (duration: 120.82248ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:17:32.107568Z","caller":"traceutil/trace.go:171","msg":"trace[1393760875] transaction","detail":"{read_only:false; response_revision:2597; number_of_response:1; }","duration":"169.201409ms","start":"2026-08-11T08:17:31.938336Z","end":"2026-08-11T08:17:32.107538Z","steps":["trace[1393760875] 'process raft request'  (duration: 169.033496ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:21:55.894102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.858032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lp2jq\" ","response":"range_response_count:1 size:6441"}
{"level":"info","ts":"2026-08-11T08:21:55.894243Z","caller":"traceutil/trace.go:171","msg":"trace[918045217] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lp2jq; range_end:; response_count:1; response_revision:4764; }","duration":"105.033266ms","start":"2026-08-11T08:21:55.789184Z","end":"2026-08-11T08:21:55.894218Z","steps":["trace[918045217] 'range keys from in-memory index tree'  (duration: 104.69696ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:00.85423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.651403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"}
{"level":"info","ts":"2026-08-11T08:22:00.854296Z","caller":"traceutil/trace.go:171","msg":"trace[1342749839] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4979; }","duration":"138.768605ms","start":"2026-08-11T08:22:00.715516Z","end":"2026-08-11T08:22:00.854285Z","steps":["trace[1342749839] 'range keys from in-memory index tree'  (duration: 138.51104ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:12.852358Z","caller":"traceutil/trace.go:171","msg":"trace[1570329918] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"129.897284ms","start":"2026-08-11T08:22:12.722435Z","end":"2026-08-11T08:22:12.852332Z","steps":["trace[1570329918] 'process raft request'  (duration: 115.084899ms)","trace[1570329918] 'compare'  (duration: 14.630191ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:22:13.129813Z","caller":"traceutil/trace.go:171","msg":"trace[182786039] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"310.320022ms","start":"2026-08-11T08:22:12.819457Z","end":"2026-08-11T08:22:13.129777Z","steps":["trace[182786039] 'process raft request'  (duration: 310.026196ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:13.129822Z","caller":"traceutil/trace.go:171","msg":"trace[2073145261] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"309.71592ms","start":"2026-08-11T08:22:12.820071Z","end":"2026-08-11T08:22:13.129787Z","steps":["trace[2073145261] 'process raft request'  (duration: 309.595188ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:13.129994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:12.819388Z","time spent":"310.512445ms","remote":"127.0.0.1:41824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached-metrics\" mod_revision:5188 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" value_size:465 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" > >"}
{"level":"warn","ts":"2026-08-11T08:22:13.130033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:12.820059Z","time spent":"309.856223ms","remote":"127.0.0.1:41930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1038,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-f9ftg\" mod_revision:5153 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-f9ftg\" value_size:980 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/memcached-f9ftg\" > >"}
{"level":"info","ts":"2026-08-11T08:22:13.130116Z","caller":"traceutil/trace.go:171","msg":"trace[1692740998] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"309.870083ms","start":"2026-08-11T08:22:12.820223Z","end":"2026-08-11T08:22:13.130093Z","steps":["trace[1692740998] 'process raft request'  (duration: 309.70977ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:13.13012Z","caller":"traceutil/trace.go:171","msg":"trace[1959717402] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"309.916554ms","start":"2026-08-11T08:22:12.82016Z","end":"2026-08-11T08:22:13.130077Z","steps":["trace[1959717402] 'process raft request'  (duration: 309.569807ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:13.130293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:12.820211Z","time spent":"309.987635ms","remote":"127.0.0.1:41930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-metrics-bsfqj\" mod_revision:5189 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-metrics-bsfqj\" value_size:1001 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/memcached-metrics-bsfqj\" > >"}
{"level":"warn","ts":"2026-08-11T08:22:13.130375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:12.820126Z","time spent":"310.088467ms","remote":"127.0.0.1:41824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached\" mod_revision:5154 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached\" value_size:625 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached\" > >"}
{"level":"info","ts":"2026-08-11T08:22:21.949391Z","caller":"traceutil/trace.go:171","msg":"trace[2091135378] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"105.991906ms","start":"2026-08-11T08:22:21.843337Z","end":"2026-08-11T08:22:21.949329Z","steps":["trace[2091135378] 'process raft request'  (duration: 34.494822ms)","trace[2091135378] 'compare'  (duration: 71.251229ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:22:35.68173Z","caller":"traceutil/trace.go:171","msg":"trace[1422934815] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"315.113425ms","start":"2026-08-11T08:22:35.366593Z","end":"2026-08-11T08:22:35.681707Z","steps":["trace[1422934815] 'process raft request'  (duration: 314.941092ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:35.681889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.366568Z","time spent":"315.242477ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5525 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-11T08:22:36.147158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.951297ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984650397 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5526 > 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-08-11T08:22:36.147782Z","caller":"traceutil/trace.go:171","msg":"trace[709809372] linearizableReadLoop","detail":"{readStateIndex:5748; appliedIndex:5746; }","duration":"587.12678ms","start":"2026-08-11T08:22:35.56062Z","end":"2026-08-11T08:22:36.147747Z","steps":["trace[709809372] 'read index received'  (duration: 120.964365ms)","trace[709809372] 'applied index is now lower than readState.Index'  (duration: 466.160065ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:22:36.147805Z","caller":"traceutil/trace.go:171","msg":"trace[689539944] transaction","detail":"{read_only:false; response_revision:5547; number_of_response:1; }","duration":"652.74686ms","start":"2026-08-11T08:22:35.495005Z","end":"2026-08-11T08:22:36.147752Z","steps":["trace[689539944] 'process raft request'  (duration: 535.10438ms)","trace[689539944] 'compare'  (duration: 116.647371ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:22:36.147971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.494968Z","time spent":"652.918094ms","remote":"127.0.0.1:41922","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:5526 > 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-08-11T08:22:36.264866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.557408ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984650398 > lease_revoke:<id:7ce09fefe25b20c3>","response":"size:28"}
{"level":"info","ts":"2026-08-11T08:22:36.265128Z","caller":"traceutil/trace.go:171","msg":"trace[1883728590] linearizableReadLoop","detail":"{readStateIndex:5749; appliedIndex:5748; }","duration":"117.227342ms","start":"2026-08-11T08:22:36.147855Z","end":"2026-08-11T08:22:36.265083Z","steps":["trace[1883728590] 'read index received'  (duration: 39.011µs)","trace[1883728590] 'applied index is now lower than readState.Index'  (duration: 117.181011ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:22:36.265265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.627727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-11T08:22:36.265341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.29998ms","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-08-11T08:22:36.265438Z","caller":"traceutil/trace.go:171","msg":"trace[843117632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5548; }","duration":"248.437103ms","start":"2026-08-11T08:22:36.016981Z","end":"2026-08-11T08:22:36.265418Z","steps":["trace[843117632] 'agreement among raft nodes before linearized reading'  (duration: 248.104406ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:36.265508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.193212ms","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-08-11T08:22:36.265544Z","caller":"traceutil/trace.go:171","msg":"trace[942026263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5549; }","duration":"383.266573ms","start":"2026-08-11T08:22:35.882268Z","end":"2026-08-11T08:22:36.265535Z","steps":["trace[942026263] 'agreement among raft nodes before linearized reading'  (duration: 383.149951ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:36.265547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.976155ms","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":"warn","ts":"2026-08-11T08:22:36.265544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.586214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-11T08:22:36.26561Z","caller":"traceutil/trace.go:171","msg":"trace[212984879] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5549; }","duration":"310.113568ms","start":"2026-08-11T08:22:35.955479Z","end":"2026-08-11T08:22:36.265592Z","steps":["trace[212984879] 'agreement among raft nodes before linearized reading'  (duration: 309.816552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.265616Z","caller":"traceutil/trace.go:171","msg":"trace[1631119282] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:5549; }","duration":"326.713657ms","start":"2026-08-11T08:22:35.938888Z","end":"2026-08-11T08:22:36.265602Z","steps":["trace[1631119282] 'agreement among raft nodes before linearized reading'  (duration: 326.549074ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:22:36.265585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.882244Z","time spent":"383.333545ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-11T08:22:36.265658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.938868Z","time spent":"326.780538ms","remote":"127.0.0.1:41938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":4,"response size":30,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"info","ts":"2026-08-11T08:22:36.265368Z","caller":"traceutil/trace.go:171","msg":"trace[1949011969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5547; }","duration":"704.77364ms","start":"2026-08-11T08:22:35.560566Z","end":"2026-08-11T08:22:36.26534Z","steps":["trace[1949011969] 'agreement among raft nodes before linearized reading'  (duration: 587.293853ms)","trace[1949011969] 'range keys from in-memory index tree'  (duration: 117.12451ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:22:36.265764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.560545Z","time spent":"705.210408ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-11T08:22:36.265805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.195875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lp2jq\" ","response":"range_response_count:1 size:6441"}
{"level":"warn","ts":"2026-08-11T08:22:36.265665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:22:35.955448Z","time spent":"310.20632ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-08-11T08:22:36.265871Z","caller":"traceutil/trace.go:171","msg":"trace[1994304181] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lp2jq; range_end:; response_count:1; response_revision:5549; }","duration":"176.308387ms","start":"2026-08-11T08:22:36.089548Z","end":"2026-08-11T08:22:36.265856Z","steps":["trace[1994304181] 'agreement among raft nodes before linearized reading'  (duration: 176.161274ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.515793Z","caller":"traceutil/trace.go:171","msg":"trace[1102520764] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"245.033057ms","start":"2026-08-11T08:22:36.270736Z","end":"2026-08-11T08:22:36.515769Z","steps":["trace[1102520764] 'process raft request'  (duration: 244.813023ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.51604Z","caller":"traceutil/trace.go:171","msg":"trace[635188002] transaction","detail":"{read_only:false; response_revision:5552; number_of_response:1; }","duration":"245.248431ms","start":"2026-08-11T08:22:36.270781Z","end":"2026-08-11T08:22:36.516029Z","steps":["trace[635188002] 'process raft request'  (duration: 244.941805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.516287Z","caller":"traceutil/trace.go:171","msg":"trace[2017741542] transaction","detail":"{read_only:false; response_revision:5553; number_of_response:1; }","duration":"245.252303ms","start":"2026-08-11T08:22:36.271022Z","end":"2026-08-11T08:22:36.516274Z","steps":["trace[2017741542] 'process raft request'  (duration: 244.967926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.516436Z","caller":"traceutil/trace.go:171","msg":"trace[226282185] linearizableReadLoop","detail":"{readStateIndex:5755; appliedIndex:5751; }","duration":"245.019258ms","start":"2026-08-11T08:22:36.271383Z","end":"2026-08-11T08:22:36.516403Z","steps":["trace[226282185] 'read index received'  (duration: 6.206799ms)","trace[226282185] 'applied index is now lower than readState.Index'  (duration: 238.810579ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:22:36.51677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.348014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81727"}
{"level":"warn","ts":"2026-08-11T08:22:36.516982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.08423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-11T08:22:36.51647Z","caller":"traceutil/trace.go:171","msg":"trace[1212521487] transaction","detail":"{read_only:false; response_revision:5554; number_of_response:1; }","duration":"244.622431ms","start":"2026-08-11T08:22:36.271813Z","end":"2026-08-11T08:22:36.516435Z","steps":["trace[1212521487] 'process raft request'  (duration: 244.411357ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.517057Z","caller":"traceutil/trace.go:171","msg":"trace[1574170667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5554; }","duration":"105.264333ms","start":"2026-08-11T08:22:36.411772Z","end":"2026-08-11T08:22:36.517037Z","steps":["trace[1574170667] 'agreement among raft nodes before linearized reading'  (duration: 105.067929ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:22:36.516849Z","caller":"traceutil/trace.go:171","msg":"trace[165826122] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5554; }","duration":"245.470686ms","start":"2026-08-11T08:22:36.271365Z","end":"2026-08-11T08:22:36.516836Z","steps":["trace[165826122] 'agreement among raft nodes before linearized reading'  (duration: 245.12434ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:23:37.513963Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2978}
{"level":"info","ts":"2026-08-11T08:23:37.586467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2978,"took":"71.058396ms","hash":3193428530,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":34328576,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-11T08:23:37.586545Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3193428530,"revision":2978,"compact-revision":-1}
{"level":"info","ts":"2026-08-11T08:28:32.260149Z","caller":"traceutil/trace.go:171","msg":"trace[1515605211] transaction","detail":"{read_only:false; response_revision:8249; number_of_response:1; }","duration":"190.235895ms","start":"2026-08-11T08:28:32.069884Z","end":"2026-08-11T08:28:32.26012Z","steps":["trace[1515605211] 'process raft request'  (duration: 190.086722ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:28:37.519551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6082}
{"level":"info","ts":"2026-08-11T08:28:37.619731Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6082,"took":"98.439917ms","hash":3034160781,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":23900160,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-08-11T08:28:37.619857Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034160781,"revision":6082,"compact-revision":2978}
{"level":"info","ts":"2026-08-11T08:29:03.19096Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000220b.wal"}
{"level":"info","ts":"2026-08-11T08:29:11.832585Z","caller":"traceutil/trace.go:171","msg":"trace[1121877152] transaction","detail":"{read_only:false; response_revision:8511; number_of_response:1; }","duration":"135.943077ms","start":"2026-08-11T08:29:11.696584Z","end":"2026-08-11T08:29:11.832527Z","steps":["trace[1121877152] 'process raft request'  (duration: 135.732843ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:29:11.833438Z","caller":"traceutil/trace.go:171","msg":"trace[1383866641] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"104.379261ms","start":"2026-08-11T08:29:11.729035Z","end":"2026-08-11T08:29:11.833414Z","steps":["trace[1383866641] 'process raft request'  (duration: 103.895671ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:29:24.876892Z","caller":"traceutil/trace.go:171","msg":"trace[566202865] linearizableReadLoop","detail":"{readStateIndex:8929; appliedIndex:8928; }","duration":"100.481536ms","start":"2026-08-11T08:29:24.776387Z","end":"2026-08-11T08:29:24.876869Z","steps":["trace[566202865] 'read index received'  (duration: 100.436875ms)","trace[566202865] 'applied index is now lower than readState.Index'  (duration: 44.011µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:29:24.877132Z","caller":"traceutil/trace.go:171","msg":"trace[660857647] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"101.476045ms","start":"2026-08-11T08:29:24.775644Z","end":"2026-08-11T08:29:24.87712Z","steps":["trace[660857647] 'process raft request'  (duration: 101.104438ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:29:24.877368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.967325ms","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-08-11T08:29:24.877412Z","caller":"traceutil/trace.go:171","msg":"trace[1156375069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8625; }","duration":"101.056006ms","start":"2026-08-11T08:29:24.776346Z","end":"2026-08-11T08:29:24.877402Z","steps":["trace[1156375069] 'agreement among raft nodes before linearized reading'  (duration: 100.936833ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:29:24.883192Z","caller":"traceutil/trace.go:171","msg":"trace[981802380] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"106.682685ms","start":"2026-08-11T08:29:24.776492Z","end":"2026-08-11T08:29:24.883174Z","steps":["trace[981802380] 'process raft request'  (duration: 106.603863ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:29:25.25798Z","caller":"traceutil/trace.go:171","msg":"trace[285769127] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"133.605383ms","start":"2026-08-11T08:29:25.124323Z","end":"2026-08-11T08:29:25.257928Z","steps":["trace[285769127] 'process raft request'  (duration: 133.346558ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:30:40.388767Z","caller":"traceutil/trace.go:171","msg":"trace[1805563681] transaction","detail":"{read_only:false; response_revision:9365; number_of_response:1; }","duration":"230.442488ms","start":"2026-08-11T08:30:40.158295Z","end":"2026-08-11T08:30:40.388737Z","steps":["trace[1805563681] 'process raft request'  (duration: 230.124182ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:30:40.54632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.133538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984660609 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9357 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-11T08:30:40.546631Z","caller":"traceutil/trace.go:171","msg":"trace[39450944] linearizableReadLoop","detail":"{readStateIndex:9692; appliedIndex:9690; }","duration":"135.121052ms","start":"2026-08-11T08:30:40.411486Z","end":"2026-08-11T08:30:40.546607Z","steps":["trace[39450944] 'read index received'  (duration: 8.551015ms)","trace[39450944] 'applied index is now lower than readState.Index'  (duration: 126.568837ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:30:40.54674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.249084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-11T08:30:40.546788Z","caller":"traceutil/trace.go:171","msg":"trace[1927102797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9367; }","duration":"135.296215ms","start":"2026-08-11T08:30:40.411475Z","end":"2026-08-11T08:30:40.546771Z","steps":["trace[1927102797] 'agreement among raft nodes before linearized reading'  (duration: 135.218473ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:30:40.546799Z","caller":"traceutil/trace.go:171","msg":"trace[2049127058] transaction","detail":"{read_only:false; response_revision:9367; number_of_response:1; }","duration":"384.943572ms","start":"2026-08-11T08:30:40.161822Z","end":"2026-08-11T08:30:40.546766Z","steps":["trace[2049127058] 'process raft request'  (duration: 384.668817ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:30:40.546824Z","caller":"traceutil/trace.go:171","msg":"trace[827407896] transaction","detail":"{read_only:false; response_revision:9366; number_of_response:1; }","duration":"384.975143ms","start":"2026-08-11T08:30:40.161795Z","end":"2026-08-11T08:30:40.54677Z","steps":["trace[827407896] 'process raft request'  (duration: 258.294254ms)","trace[827407896] 'compare'  (duration: 125.863003ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:30:40.546972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:40.161802Z","time spent":"385.082004ms","remote":"127.0.0.1:41922","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:9358 > 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-08-11T08:30:40.547049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:40.161776Z","time spent":"385.155666ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9357 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-11T08:31:19.468364Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-11T08:31:19.475848Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-11T08:31:19.476077Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-11T08:33:37.527165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8276}
{"level":"info","ts":"2026-08-11T08:33:37.610685Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8276,"took":"81.087653ms","hash":2122844370,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":26333184,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-11T08:33:37.610759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2122844370,"revision":8276,"compact-revision":6082}
{"level":"info","ts":"2026-08-11T08:34:24.456984Z","caller":"traceutil/trace.go:171","msg":"trace[1920214195] transaction","detail":"{read_only:false; response_revision:11219; number_of_response:1; }","duration":"161.089685ms","start":"2026-08-11T08:34:24.295834Z","end":"2026-08-11T08:34:24.456924Z","steps":["trace[1920214195] 'process raft request'  (duration: 160.954552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:34:24.472696Z","caller":"traceutil/trace.go:171","msg":"trace[1491941377] linearizableReadLoop","detail":"{readStateIndex:11600; appliedIndex:11598; }","duration":"129.812536ms","start":"2026-08-11T08:34:24.342857Z","end":"2026-08-11T08:34:24.47267Z","steps":["trace[1491941377] 'read index received'  (duration: 114.013163ms)","trace[1491941377] 'applied index is now lower than readState.Index'  (duration: 15.797663ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:34:24.472806Z","caller":"traceutil/trace.go:171","msg":"trace[2037749814] transaction","detail":"{read_only:false; response_revision:11220; number_of_response:1; }","duration":"141.804277ms","start":"2026-08-11T08:34:24.330954Z","end":"2026-08-11T08:34:24.472758Z","steps":["trace[2037749814] 'process raft request'  (duration: 141.587302ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:34:24.472986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.192276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-11T08:34:24.474116Z","caller":"traceutil/trace.go:171","msg":"trace[1513349208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11220; }","duration":"129.353068ms","start":"2026-08-11T08:34:24.344715Z","end":"2026-08-11T08:34:24.474068Z","steps":["trace[1513349208] 'agreement among raft nodes before linearized reading'  (duration: 128.090733ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:34:24.472977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.085071ms","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-08-11T08:34:24.474428Z","caller":"traceutil/trace.go:171","msg":"trace[686252678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11220; }","duration":"131.596561ms","start":"2026-08-11T08:34:24.342805Z","end":"2026-08-11T08:34:24.474402Z","steps":["trace[686252678] 'agreement among raft nodes before linearized reading'  (duration: 129.980939ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:34:24.473246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.067744ms","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-08-11T08:34:24.474604Z","caller":"traceutil/trace.go:171","msg":"trace[1666205242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11220; }","duration":"126.405481ms","start":"2026-08-11T08:34:24.348131Z","end":"2026-08-11T08:34:24.474537Z","steps":["trace[1666205242] 'agreement among raft nodes before linearized reading'  (duration: 124.951013ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:34:24.606459Z","caller":"traceutil/trace.go:171","msg":"trace[1082222186] transaction","detail":"{read_only:false; response_revision:11223; number_of_response:1; }","duration":"127.060534ms","start":"2026-08-11T08:34:24.479371Z","end":"2026-08-11T08:34:24.606431Z","steps":["trace[1082222186] 'process raft request'  (duration: 126.975452ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:34:24.606468Z","caller":"traceutil/trace.go:171","msg":"trace[304459576] transaction","detail":"{read_only:false; response_revision:11222; number_of_response:1; }","duration":"127.118365ms","start":"2026-08-11T08:34:24.479312Z","end":"2026-08-11T08:34:24.60643Z","steps":["trace[304459576] 'process raft request'  (duration: 126.892211ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:38:37.533447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10764}
{"level":"info","ts":"2026-08-11T08:38:37.619752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10764,"took":"83.295401ms","hash":4079780600,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":28073984,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-11T08:38:37.619808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4079780600,"revision":10764,"compact-revision":8276}
{"level":"info","ts":"2026-08-11T08:40:58.792276Z","caller":"traceutil/trace.go:171","msg":"trace[1317157014] transaction","detail":"{read_only:false; response_revision:13846; number_of_response:1; }","duration":"172.609667ms","start":"2026-08-11T08:40:58.619623Z","end":"2026-08-11T08:40:58.792233Z","steps":["trace[1317157014] 'process raft request'  (duration: 149.784729ms)","trace[1317157014] 'compare'  (duration: 22.627085ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:41:07.168698Z","caller":"traceutil/trace.go:171","msg":"trace[1880624605] linearizableReadLoop","detail":"{readStateIndex:14380; appliedIndex:14379; }","duration":"117.038889ms","start":"2026-08-11T08:41:07.05164Z","end":"2026-08-11T08:41:07.168679Z","steps":["trace[1880624605] 'read index received'  (duration: 116.905417ms)","trace[1880624605] 'applied index is now lower than readState.Index'  (duration: 132.522µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:41:07.168811Z","caller":"traceutil/trace.go:171","msg":"trace[429612757] transaction","detail":"{read_only:false; response_revision:13905; number_of_response:1; }","duration":"134.067376ms","start":"2026-08-11T08:41:07.034715Z","end":"2026-08-11T08:41:07.168782Z","steps":["trace[429612757] 'process raft request'  (duration: 133.843432ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:41:07.168879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.231863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-vcq5s\" ","response":"range_response_count:1 size:11624"}
{"level":"info","ts":"2026-08-11T08:41:07.168913Z","caller":"traceutil/trace.go:171","msg":"trace[274422662] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-vcq5s; range_end:; response_count:1; response_revision:13905; }","duration":"117.281714ms","start":"2026-08-11T08:41:07.051624Z","end":"2026-08-11T08:41:07.168906Z","steps":["trace[274422662] 'agreement among raft nodes before linearized reading'  (duration: 117.150911ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:41:07.332198Z","caller":"traceutil/trace.go:171","msg":"trace[590801539] transaction","detail":"{read_only:false; response_revision:13906; number_of_response:1; }","duration":"153.200833ms","start":"2026-08-11T08:41:07.178976Z","end":"2026-08-11T08:41:07.332177Z","steps":["trace[590801539] 'process raft request'  (duration: 152.438019ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:41:16.454283Z","caller":"traceutil/trace.go:171","msg":"trace[322834056] transaction","detail":"{read_only:false; response_revision:14070; number_of_response:1; }","duration":"267.184105ms","start":"2026-08-11T08:41:16.18707Z","end":"2026-08-11T08:41:16.454254Z","steps":["trace[322834056] 'process raft request'  (duration: 266.91273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:41:16.680786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.797295ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984673379 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:13955 > 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-08-11T08:41:16.680964Z","caller":"traceutil/trace.go:171","msg":"trace[230870002] transaction","detail":"{read_only:false; response_revision:14071; number_of_response:1; }","duration":"212.461293ms","start":"2026-08-11T08:41:16.468461Z","end":"2026-08-11T08:41:16.680922Z","steps":["trace[230870002] 'process raft request'  (duration: 108.406964ms)","trace[230870002] 'compare'  (duration: 103.542979ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:41:16.721993Z","caller":"traceutil/trace.go:171","msg":"trace[286793713] linearizableReadLoop","detail":"{readStateIndex:14551; appliedIndex:14549; }","duration":"236.387092ms","start":"2026-08-11T08:41:16.485579Z","end":"2026-08-11T08:41:16.721966Z","steps":["trace[286793713] 'read index received'  (duration: 91.337145ms)","trace[286793713] 'applied index is now lower than readState.Index'  (duration: 145.048827ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:41:16.722228Z","caller":"traceutil/trace.go:171","msg":"trace[1890582945] transaction","detail":"{read_only:false; response_revision:14072; number_of_response:1; }","duration":"253.42736ms","start":"2026-08-11T08:41:16.468732Z","end":"2026-08-11T08:41:16.72216Z","steps":["trace[1890582945] 'process raft request'  (duration: 253.043443ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:41:16.722418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.80405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/data-ovn-ovsdb-nb-0.18cab399be9899db\" ","response":"range_response_count:1 size:956"}
{"level":"info","ts":"2026-08-11T08:41:16.722536Z","caller":"traceutil/trace.go:171","msg":"trace[1446913725] range","detail":"{range_begin:/registry/events/openstack/data-ovn-ovsdb-nb-0.18cab399be9899db; range_end:; response_count:1; response_revision:14072; }","duration":"236.977654ms","start":"2026-08-11T08:41:16.485527Z","end":"2026-08-11T08:41:16.722505Z","steps":["trace[1446913725] 'agreement among raft nodes before linearized reading'  (duration: 236.648137ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:41:16.723141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.750022ms","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-08-11T08:41:16.723206Z","caller":"traceutil/trace.go:171","msg":"trace[1696080557] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14073; }","duration":"156.866964ms","start":"2026-08-11T08:41:16.566321Z","end":"2026-08-11T08:41:16.723188Z","steps":["trace[1696080557] 'agreement among raft nodes before linearized reading'  (duration: 156.687301ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:41:16.723257Z","caller":"traceutil/trace.go:171","msg":"trace[1174467368] transaction","detail":"{read_only:false; response_revision:14073; number_of_response:1; }","duration":"103.229704ms","start":"2026-08-11T08:41:16.620015Z","end":"2026-08-11T08:41:16.723244Z","steps":["trace[1174467368] 'process raft request'  (duration: 102.906308ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:41:16.72356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.473708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-11T08:41:16.723585Z","caller":"traceutil/trace.go:171","msg":"trace[279312180] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:14073; }","duration":"142.52789ms","start":"2026-08-11T08:41:16.581049Z","end":"2026-08-11T08:41:16.723577Z","steps":["trace[279312180] 'agreement among raft nodes before linearized reading'  (duration: 142.463068ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:42:56.165527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.988005ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984676970 > lease_revoke:<id:7ce09fefe25b888f>","response":"size:28"}
{"level":"info","ts":"2026-08-11T08:42:56.165646Z","caller":"traceutil/trace.go:171","msg":"trace[1082842818] linearizableReadLoop","detail":"{readStateIndex:15672; appliedIndex:15671; }","duration":"142.832666ms","start":"2026-08-11T08:42:56.022793Z","end":"2026-08-11T08:42:56.165626Z","steps":["trace[1082842818] 'read index received'  (duration: 49.301µs)","trace[1082842818] 'applied index is now lower than readState.Index'  (duration: 142.781885ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:42:56.165793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.981269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-11T08:42:56.165863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.180064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-11T08:42:56.165876Z","caller":"traceutil/trace.go:171","msg":"trace[1075367635] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15163; }","duration":"143.116002ms","start":"2026-08-11T08:42:56.022739Z","end":"2026-08-11T08:42:56.165855Z","steps":["trace[1075367635] 'agreement among raft nodes before linearized reading'  (duration: 142.976009ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:42:56.165903Z","caller":"traceutil/trace.go:171","msg":"trace[260632986] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15163; }","duration":"142.243115ms","start":"2026-08-11T08:42:56.023649Z","end":"2026-08-11T08:42:56.165892Z","steps":["trace[260632986] 'agreement among raft nodes before linearized reading'  (duration: 142.098113ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:42:56.166091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.320738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-08-11T08:42:56.166148Z","caller":"traceutil/trace.go:171","msg":"trace[1338387015] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15163; }","duration":"141.427519ms","start":"2026-08-11T08:42:56.024709Z","end":"2026-08-11T08:42:56.166137Z","steps":["trace[1338387015] 'agreement among raft nodes before linearized reading'  (duration: 141.331267ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:42:57.273112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.760074ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984676988 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:15158 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-11T08:42:57.273235Z","caller":"traceutil/trace.go:171","msg":"trace[1191713761] linearizableReadLoop","detail":"{readStateIndex:15676; appliedIndex:15675; }","duration":"177.161746ms","start":"2026-08-11T08:42:57.096056Z","end":"2026-08-11T08:42:57.273217Z","steps":["trace[1191713761] 'read index received'  (duration: 19.893693ms)","trace[1191713761] 'applied index is now lower than readState.Index'  (duration: 157.266873ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:42:57.273439Z","caller":"traceutil/trace.go:171","msg":"trace[1242604347] transaction","detail":"{read_only:false; response_revision:15167; number_of_response:1; }","duration":"198.377184ms","start":"2026-08-11T08:42:57.075018Z","end":"2026-08-11T08:42:57.273395Z","steps":["trace[1242604347] 'process raft request'  (duration: 68.239502ms)","trace[1242604347] 'compare'  (duration: 129.591951ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:42:57.273676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.588414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-08-11T08:42:57.273782Z","caller":"traceutil/trace.go:171","msg":"trace[1960535250] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15167; }","duration":"177.740717ms","start":"2026-08-11T08:42:57.096019Z","end":"2026-08-11T08:42:57.27376Z","steps":["trace[1960535250] 'agreement among raft nodes before linearized reading'  (duration: 177.425031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:42:57.304341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.083315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-08-11T08:42:57.30437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.768803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lp2jq\" ","response":"range_response_count:1 size:6441"}
{"level":"info","ts":"2026-08-11T08:42:57.304437Z","caller":"traceutil/trace.go:171","msg":"trace[1744659255] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lp2jq; range_end:; response_count:1; response_revision:15168; }","duration":"184.857484ms","start":"2026-08-11T08:42:57.119563Z","end":"2026-08-11T08:42:57.30442Z","steps":["trace[1744659255] 'agreement among raft nodes before linearized reading'  (duration: 184.682261ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:42:57.304562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.949885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-fmvst\" ","response":"range_response_count:1 size:20554"}
{"level":"info","ts":"2026-08-11T08:42:57.304432Z","caller":"traceutil/trace.go:171","msg":"trace[1198824235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15168; }","duration":"190.179387ms","start":"2026-08-11T08:42:57.114231Z","end":"2026-08-11T08:42:57.30441Z","steps":["trace[1198824235] 'agreement among raft nodes before linearized reading'  (duration: 189.938493ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:42:57.304606Z","caller":"traceutil/trace.go:171","msg":"trace[1402979521] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-fmvst; range_end:; response_count:1; response_revision:15168; }","duration":"186.059287ms","start":"2026-08-11T08:42:57.118537Z","end":"2026-08-11T08:42:57.304597Z","steps":["trace[1402979521] 'agreement among raft nodes before linearized reading'  (duration: 185.925074ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:43:37.539131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12932}
{"level":"info","ts":"2026-08-11T08:43:37.612947Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12932,"took":"71.373612ms","hash":2285775327,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":30507008,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-11T08:43:37.613002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2285775327,"revision":12932,"compact-revision":10764}
{"level":"info","ts":"2026-08-11T08:44:18.951806Z","caller":"traceutil/trace.go:171","msg":"trace[561128538] transaction","detail":"{read_only:false; response_revision:15715; number_of_response:1; }","duration":"128.795626ms","start":"2026-08-11T08:44:18.822971Z","end":"2026-08-11T08:44:18.951766Z","steps":["trace[561128538] 'process raft request'  (duration: 128.555812ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:46:25.862887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.483223ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984683103 > lease_revoke:<id:7ce09fefe25ba0db>","response":"size:29"}
{"level":"info","ts":"2026-08-11T08:46:25.863038Z","caller":"traceutil/trace.go:171","msg":"trace[569986941] linearizableReadLoop","detail":"{readStateIndex:17341; appliedIndex:17340; }","duration":"108.027223ms","start":"2026-08-11T08:46:25.754991Z","end":"2026-08-11T08:46:25.863018Z","steps":["trace[569986941] 'read index received'  (duration: 52.501µs)","trace[569986941] 'applied index is now lower than readState.Index'  (duration: 107.973622ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:46:25.863207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.211588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-11T08:46:25.863235Z","caller":"traceutil/trace.go:171","msg":"trace[960605267] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16779; }","duration":"108.287958ms","start":"2026-08-11T08:46:25.754938Z","end":"2026-08-11T08:46:25.863226Z","steps":["trace[960605267] 'agreement among raft nodes before linearized reading'  (duration: 108.127775ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:48:34.548037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.335302ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984686672 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:17741 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T08:48:34.548226Z","caller":"traceutil/trace.go:171","msg":"trace[1734122523] transaction","detail":"{read_only:false; response_revision:17766; number_of_response:1; }","duration":"186.557529ms","start":"2026-08-11T08:48:34.361645Z","end":"2026-08-11T08:48:34.548202Z","steps":["trace[1734122523] 'process raft request'  (duration: 36.928392ms)","trace[1734122523] 'compare'  (duration: 149.152698ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:48:34.548645Z","caller":"traceutil/trace.go:171","msg":"trace[2060140380] linearizableReadLoop","detail":"{readStateIndex:18358; appliedIndex:18357; }","duration":"181.346219ms","start":"2026-08-11T08:48:34.367254Z","end":"2026-08-11T08:48:34.5486Z","steps":["trace[2060140380] 'read index received'  (duration: 31.232652ms)","trace[2060140380] 'applied index is now lower than readState.Index'  (duration: 150.109897ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:48:34.548857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.91492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-11T08:48:34.548858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.697442ms","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":"warn","ts":"2026-08-11T08:48:34.548874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.605434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-ovn-vpn-agent-default-xthrb\" ","response":"range_response_count:1 size:15805"}
{"level":"info","ts":"2026-08-11T08:48:34.5489Z","caller":"traceutil/trace.go:171","msg":"trace[2064438607] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17767; }","duration":"140.001101ms","start":"2026-08-11T08:48:34.408888Z","end":"2026-08-11T08:48:34.548889Z","steps":["trace[2064438607] 'agreement among raft nodes before linearized reading'  (duration: 139.91045ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:48:34.548902Z","caller":"traceutil/trace.go:171","msg":"trace[1870147164] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:17767; }","duration":"172.792905ms","start":"2026-08-11T08:48:34.376099Z","end":"2026-08-11T08:48:34.548892Z","steps":["trace[1870147164] 'agreement among raft nodes before linearized reading'  (duration: 172.666032ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:48:34.549182Z","caller":"traceutil/trace.go:171","msg":"trace[1337198625] range","detail":"{range_begin:/registry/pods/openstack/neutron-ovn-vpn-agent-default-xthrb; range_end:; response_count:1; response_revision:17767; }","duration":"181.682006ms","start":"2026-08-11T08:48:34.367231Z","end":"2026-08-11T08:48:34.548913Z","steps":["trace[1337198625] 'agreement among raft nodes before linearized reading'  (duration: 181.459872ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:48:37.54711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15438}
{"level":"info","ts":"2026-08-11T08:48:37.636201Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15438,"took":"86.502189ms","hash":1966332138,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":32354304,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T08:48:37.636249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1966332138,"revision":15438,"compact-revision":12932}
{"level":"info","ts":"2026-08-11T08:48:40.785673Z","caller":"traceutil/trace.go:171","msg":"trace[162965238] transaction","detail":"{read_only:false; response_revision:17806; number_of_response:1; }","duration":"204.836852ms","start":"2026-08-11T08:48:40.580791Z","end":"2026-08-11T08:48:40.785628Z","steps":["trace[162965238] 'process raft request'  (duration: 179.236609ms)","trace[162965238] 'compare'  (duration: 25.39269ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:48:40.880051Z","caller":"traceutil/trace.go:171","msg":"trace[103547656] linearizableReadLoop","detail":"{readStateIndex:18401; appliedIndex:18399; }","duration":"224.381149ms","start":"2026-08-11T08:48:40.655647Z","end":"2026-08-11T08:48:40.880028Z","steps":["trace[103547656] 'read index received'  (duration: 104.338063ms)","trace[103547656] 'applied index is now lower than readState.Index'  (duration: 120.042186ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:48:40.880106Z","caller":"traceutil/trace.go:171","msg":"trace[1915602767] transaction","detail":"{read_only:false; response_revision:17807; number_of_response:1; }","duration":"296.45056ms","start":"2026-08-11T08:48:40.583628Z","end":"2026-08-11T08:48:40.880079Z","steps":["trace[1915602767] 'process raft request'  (duration: 296.261276ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:48:40.880246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.590323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-11T08:48:40.880288Z","caller":"traceutil/trace.go:171","msg":"trace[2022628618] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:17807; }","duration":"224.680805ms","start":"2026-08-11T08:48:40.655596Z","end":"2026-08-11T08:48:40.880277Z","steps":["trace[2022628618] 'agreement among raft nodes before linearized reading'  (duration: 224.523552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:48:41.217986Z","caller":"traceutil/trace.go:171","msg":"trace[1813402843] linearizableReadLoop","detail":"{readStateIndex:18402; appliedIndex:18401; }","duration":"323.39487ms","start":"2026-08-11T08:48:40.894566Z","end":"2026-08-11T08:48:41.217961Z","steps":["trace[1813402843] 'read index received'  (duration: 323.247757ms)","trace[1813402843] 'applied index is now lower than readState.Index'  (duration: 145.803µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T08:48:41.218008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:48:40.881431Z","time spent":"336.567064ms","remote":"127.0.0.1:41676","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-08-11T08:48:41.218171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.584494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-11T08:48:41.218269Z","caller":"traceutil/trace.go:171","msg":"trace[2098155365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17807; }","duration":"323.704015ms","start":"2026-08-11T08:48:40.89453Z","end":"2026-08-11T08:48:41.218234Z","steps":["trace[2098155365] 'agreement among raft nodes before linearized reading'  (duration: 323.530572ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:48:41.218313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:48:40.894514Z","time spent":"323.789598ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-11T08:48:41.218368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.522164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-11T08:48:41.218448Z","caller":"traceutil/trace.go:171","msg":"trace[1648147148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17807; }","duration":"263.620096ms","start":"2026-08-11T08:48:40.954808Z","end":"2026-08-11T08:48:41.218428Z","steps":["trace[1648147148] 'agreement among raft nodes before linearized reading'  (duration: 263.358761ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:48:41.218761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.577184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-11T08:48:41.218793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.767154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-11T08:48:41.218826Z","caller":"traceutil/trace.go:171","msg":"trace[896606842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17807; }","duration":"265.688816ms","start":"2026-08-11T08:48:40.953118Z","end":"2026-08-11T08:48:41.218807Z","steps":["trace[896606842] 'agreement among raft nodes before linearized reading'  (duration: 265.501563ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:48:41.218835Z","caller":"traceutil/trace.go:171","msg":"trace[1089449591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17807; }","duration":"270.846706ms","start":"2026-08-11T08:48:40.947974Z","end":"2026-08-11T08:48:41.218821Z","steps":["trace[1089449591] 'agreement among raft nodes before linearized reading'  (duration: 270.705003ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:48:41.218837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.099661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T08:48:41.218902Z","caller":"traceutil/trace.go:171","msg":"trace[276652716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17807; }","duration":"298.221303ms","start":"2026-08-11T08:48:40.920666Z","end":"2026-08-11T08:48:41.218888Z","steps":["trace[276652716] 'agreement among raft nodes before linearized reading'  (duration: 297.457668ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:51:50.667704Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-11T08:51:50.672656Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-11T08:51:50.672823Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-11T08:53:37.554605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17788}
{"level":"info","ts":"2026-08-11T08:53:37.650944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17788,"took":"92.706393ms","hash":1017097293,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":34394112,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-11T08:53:37.651013Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1017097293,"revision":17788,"compact-revision":15438}
{"level":"info","ts":"2026-08-11T08:54:10.074848Z","caller":"traceutil/trace.go:171","msg":"trace[1227407901] transaction","detail":"{read_only:false; response_revision:20306; number_of_response:1; }","duration":"115.405189ms","start":"2026-08-11T08:54:09.959413Z","end":"2026-08-11T08:54:10.074819Z","steps":["trace[1227407901] 'process raft request'  (duration: 115.252266ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:54:10.734424Z","caller":"traceutil/trace.go:171","msg":"trace[2096612229] linearizableReadLoop","detail":"{readStateIndex:20987; appliedIndex:20986; }","duration":"112.252439ms","start":"2026-08-11T08:54:10.622144Z","end":"2026-08-11T08:54:10.734396Z","steps":["trace[2096612229] 'read index received'  (duration: 112.057195ms)","trace[2096612229] 'applied index is now lower than readState.Index'  (duration: 193.454µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:54:10.734519Z","caller":"traceutil/trace.go:171","msg":"trace[896751789] transaction","detail":"{read_only:false; response_revision:20308; number_of_response:1; }","duration":"114.430851ms","start":"2026-08-11T08:54:10.620056Z","end":"2026-08-11T08:54:10.734487Z","steps":["trace[896751789] 'process raft request'  (duration: 114.172466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:54:10.734596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.437952ms","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-08-11T08:54:10.734649Z","caller":"traceutil/trace.go:171","msg":"trace[752756669] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20308; }","duration":"112.533553ms","start":"2026-08-11T08:54:10.622105Z","end":"2026-08-11T08:54:10.734639Z","steps":["trace[752756669] 'agreement among raft nodes before linearized reading'  (duration: 112.438192ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:54:10.94345Z","caller":"traceutil/trace.go:171","msg":"trace[114356271] linearizableReadLoop","detail":"{readStateIndex:20990; appliedIndex:20989; }","duration":"147.059497ms","start":"2026-08-11T08:54:10.796371Z","end":"2026-08-11T08:54:10.94343Z","steps":["trace[114356271] 'read index received'  (duration: 139.412071ms)","trace[114356271] 'applied index is now lower than readState.Index'  (duration: 7.646416ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T08:54:10.943577Z","caller":"traceutil/trace.go:171","msg":"trace[1821288541] transaction","detail":"{read_only:false; response_revision:20310; number_of_response:1; }","duration":"147.791381ms","start":"2026-08-11T08:54:10.795757Z","end":"2026-08-11T08:54:10.943549Z","steps":["trace[1821288541] 'process raft request'  (duration: 140.114824ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:54:10.943654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.271013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-11T08:54:10.943694Z","caller":"traceutil/trace.go:171","msg":"trace[500949138] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:20310; }","duration":"147.452206ms","start":"2026-08-11T08:54:10.796232Z","end":"2026-08-11T08:54:10.943684Z","steps":["trace[500949138] 'agreement among raft nodes before linearized reading'  (duration: 147.311672ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:54:10.943768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.495803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-08-11T08:54:10.943856Z","caller":"traceutil/trace.go:171","msg":"trace[1125705514] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:20310; }","duration":"140.641446ms","start":"2026-08-11T08:54:10.803195Z","end":"2026-08-11T08:54:10.943836Z","steps":["trace[1125705514] 'agreement among raft nodes before linearized reading'  (duration: 140.37463ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:57:47.167784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.314892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T08:57:47.167928Z","caller":"traceutil/trace.go:171","msg":"trace[1123283004] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:22651; }","duration":"110.521626ms","start":"2026-08-11T08:57:47.057386Z","end":"2026-08-11T08:57:47.167908Z","steps":["trace[1123283004] 'count revisions from in-memory index tree'  (duration: 110.20337ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:57:47.196408Z","caller":"traceutil/trace.go:171","msg":"trace[98855784] transaction","detail":"{read_only:false; response_revision:22652; number_of_response:1; }","duration":"132.795123ms","start":"2026-08-11T08:57:47.063597Z","end":"2026-08-11T08:57:47.196392Z","steps":["trace[98855784] 'process raft request'  (duration: 132.60232ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T08:57:47.48693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.534326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclusters.infrastructure.cluster.x-k8s.io\" ","response":"range_response_count:1 size:87328"}
{"level":"info","ts":"2026-08-11T08:57:47.487014Z","caller":"traceutil/trace.go:171","msg":"trace[97107858] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclusters.infrastructure.cluster.x-k8s.io; range_end:; response_count:1; response_revision:22652; }","duration":"162.639788ms","start":"2026-08-11T08:57:47.324357Z","end":"2026-08-11T08:57:47.486997Z","steps":["trace[97107858] 'range keys from in-memory index tree'  (duration: 162.321352ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T08:58:37.560971Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20139}
{"level":"info","ts":"2026-08-11T08:58:37.666923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20139,"took":"103.089182ms","hash":229162038,"current-db-size-bytes":59764736,"current-db-size":"60 MB","current-db-size-in-use-bytes":42512384,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-11T08:58:37.666981Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":229162038,"revision":20139,"compact-revision":17788}
{"level":"info","ts":"2026-08-11T09:01:25.151995Z","caller":"traceutil/trace.go:171","msg":"trace[1204022269] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"137.967394ms","start":"2026-08-11T09:01:25.014002Z","end":"2026-08-11T09:01:25.151969Z","steps":["trace[1204022269] 'process raft request'  (duration: 137.349702ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:25.455748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.496489ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984705933 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24891 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:25.456097Z","caller":"traceutil/trace.go:171","msg":"trace[1681027840] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"265.247013ms","start":"2026-08-11T09:01:25.190825Z","end":"2026-08-11T09:01:25.456072Z","steps":["trace[1681027840] 'process raft request'  (duration: 131.339607ms)","trace[1681027840] 'compare'  (duration: 132.931257ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:29.699353Z","caller":"traceutil/trace.go:171","msg":"trace[930747049] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"125.394642ms","start":"2026-08-11T09:01:29.57393Z","end":"2026-08-11T09:01:29.699324Z","steps":["trace[930747049] 'process raft request'  (duration: 125.209529ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:29.968069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.942885ms","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-08-11T09:01:29.968152Z","caller":"traceutil/trace.go:171","msg":"trace[698566497] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24950; }","duration":"202.065077ms","start":"2026-08-11T09:01:29.766069Z","end":"2026-08-11T09:01:29.968134Z","steps":["trace[698566497] 'range keys from in-memory index tree'  (duration: 201.783612ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:29.968208Z","caller":"traceutil/trace.go:171","msg":"trace[1561943772] transaction","detail":"{read_only:false; response_revision:24951; number_of_response:1; }","duration":"198.843026ms","start":"2026-08-11T09:01:29.769336Z","end":"2026-08-11T09:01:29.968179Z","steps":["trace[1561943772] 'process raft request'  (duration: 108.843364ms)","trace[1561943772] 'compare'  (duration: 89.620685ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:30.293444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.812743ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706015 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24933 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:30.29396Z","caller":"traceutil/trace.go:171","msg":"trace[996201399] linearizableReadLoop","detail":"{readStateIndex:25761; appliedIndex:25760; }","duration":"322.061446ms","start":"2026-08-11T09:01:29.971871Z","end":"2026-08-11T09:01:30.293932Z","steps":["trace[996201399] 'read index received'  (duration: 198.649352ms)","trace[996201399] 'applied index is now lower than readState.Index'  (duration: 123.409804ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:30.293973Z","caller":"traceutil/trace.go:171","msg":"trace[1283768166] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"501.985537ms","start":"2026-08-11T09:01:29.791947Z","end":"2026-08-11T09:01:30.293933Z","steps":["trace[1283768166] 'process raft request'  (duration: 378.570353ms)","trace[1283768166] 'compare'  (duration: 122.63004ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:30.294137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:29.791926Z","time spent":"502.11968ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24933 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:30.294185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.461505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-11T09:01:30.294154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.405197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:30.294216Z","caller":"traceutil/trace.go:171","msg":"trace[1974846038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24954; }","duration":"307.524837ms","start":"2026-08-11T09:01:29.986682Z","end":"2026-08-11T09:01:30.294207Z","steps":["trace[1974846038] 'agreement among raft nodes before linearized reading'  (duration: 307.393864ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:30.294241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:29.986671Z","time spent":"307.563257ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-11T09:01:30.294243Z","caller":"traceutil/trace.go:171","msg":"trace[1491378120] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24954; }","duration":"198.54153ms","start":"2026-08-11T09:01:30.095683Z","end":"2026-08-11T09:01:30.294224Z","steps":["trace[1491378120] 'agreement among raft nodes before linearized reading'  (duration: 198.395487ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:30.294262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.366942ms","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-08-11T09:01:30.294392Z","caller":"traceutil/trace.go:171","msg":"trace[2039166463] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24954; }","duration":"322.523405ms","start":"2026-08-11T09:01:29.971821Z","end":"2026-08-11T09:01:30.294345Z","steps":["trace[2039166463] 'agreement among raft nodes before linearized reading'  (duration: 322.22985ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:30.294485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:29.971798Z","time spent":"322.673798ms","remote":"127.0.0.1:41840","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-08-11T09:01:31.116235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.293693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-08-11T09:01:31.116341Z","caller":"traceutil/trace.go:171","msg":"trace[762348590] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24956; }","duration":"240.445396ms","start":"2026-08-11T09:01:30.875868Z","end":"2026-08-11T09:01:31.116314Z","steps":["trace[762348590] 'range keys from in-memory index tree'  (duration: 240.123989ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:31.116357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.007282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:31.116438Z","caller":"traceutil/trace.go:171","msg":"trace[139132380] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:24956; }","duration":"195.134264ms","start":"2026-08-11T09:01:30.921286Z","end":"2026-08-11T09:01:31.11642Z","steps":["trace[139132380] 'count revisions from in-memory index tree'  (duration: 194.92319ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:31.11644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.005654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:31.1165Z","caller":"traceutil/trace.go:171","msg":"trace[1974974981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24956; }","duration":"194.065695ms","start":"2026-08-11T09:01:30.922421Z","end":"2026-08-11T09:01:31.116487Z","steps":["trace[1974974981] 'range keys from in-memory index tree'  (duration: 193.924641ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:31.337136Z","caller":"traceutil/trace.go:171","msg":"trace[2106417930] transaction","detail":"{read_only:false; response_revision:24958; number_of_response:1; }","duration":"138.794469ms","start":"2026-08-11T09:01:31.198314Z","end":"2026-08-11T09:01:31.337108Z","steps":["trace[2106417930] 'process raft request'  (duration: 138.575655ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:31.337671Z","caller":"traceutil/trace.go:171","msg":"trace[903549438] transaction","detail":"{read_only:false; response_revision:24959; number_of_response:1; }","duration":"138.129548ms","start":"2026-08-11T09:01:31.199508Z","end":"2026-08-11T09:01:31.337637Z","steps":["trace[903549438] 'process raft request'  (duration: 137.934804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:31.793999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.335961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706048 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24946 > 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:18"}
{"level":"info","ts":"2026-08-11T09:01:31.794105Z","caller":"traceutil/trace.go:171","msg":"trace[675758611] transaction","detail":"{read_only:false; response_revision:24963; number_of_response:1; }","duration":"264.709032ms","start":"2026-08-11T09:01:31.529377Z","end":"2026-08-11T09:01:31.794087Z","steps":["trace[675758611] 'process raft request'  (duration: 47.202158ms)","trace[675758611] 'compare'  (duration: 216.916663ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:32.06489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.86825ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706049 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24901 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:32.065063Z","caller":"traceutil/trace.go:171","msg":"trace[1910902069] transaction","detail":"{read_only:false; response_revision:24964; number_of_response:1; }","duration":"488.717732ms","start":"2026-08-11T09:01:31.576321Z","end":"2026-08-11T09:01:32.065038Z","steps":["trace[1910902069] 'process raft request'  (duration: 347.597057ms)","trace[1910902069] 'compare'  (duration: 140.762358ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:32.065117Z","caller":"traceutil/trace.go:171","msg":"trace[800174523] transaction","detail":"{read_only:false; response_revision:24966; number_of_response:1; }","duration":"359.72625ms","start":"2026-08-11T09:01:31.705376Z","end":"2026-08-11T09:01:32.065103Z","steps":["trace[800174523] 'process raft request'  (duration: 359.688559ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.065171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.576295Z","time spent":"488.818993ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24901 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:32.065196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.705351Z","time spent":"359.804842ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:24950 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-11T09:01:32.065305Z","caller":"traceutil/trace.go:171","msg":"trace[60762281] transaction","detail":"{read_only:false; response_revision:24965; number_of_response:1; }","duration":"360.480045ms","start":"2026-08-11T09:01:31.704815Z","end":"2026-08-11T09:01:32.065295Z","steps":["trace[60762281] 'process raft request'  (duration: 360.195979ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.06538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.704788Z","time spent":"360.548965ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24949 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-11T09:01:32.065394Z","caller":"traceutil/trace.go:171","msg":"trace[74902464] linearizableReadLoop","detail":"{readStateIndex:25774; appliedIndex:25773; }","duration":"486.323416ms","start":"2026-08-11T09:01:31.579033Z","end":"2026-08-11T09:01:32.065356Z","steps":["trace[74902464] 'read index received'  (duration: 344.872145ms)","trace[74902464] 'applied index is now lower than readState.Index'  (duration: 141.449591ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:32.065588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.52711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:32.065651Z","caller":"traceutil/trace.go:171","msg":"trace[546933846] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24966; }","duration":"486.633571ms","start":"2026-08-11T09:01:31.578998Z","end":"2026-08-11T09:01:32.065632Z","steps":["trace[546933846] 'agreement among raft nodes before linearized reading'  (duration: 486.520879ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.065701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.578987Z","time spent":"486.699923ms","remote":"127.0.0.1:47098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"info","ts":"2026-08-11T09:01:32.091347Z","caller":"traceutil/trace.go:171","msg":"trace[1972513734] transaction","detail":"{read_only:false; response_revision:24967; number_of_response:1; }","duration":"119.296435ms","start":"2026-08-11T09:01:31.972034Z","end":"2026-08-11T09:01:32.091331Z","steps":["trace[1972513734] 'process raft request'  (duration: 119.221614ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.401463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.365255ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706053 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24951 > 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-08-11T09:01:32.401558Z","caller":"traceutil/trace.go:171","msg":"trace[1884792002] linearizableReadLoop","detail":"{readStateIndex:25778; appliedIndex:25777; }","duration":"336.061226ms","start":"2026-08-11T09:01:32.065483Z","end":"2026-08-11T09:01:32.401544Z","steps":["trace[1884792002] 'read index received'  (duration: 25.839788ms)","trace[1884792002] 'applied index is now lower than readState.Index'  (duration: 310.220388ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:32.401614Z","caller":"traceutil/trace.go:171","msg":"trace[1068256669] transaction","detail":"{read_only:false; response_revision:24968; number_of_response:1; }","duration":"427.948513ms","start":"2026-08-11T09:01:31.973639Z","end":"2026-08-11T09:01:32.401588Z","steps":["trace[1068256669] 'process raft request'  (duration: 253.383265ms)","trace[1068256669] 'compare'  (duration: 174.250442ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:32.401645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.705044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:32.401676Z","caller":"traceutil/trace.go:171","msg":"trace[586073274] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24968; }","duration":"630.772975ms","start":"2026-08-11T09:01:31.770893Z","end":"2026-08-11T09:01:32.401666Z","steps":["trace[586073274] 'agreement among raft nodes before linearized reading'  (duration: 630.714084ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.40171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.770872Z","time spent":"630.829606ms","remote":"127.0.0.1:47538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-08-11T09:01:32.401734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:31.973617Z","time spent":"428.046684ms","remote":"127.0.0.1:41922","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:24951 > 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":"info","ts":"2026-08-11T09:01:32.432438Z","caller":"traceutil/trace.go:171","msg":"trace[1314434882] transaction","detail":"{read_only:false; response_revision:24969; number_of_response:1; }","duration":"133.697562ms","start":"2026-08-11T09:01:32.298717Z","end":"2026-08-11T09:01:32.432415Z","steps":["trace[1314434882] 'process raft request'  (duration: 133.557239ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.886536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.580347ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706056 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24952 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:32.886645Z","caller":"traceutil/trace.go:171","msg":"trace[1730053286] linearizableReadLoop","detail":"{readStateIndex:25780; appliedIndex:25778; }","duration":"485.045871ms","start":"2026-08-11T09:01:32.401582Z","end":"2026-08-11T09:01:32.886627Z","steps":["trace[1730053286] 'read index received'  (duration: 30.67519ms)","trace[1730053286] 'applied index is now lower than readState.Index'  (duration: 454.368831ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:32.88693Z","caller":"traceutil/trace.go:171","msg":"trace[1678441043] transaction","detail":"{read_only:false; response_revision:24970; number_of_response:1; }","duration":"587.34251ms","start":"2026-08-11T09:01:32.299568Z","end":"2026-08-11T09:01:32.88691Z","steps":["trace[1678441043] 'process raft request'  (duration: 437.280983ms)","trace[1678441043] 'compare'  (duration: 149.037047ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:32.886974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.846234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:32.887033Z","caller":"traceutil/trace.go:171","msg":"trace[286124250] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24970; }","duration":"477.933955ms","start":"2026-08-11T09:01:32.40908Z","end":"2026-08-11T09:01:32.887013Z","steps":["trace[286124250] 'agreement among raft nodes before linearized reading'  (duration: 477.835883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.887031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.299545Z","time spent":"587.436372ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24952 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:32.887031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.943327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-11T09:01:32.887079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.409067Z","time spent":"477.996626ms","remote":"127.0.0.1:41842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-08-11T09:01:32.887095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.339026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:32.887104Z","caller":"traceutil/trace.go:171","msg":"trace[250915471] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:24970; }","duration":"370.034329ms","start":"2026-08-11T09:01:32.51705Z","end":"2026-08-11T09:01:32.887085Z","steps":["trace[250915471] 'agreement among raft nodes before linearized reading'  (duration: 369.877996ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:32.887132Z","caller":"traceutil/trace.go:171","msg":"trace[364087946] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:24970; }","duration":"422.375796ms","start":"2026-08-11T09:01:32.464742Z","end":"2026-08-11T09:01:32.887118Z","steps":["trace[364087946] 'agreement among raft nodes before linearized reading'  (duration: 422.333935ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.887148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.517Z","time spent":"370.138631ms","remote":"127.0.0.1:42076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-08-11T09:01:32.887167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.464687Z","time spent":"422.473558ms","remote":"127.0.0.1:46574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true "}
{"level":"warn","ts":"2026-08-11T09:01:32.887317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.092079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-11T09:01:32.887037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.268624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-11T09:01:32.887385Z","caller":"traceutil/trace.go:171","msg":"trace[2141146817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24970; }","duration":"476.216732ms","start":"2026-08-11T09:01:32.411153Z","end":"2026-08-11T09:01:32.88737Z","steps":["trace[2141146817] 'agreement among raft nodes before linearized reading'  (duration: 476.09766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:32.887414Z","caller":"traceutil/trace.go:171","msg":"trace[580148758] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:24970; }","duration":"422.700593ms","start":"2026-08-11T09:01:32.464705Z","end":"2026-08-11T09:01:32.887406Z","steps":["trace[580148758] 'agreement among raft nodes before linearized reading'  (duration: 422.244484ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.887415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.870058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-11T09:01:32.887431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.411133Z","time spent":"476.285723ms","remote":"127.0.0.1:41642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-11T09:01:32.887457Z","caller":"traceutil/trace.go:171","msg":"trace[1141516886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24970; }","duration":"551.935718ms","start":"2026-08-11T09:01:32.3355Z","end":"2026-08-11T09:01:32.887436Z","steps":["trace[1141516886] 'agreement among raft nodes before linearized reading'  (duration: 551.817096ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:32.887486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.335478Z","time spent":"552.0016ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-11T09:01:32.887441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:32.464687Z","time spent":"422.745323ms","remote":"127.0.0.1:46586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":4,"response size":31,"request content":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true "}
{"level":"warn","ts":"2026-08-11T09:01:33.354287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.507739ms","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-08-11T09:01:33.354346Z","caller":"traceutil/trace.go:171","msg":"trace[254496303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24971; }","duration":"184.623741ms","start":"2026-08-11T09:01:33.16971Z","end":"2026-08-11T09:01:33.354334Z","steps":["trace[254496303] 'range keys from in-memory index tree'  (duration: 184.325316ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:33.680651Z","caller":"traceutil/trace.go:171","msg":"trace[1684105829] transaction","detail":"{read_only:false; response_revision:24973; number_of_response:1; }","duration":"336.748678ms","start":"2026-08-11T09:01:33.343874Z","end":"2026-08-11T09:01:33.680623Z","steps":["trace[1684105829] 'process raft request'  (duration: 239.761082ms)","trace[1684105829] 'compare'  (duration: 96.698631ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:33.680811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.34386Z","time spent":"336.878071ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24959 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-11T09:01:33.681233Z","caller":"traceutil/trace.go:171","msg":"trace[755813234] transaction","detail":"{read_only:false; response_revision:24974; number_of_response:1; }","duration":"322.546396ms","start":"2026-08-11T09:01:33.358259Z","end":"2026-08-11T09:01:33.680805Z","steps":["trace[755813234] 'process raft request'  (duration: 322.27163ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:33.681412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.358235Z","time spent":"323.098896ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24957 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:34.189795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.705619ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706068 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24960 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:34.190013Z","caller":"traceutil/trace.go:171","msg":"trace[664902827] linearizableReadLoop","detail":"{readStateIndex:25785; appliedIndex:25782; }","duration":"649.888173ms","start":"2026-08-11T09:01:33.540107Z","end":"2026-08-11T09:01:34.189995Z","steps":["trace[664902827] 'read index received'  (duration: 43.583248ms)","trace[664902827] 'applied index is now lower than readState.Index'  (duration: 606.303555ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:34.189998Z","caller":"traceutil/trace.go:171","msg":"trace[1467429269] transaction","detail":"{read_only:false; response_revision:24975; number_of_response:1; }","duration":"660.488307ms","start":"2026-08-11T09:01:33.529463Z","end":"2026-08-11T09:01:34.189951Z","steps":["trace[1467429269] 'process raft request'  (duration: 298.525193ms)","trace[1467429269] 'compare'  (duration: 360.937894ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:34.190088Z","caller":"traceutil/trace.go:171","msg":"trace[1839219641] transaction","detail":"{read_only:false; response_revision:24977; number_of_response:1; }","duration":"119.333396ms","start":"2026-08-11T09:01:34.070737Z","end":"2026-08-11T09:01:34.190071Z","steps":["trace[1839219641] 'process raft request'  (duration: 119.256885ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.190156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.529441Z","time spent":"660.63407ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24960 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-08-11T09:01:34.190224Z","caller":"traceutil/trace.go:171","msg":"trace[1512072314] transaction","detail":"{read_only:false; response_revision:24976; number_of_response:1; }","duration":"359.461885ms","start":"2026-08-11T09:01:33.83075Z","end":"2026-08-11T09:01:34.190212Z","steps":["trace[1512072314] 'process raft request'  (duration: 359.155809ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.190289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.830715Z","time spent":"359.535387ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24936 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:519 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:34.190381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.347623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-08-11T09:01:34.190405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.165463ms","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-08-11T09:01:34.190376Z","caller":"traceutil/trace.go:171","msg":"trace[1523564429] transaction","detail":"{read_only:false; response_revision:24978; number_of_response:1; }","duration":"119.55257ms","start":"2026-08-11T09:01:34.070768Z","end":"2026-08-11T09:01:34.190321Z","steps":["trace[1523564429] 'process raft request'  (duration: 119.267535ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:34.19045Z","caller":"traceutil/trace.go:171","msg":"trace[297223012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24978; }","duration":"393.235325ms","start":"2026-08-11T09:01:33.797202Z","end":"2026-08-11T09:01:34.190437Z","steps":["trace[297223012] 'agreement among raft nodes before linearized reading'  (duration: 393.079562ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:34.19045Z","caller":"traceutil/trace.go:171","msg":"trace[1257207828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24978; }","duration":"649.442725ms","start":"2026-08-11T09:01:33.54099Z","end":"2026-08-11T09:01:34.190433Z","steps":["trace[1257207828] 'agreement among raft nodes before linearized reading'  (duration: 649.267262ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.190481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.797186Z","time spent":"393.288396ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-11T09:01:34.190487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.540978Z","time spent":"649.501526ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-11T09:01:34.190445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.311401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-11T09:01:34.190554Z","caller":"traceutil/trace.go:171","msg":"trace[622271198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24978; }","duration":"650.472624ms","start":"2026-08-11T09:01:33.540055Z","end":"2026-08-11T09:01:34.190528Z","steps":["trace[622271198] 'agreement among raft nodes before linearized reading'  (duration: 650.040576ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.190622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:33.540033Z","time spent":"650.577356ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-11T09:01:34.917034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221739944984706073,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-11T09:01:34.937027Z","caller":"traceutil/trace.go:171","msg":"trace[1516590728] transaction","detail":"{read_only:false; response_revision:24981; number_of_response:1; }","duration":"741.348351ms","start":"2026-08-11T09:01:34.195657Z","end":"2026-08-11T09:01:34.937005Z","steps":["trace[1516590728] 'process raft request'  (duration: 741.312491ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:34.937059Z","caller":"traceutil/trace.go:171","msg":"trace[1415238611] transaction","detail":"{read_only:false; response_revision:24980; number_of_response:1; }","duration":"741.573176ms","start":"2026-08-11T09:01:34.195453Z","end":"2026-08-11T09:01:34.937026Z","steps":["trace[1415238611] 'process raft request'  (duration: 741.401572ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.937135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.195635Z","time spent":"741.440104ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24962 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:34.937196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.195427Z","time spent":"741.694379ms","remote":"127.0.0.1:41922","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:24961 > 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":"info","ts":"2026-08-11T09:01:34.96625Z","caller":"traceutil/trace.go:171","msg":"trace[1909425536] transaction","detail":"{read_only:false; response_revision:24982; number_of_response:1; }","duration":"549.251777ms","start":"2026-08-11T09:01:34.416967Z","end":"2026-08-11T09:01:34.966219Z","steps":["trace[1909425536] 'process raft request'  (duration: 548.984192ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.966429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.416906Z","time spent":"549.43684ms","remote":"127.0.0.1:41922","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:24968 > 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":"info","ts":"2026-08-11T09:01:34.966505Z","caller":"traceutil/trace.go:171","msg":"trace[394908487] transaction","detail":"{read_only:false; response_revision:24983; number_of_response:1; }","duration":"529.490246ms","start":"2026-08-11T09:01:34.436998Z","end":"2026-08-11T09:01:34.966488Z","steps":["trace[394908487] 'process raft request'  (duration: 529.15951ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.966598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.43697Z","time spent":"529.583428ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24969 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-11T09:01:34.966739Z","caller":"traceutil/trace.go:171","msg":"trace[1719490011] linearizableReadLoop","detail":"{readStateIndex:25794; appliedIndex:25790; }","duration":"549.838748ms","start":"2026-08-11T09:01:34.416884Z","end":"2026-08-11T09:01:34.966722Z","steps":["trace[1719490011] 'read index received'  (duration: 520.090905ms)","trace[1719490011] 'applied index is now lower than readState.Index'  (duration: 29.746803ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:34.966844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.964831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:34.966882Z","caller":"traceutil/trace.go:171","msg":"trace[1046218876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24984; }","duration":"550.029591ms","start":"2026-08-11T09:01:34.416838Z","end":"2026-08-11T09:01:34.966867Z","steps":["trace[1046218876] 'agreement among raft nodes before linearized reading'  (duration: 549.96874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.966916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.416818Z","time spent":"550.088303ms","remote":"127.0.0.1:41642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-11T09:01:34.966939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.429322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:34.967038Z","caller":"traceutil/trace.go:171","msg":"trace[1552110154] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:24984; }","duration":"494.547074ms","start":"2026-08-11T09:01:34.472469Z","end":"2026-08-11T09:01:34.967016Z","steps":["trace[1552110154] 'agreement among raft nodes before linearized reading'  (duration: 494.371361ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:34.967087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:34.472456Z","time spent":"494.620055ms","remote":"127.0.0.1:50678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "}
{"level":"info","ts":"2026-08-11T09:01:35.16657Z","caller":"traceutil/trace.go:171","msg":"trace[1045527542] transaction","detail":"{read_only:false; response_revision:24985; number_of_response:1; }","duration":"195.387618ms","start":"2026-08-11T09:01:34.971162Z","end":"2026-08-11T09:01:35.166549Z","steps":["trace[1045527542] 'process raft request'  (duration: 195.258365ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:36.076949Z","caller":"traceutil/trace.go:171","msg":"trace[1374039914] linearizableReadLoop","detail":"{readStateIndex:25799; appliedIndex:25798; }","duration":"100.952062ms","start":"2026-08-11T09:01:35.975965Z","end":"2026-08-11T09:01:36.076917Z","steps":["trace[1374039914] 'read index received'  (duration: 40.986679ms)","trace[1374039914] 'applied index is now lower than readState.Index'  (duration: 59.963383ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:36.077072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.083785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:36.077103Z","caller":"traceutil/trace.go:171","msg":"trace[620093524] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:24989; }","duration":"101.168766ms","start":"2026-08-11T09:01:35.975925Z","end":"2026-08-11T09:01:36.077094Z","steps":["trace[620093524] 'agreement among raft nodes before linearized reading'  (duration: 101.082245ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:36.545369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.291638ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706106 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24979 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:36.54555Z","caller":"traceutil/trace.go:171","msg":"trace[1936971013] linearizableReadLoop","detail":"{readStateIndex:25804; appliedIndex:25803; }","duration":"133.54284ms","start":"2026-08-11T09:01:36.411962Z","end":"2026-08-11T09:01:36.545504Z","steps":["trace[1936971013] 'read index received'  (duration: 54.421µs)","trace[1936971013] 'applied index is now lower than readState.Index'  (duration: 133.486719ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:36.545549Z","caller":"traceutil/trace.go:171","msg":"trace[144828677] transaction","detail":"{read_only:false; response_revision:24993; number_of_response:1; }","duration":"285.171637ms","start":"2026-08-11T09:01:36.260334Z","end":"2026-08-11T09:01:36.545505Z","steps":["trace[144828677] 'process raft request'  (duration: 131.580782ms)","trace[144828677] 'compare'  (duration: 152.914301ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:36.54566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.690492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:01:36.545713Z","caller":"traceutil/trace.go:171","msg":"trace[784273717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24993; }","duration":"133.771893ms","start":"2026-08-11T09:01:36.411925Z","end":"2026-08-11T09:01:36.545697Z","steps":["trace[784273717] 'agreement among raft nodes before linearized reading'  (duration: 133.674982ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:37.26853Z","caller":"traceutil/trace.go:171","msg":"trace[2063262626] transaction","detail":"{read_only:false; response_revision:24995; number_of_response:1; }","duration":"323.955873ms","start":"2026-08-11T09:01:36.944542Z","end":"2026-08-11T09:01:37.268498Z","steps":["trace[2063262626] 'process raft request'  (duration: 323.732799ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:37.268555Z","caller":"traceutil/trace.go:171","msg":"trace[754838503] linearizableReadLoop","detail":"{readStateIndex:25809; appliedIndex:25805; }","duration":"184.204044ms","start":"2026-08-11T09:01:37.084335Z","end":"2026-08-11T09:01:37.268539Z","steps":["trace[754838503] 'read index received'  (duration: 183.892038ms)","trace[754838503] 'applied index is now lower than readState.Index'  (duration: 311.376µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:37.268584Z","caller":"traceutil/trace.go:171","msg":"trace[1232890554] transaction","detail":"{read_only:false; response_revision:24996; number_of_response:1; }","duration":"296.7911ms","start":"2026-08-11T09:01:36.971758Z","end":"2026-08-11T09:01:37.268549Z","steps":["trace[1232890554] 'process raft request'  (duration: 296.698818ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:37.268672Z","caller":"traceutil/trace.go:171","msg":"trace[1668657702] transaction","detail":"{read_only:false; response_revision:24997; number_of_response:1; }","duration":"296.847451ms","start":"2026-08-11T09:01:36.971817Z","end":"2026-08-11T09:01:37.268664Z","steps":["trace[1668657702] 'process raft request'  (duration: 296.669198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:37.268686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:36.944529Z","time spent":"324.075485ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24981 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-11T09:01:37.268772Z","caller":"traceutil/trace.go:171","msg":"trace[1844249295] transaction","detail":"{read_only:false; response_revision:24998; number_of_response:1; }","duration":"295.142759ms","start":"2026-08-11T09:01:36.973625Z","end":"2026-08-11T09:01:37.268767Z","steps":["trace[1844249295] 'process raft request'  (duration: 294.879144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:37.268901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.56108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-11T09:01:37.268966Z","caller":"traceutil/trace.go:171","msg":"trace[1935350233] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:24998; }","duration":"184.603761ms","start":"2026-08-11T09:01:37.084329Z","end":"2026-08-11T09:01:37.268932Z","steps":["trace[1935350233] 'agreement among raft nodes before linearized reading'  (duration: 184.495669ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:37.384254Z","caller":"traceutil/trace.go:171","msg":"trace[1165250222] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"111.041947ms","start":"2026-08-11T09:01:37.273193Z","end":"2026-08-11T09:01:37.384235Z","steps":["trace[1165250222] 'process raft request'  (duration: 110.273912ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:37.747032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.483746ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706119 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24986 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:37.747139Z","caller":"traceutil/trace.go:171","msg":"trace[744962585] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"263.615242ms","start":"2026-08-11T09:01:37.4835Z","end":"2026-08-11T09:01:37.747116Z","steps":["trace[744962585] 'process raft request'  (duration: 114.982932ms)","trace[744962585] 'compare'  (duration: 148.359634ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:38.150638Z","caller":"traceutil/trace.go:171","msg":"trace[1502005806] linearizableReadLoop","detail":"{readStateIndex:25812; appliedIndex:25811; }","duration":"312.612465ms","start":"2026-08-11T09:01:37.838003Z","end":"2026-08-11T09:01:38.150616Z","steps":["trace[1502005806] 'read index received'  (duration: 312.432592ms)","trace[1502005806] 'applied index is now lower than readState.Index'  (duration: 178.973µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:38.150949Z","caller":"traceutil/trace.go:171","msg":"trace[1991091442] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"371.118051ms","start":"2026-08-11T09:01:37.779799Z","end":"2026-08-11T09:01:38.150917Z","steps":["trace[1991091442] 'process raft request'  (duration: 370.686072ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:38.151093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:37.779784Z","time spent":"371.233463ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24987 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:38.151129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.110324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-11T09:01:38.151182Z","caller":"traceutil/trace.go:171","msg":"trace[273543480] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25001; }","duration":"313.197645ms","start":"2026-08-11T09:01:37.837971Z","end":"2026-08-11T09:01:38.151169Z","steps":["trace[273543480] 'agreement among raft nodes before linearized reading'  (duration: 312.940851ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:38.151221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:37.837957Z","time spent":"313.256487ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-11T09:01:38.507334Z","caller":"traceutil/trace.go:171","msg":"trace[1607658350] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"263.433888ms","start":"2026-08-11T09:01:38.243881Z","end":"2026-08-11T09:01:38.507314Z","steps":["trace[1607658350] 'process raft request'  (duration: 199.139921ms)","trace[1607658350] 'compare'  (duration: 64.037422ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:38.507462Z","caller":"traceutil/trace.go:171","msg":"trace[371886645] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"244.976903ms","start":"2026-08-11T09:01:38.262477Z","end":"2026-08-11T09:01:38.507454Z","steps":["trace[371886645] 'process raft request'  (duration: 244.795479ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:38.507591Z","caller":"traceutil/trace.go:171","msg":"trace[1936584358] linearizableReadLoop","detail":"{readStateIndex:25816; appliedIndex:25813; }","duration":"242.315012ms","start":"2026-08-11T09:01:38.265266Z","end":"2026-08-11T09:01:38.507581Z","steps":["trace[1936584358] 'read index received'  (duration: 177.73388ms)","trace[1936584358] 'applied index is now lower than readState.Index'  (duration: 64.580442ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:38.507616Z","caller":"traceutil/trace.go:171","msg":"trace[1390482402] transaction","detail":"{read_only:false; response_revision:25005; number_of_response:1; }","duration":"245.025893ms","start":"2026-08-11T09:01:38.262583Z","end":"2026-08-11T09:01:38.507609Z","steps":["trace[1390482402] 'process raft request'  (duration: 244.83889ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:38.507709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.435055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-11T09:01:38.507744Z","caller":"traceutil/trace.go:171","msg":"trace[1059030265] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25005; }","duration":"242.480066ms","start":"2026-08-11T09:01:38.265253Z","end":"2026-08-11T09:01:38.507733Z","steps":["trace[1059030265] 'agreement among raft nodes before linearized reading'  (duration: 242.387264ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:38.739414Z","caller":"traceutil/trace.go:171","msg":"trace[1117988149] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"185.109971ms","start":"2026-08-11T09:01:38.554272Z","end":"2026-08-11T09:01:38.739382Z","steps":["trace[1117988149] 'process raft request'  (duration: 184.965428ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:41.722758Z","caller":"traceutil/trace.go:171","msg":"trace[1800806191] linearizableReadLoop","detail":"{readStateIndex:25840; appliedIndex:25839; }","duration":"164.562986ms","start":"2026-08-11T09:01:41.558163Z","end":"2026-08-11T09:01:41.722726Z","steps":["trace[1800806191] 'read index received'  (duration: 164.310821ms)","trace[1800806191] 'applied index is now lower than readState.Index'  (duration: 250.775µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:41.722883Z","caller":"traceutil/trace.go:171","msg":"trace[1438097607] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"307.476965ms","start":"2026-08-11T09:01:41.415375Z","end":"2026-08-11T09:01:41.722852Z","steps":["trace[1438097607] 'process raft request'  (duration: 307.155029ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:41.723036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.858221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"warn","ts":"2026-08-11T09:01:41.72306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:41.415358Z","time spent":"307.612959ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25013 > 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-08-11T09:01:41.723091Z","caller":"traceutil/trace.go:171","msg":"trace[1155615907] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25028; }","duration":"164.960704ms","start":"2026-08-11T09:01:41.558118Z","end":"2026-08-11T09:01:41.723079Z","steps":["trace[1155615907] 'agreement among raft nodes before linearized reading'  (duration: 164.75947ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:41.950783Z","caller":"traceutil/trace.go:171","msg":"trace[949435681] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"192.273039ms","start":"2026-08-11T09:01:41.758472Z","end":"2026-08-11T09:01:41.950745Z","steps":["trace[949435681] 'process raft request'  (duration: 191.481904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:42.352144Z","caller":"traceutil/trace.go:171","msg":"trace[694864143] linearizableReadLoop","detail":"{readStateIndex:25842; appliedIndex:25841; }","duration":"126.83262ms","start":"2026-08-11T09:01:42.225293Z","end":"2026-08-11T09:01:42.352125Z","steps":["trace[694864143] 'read index received'  (duration: 98.75489ms)","trace[694864143] 'applied index is now lower than readState.Index'  (duration: 28.07686ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:42.35244Z","caller":"traceutil/trace.go:171","msg":"trace[1561470125] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"188.414134ms","start":"2026-08-11T09:01:42.163987Z","end":"2026-08-11T09:01:42.352401Z","steps":["trace[1561470125] 'process raft request'  (duration: 160.10568ms)","trace[1561470125] 'compare'  (duration: 27.347326ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:42.352579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.281189ms","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-08-11T09:01:42.352641Z","caller":"traceutil/trace.go:171","msg":"trace[108185188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25030; }","duration":"127.421663ms","start":"2026-08-11T09:01:42.225205Z","end":"2026-08-11T09:01:42.352627Z","steps":["trace[108185188] 'agreement among raft nodes before linearized reading'  (duration: 127.228408ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:49.070803Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000652c.wal"}
{"level":"info","ts":"2026-08-11T09:01:50.48028Z","caller":"traceutil/trace.go:171","msg":"trace[625169792] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"101.957452ms","start":"2026-08-11T09:01:50.378292Z","end":"2026-08-11T09:01:50.480249Z","steps":["trace[625169792] 'process raft request'  (duration: 101.643296ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:50.619608Z","caller":"traceutil/trace.go:171","msg":"trace[1479357657] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"134.466517ms","start":"2026-08-11T09:01:50.485123Z","end":"2026-08-11T09:01:50.619589Z","steps":["trace[1479357657] 'process raft request'  (duration: 129.44048ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:50.927388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.338403ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706506 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25077 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-11T09:01:50.927589Z","caller":"traceutil/trace.go:171","msg":"trace[417409131] linearizableReadLoop","detail":"{readStateIndex:25965; appliedIndex:25961; }","duration":"354.520291ms","start":"2026-08-11T09:01:50.573049Z","end":"2026-08-11T09:01:50.92757Z","steps":["trace[417409131] 'read index received'  (duration: 41.527749ms)","trace[417409131] 'applied index is now lower than readState.Index'  (duration: 312.991742ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:50.927596Z","caller":"traceutil/trace.go:171","msg":"trace[1437375441] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"377.406971ms","start":"2026-08-11T09:01:50.550145Z","end":"2026-08-11T09:01:50.927552Z","steps":["trace[1437375441] 'process raft request'  (duration: 215.822222ms)","trace[1437375441] 'compare'  (duration: 161.219151ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:50.927699Z","caller":"traceutil/trace.go:171","msg":"trace[753861743] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"373.849783ms","start":"2026-08-11T09:01:50.553825Z","end":"2026-08-11T09:01:50.927675Z","steps":["trace[753861743] 'process raft request'  (duration: 373.70783ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:50.927736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:50.550127Z","time spent":"377.530654ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25077 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:50.927801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.744605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4328502e-a38c-4a7b-89a3-4c3d694e678b\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-08-11T09:01:50.927848Z","caller":"traceutil/trace.go:171","msg":"trace[1990224388] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4328502e-a38c-4a7b-89a3-4c3d694e678b; range_end:; response_count:1; response_revision:25151; }","duration":"354.830647ms","start":"2026-08-11T09:01:50.573005Z","end":"2026-08-11T09:01:50.927836Z","steps":["trace[1990224388] 'agreement among raft nodes before linearized reading'  (duration: 354.663804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:50.927884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:50.572989Z","time spent":"354.886468ms","remote":"127.0.0.1:41840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3666,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4328502e-a38c-4a7b-89a3-4c3d694e678b\" "}
{"level":"info","ts":"2026-08-11T09:01:50.927962Z","caller":"traceutil/trace.go:171","msg":"trace[1128100623] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"375.881641ms","start":"2026-08-11T09:01:50.552071Z","end":"2026-08-11T09:01:50.927953Z","steps":["trace[1128100623] 'process raft request'  (duration: 375.405992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:50.928041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:50.552064Z","time spent":"375.947582ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25078 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:50.927812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:50.553813Z","time spent":"373.946535ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25079 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-11T09:01:50.928205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.42632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-11T09:01:50.928256Z","caller":"traceutil/trace.go:171","msg":"trace[360348392] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:25151; }","duration":"234.508142ms","start":"2026-08-11T09:01:50.693735Z","end":"2026-08-11T09:01:50.928243Z","steps":["trace[360348392] 'agreement among raft nodes before linearized reading'  (duration: 234.38561ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:50.928402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.598609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-11T09:01:50.928875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.169023ms","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-08-11T09:01:50.928967Z","caller":"traceutil/trace.go:171","msg":"trace[1216515071] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25151; }","duration":"171.255195ms","start":"2026-08-11T09:01:50.757663Z","end":"2026-08-11T09:01:50.928918Z","steps":["trace[1216515071] 'agreement among raft nodes before linearized reading'  (duration: 170.455059ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:50.928463Z","caller":"traceutil/trace.go:171","msg":"trace[572335828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25151; }","duration":"135.700211ms","start":"2026-08-11T09:01:50.792748Z","end":"2026-08-11T09:01:50.928448Z","steps":["trace[572335828] 'agreement among raft nodes before linearized reading'  (duration: 135.367544ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.194463Z","caller":"traceutil/trace.go:171","msg":"trace[198250108] linearizableReadLoop","detail":"{readStateIndex:25967; appliedIndex:25966; }","duration":"261.777237ms","start":"2026-08-11T09:01:50.932662Z","end":"2026-08-11T09:01:51.19444Z","steps":["trace[198250108] 'read index received'  (duration: 14.460389ms)","trace[198250108] 'applied index is now lower than readState.Index'  (duration: 247.316058ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:51.194484Z","caller":"traceutil/trace.go:171","msg":"trace[1827116252] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"261.984431ms","start":"2026-08-11T09:01:50.932466Z","end":"2026-08-11T09:01:51.19445Z","steps":["trace[1827116252] 'process raft request'  (duration: 261.722816ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.194749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.067132ms","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-08-11T09:01:51.194815Z","caller":"traceutil/trace.go:171","msg":"trace[685658582] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25153; }","duration":"262.179135ms","start":"2026-08-11T09:01:50.932625Z","end":"2026-08-11T09:01:51.194804Z","steps":["trace[685658582] 'agreement among raft nodes before linearized reading'  (duration: 261.91798ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.194929Z","caller":"traceutil/trace.go:171","msg":"trace[865647072] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"246.991841ms","start":"2026-08-11T09:01:50.947898Z","end":"2026-08-11T09:01:51.19489Z","steps":["trace[865647072] 'process raft request'  (duration: 246.844319ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.194996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.919144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6579d44445-w6p89.18cab2e585be0677\" ","response":"range_response_count:1 size:1137"}
{"level":"info","ts":"2026-08-11T09:01:51.195047Z","caller":"traceutil/trace.go:171","msg":"trace[951169309] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6579d44445-w6p89.18cab2e585be0677; range_end:; response_count:1; response_revision:25154; }","duration":"124.013975ms","start":"2026-08-11T09:01:51.071019Z","end":"2026-08-11T09:01:51.195033Z","steps":["trace[951169309] 'agreement among raft nodes before linearized reading'  (duration: 123.831752ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.195269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.452232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-11T09:01:51.195329Z","caller":"traceutil/trace.go:171","msg":"trace[2055679277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25154; }","duration":"114.542963ms","start":"2026-08-11T09:01:51.080771Z","end":"2026-08-11T09:01:51.195314Z","steps":["trace[2055679277] 'agreement among raft nodes before linearized reading'  (duration: 114.34945ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.195981Z","caller":"traceutil/trace.go:171","msg":"trace[345326751] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"258.710958ms","start":"2026-08-11T09:01:50.935778Z","end":"2026-08-11T09:01:51.194489Z","steps":["trace[345326751] 'process raft request'  (duration: 258.543515ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.472845Z","caller":"traceutil/trace.go:171","msg":"trace[1283272782] linearizableReadLoop","detail":"{readStateIndex:25970; appliedIndex:25969; }","duration":"273.350008ms","start":"2026-08-11T09:01:51.199465Z","end":"2026-08-11T09:01:51.472815Z","steps":["trace[1283272782] 'read index received'  (duration: 231.395321ms)","trace[1283272782] 'applied index is now lower than readState.Index'  (duration: 41.953227ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:51.47292Z","caller":"traceutil/trace.go:171","msg":"trace[328338784] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"274.519742ms","start":"2026-08-11T09:01:51.19836Z","end":"2026-08-11T09:01:51.47288Z","steps":["trace[328338784] 'process raft request'  (duration: 232.488313ms)","trace[328338784] 'compare'  (duration: 41.658642ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:51.473123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.631544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-11T09:01:51.473174Z","caller":"traceutil/trace.go:171","msg":"trace[524675658] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:25155; }","duration":"273.715565ms","start":"2026-08-11T09:01:51.199444Z","end":"2026-08-11T09:01:51.47316Z","steps":["trace[524675658] 'agreement among raft nodes before linearized reading'  (duration: 273.525411ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.499721Z","caller":"traceutil/trace.go:171","msg":"trace[593909530] transaction","detail":"{read_only:false; response_revision:25157; number_of_response:1; }","duration":"191.324841ms","start":"2026-08-11T09:01:51.30838Z","end":"2026-08-11T09:01:51.499705Z","steps":["trace[593909530] 'process raft request'  (duration: 191.219599ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.499746Z","caller":"traceutil/trace.go:171","msg":"trace[1237313210] transaction","detail":"{read_only:false; response_revision:25156; number_of_response:1; }","duration":"298.461812ms","start":"2026-08-11T09:01:51.201255Z","end":"2026-08-11T09:01:51.499716Z","steps":["trace[1237313210] 'process raft request'  (duration: 298.234688ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.500135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.365091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-11T09:01:51.5002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.25116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4328502e-a38c-4a7b-89a3-4c3d694e678b\" ","response":"range_response_count:1 size:3760"}
{"level":"info","ts":"2026-08-11T09:01:51.500222Z","caller":"traceutil/trace.go:171","msg":"trace[2091777833] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"189.875573ms","start":"2026-08-11T09:01:51.310314Z","end":"2026-08-11T09:01:51.500189Z","steps":["trace[2091777833] 'process raft request'  (duration: 189.341453ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.500291Z","caller":"traceutil/trace.go:171","msg":"trace[1136977837] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4328502e-a38c-4a7b-89a3-4c3d694e678b; range_end:; response_count:1; response_revision:25159; }","duration":"270.379431ms","start":"2026-08-11T09:01:51.229891Z","end":"2026-08-11T09:01:51.50027Z","steps":["trace[1136977837] 'agreement among raft nodes before linearized reading'  (duration: 270.150247ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.500327Z","caller":"traceutil/trace.go:171","msg":"trace[123857053] transaction","detail":"{read_only:false; response_revision:25159; number_of_response:1; }","duration":"159.918576ms","start":"2026-08-11T09:01:51.340393Z","end":"2026-08-11T09:01:51.500312Z","steps":["trace[123857053] 'process raft request'  (duration: 159.470408ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.500208Z","caller":"traceutil/trace.go:171","msg":"trace[932820149] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25159; }","duration":"245.472583ms","start":"2026-08-11T09:01:51.254718Z","end":"2026-08-11T09:01:51.500191Z","steps":["trace[932820149] 'agreement among raft nodes before linearized reading'  (duration: 245.32026ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.500572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.336799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-11T09:01:51.500613Z","caller":"traceutil/trace.go:171","msg":"trace[80653366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25159; }","duration":"180.415481ms","start":"2026-08-11T09:01:51.320183Z","end":"2026-08-11T09:01:51.500599Z","steps":["trace[80653366] 'agreement among raft nodes before linearized reading'  (duration: 180.253558ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:51.83433Z","caller":"traceutil/trace.go:171","msg":"trace[425793002] linearizableReadLoop","detail":"{readStateIndex:25975; appliedIndex:25974; }","duration":"326.920429ms","start":"2026-08-11T09:01:51.507383Z","end":"2026-08-11T09:01:51.834303Z","steps":["trace[425793002] 'read index received'  (duration: 266.14543ms)","trace[425793002] 'applied index is now lower than readState.Index'  (duration: 60.773779ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:01:51.834513Z","caller":"traceutil/trace.go:171","msg":"trace[397595488] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"329.483378ms","start":"2026-08-11T09:01:51.504957Z","end":"2026-08-11T09:01:51.83444Z","steps":["trace[397595488] 'process raft request'  (duration: 268.576717ms)","trace[397595488] 'compare'  (duration: 60.527334ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:51.834591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.202084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-08-11T09:01:51.834651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:51.504932Z","time spent":"329.648691ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25135 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-11T09:01:51.834662Z","caller":"traceutil/trace.go:171","msg":"trace[1056743261] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25160; }","duration":"327.287316ms","start":"2026-08-11T09:01:51.507345Z","end":"2026-08-11T09:01:51.834632Z","steps":["trace[1056743261] 'agreement among raft nodes before linearized reading'  (duration: 327.109483ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:51.834688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:51.50733Z","time spent":"327.352887ms","remote":"127.0.0.1:41840","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":"info","ts":"2026-08-11T09:01:58.712485Z","caller":"traceutil/trace.go:171","msg":"trace[1779875399] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"207.33923ms","start":"2026-08-11T09:01:58.505113Z","end":"2026-08-11T09:01:58.712452Z","steps":["trace[1779875399] 'process raft request'  (duration: 207.066824ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:01:59.032401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.936815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984706680 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25208 > 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:18"}
{"level":"info","ts":"2026-08-11T09:01:59.033181Z","caller":"traceutil/trace.go:171","msg":"trace[744222620] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"317.242724ms","start":"2026-08-11T09:01:58.71588Z","end":"2026-08-11T09:01:59.033123Z","steps":["trace[744222620] 'process raft request'  (duration: 99.505274ms)","trace[744222620] 'compare'  (duration: 216.819132ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:01:59.033324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T09:01:58.715856Z","time spent":"317.396646ms","remote":"127.0.0.1:41922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25208 > 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-08-11T09:01:59.119072Z","caller":"traceutil/trace.go:171","msg":"trace[651832004] transaction","detail":"{read_only:false; response_revision:25232; number_of_response:1; }","duration":"163.588898ms","start":"2026-08-11T09:01:58.955452Z","end":"2026-08-11T09:01:59.119041Z","steps":["trace[651832004] 'process raft request'  (duration: 163.288232ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:59.119109Z","caller":"traceutil/trace.go:171","msg":"trace[760022783] transaction","detail":"{read_only:false; response_revision:25233; number_of_response:1; }","duration":"163.586277ms","start":"2026-08-11T09:01:58.95548Z","end":"2026-08-11T09:01:59.119066Z","steps":["trace[760022783] 'process raft request'  (duration: 163.433055ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:59.41966Z","caller":"traceutil/trace.go:171","msg":"trace[1542800977] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"187.729982ms","start":"2026-08-11T09:01:59.231912Z","end":"2026-08-11T09:01:59.419642Z","steps":["trace[1542800977] 'process raft request'  (duration: 187.591299ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:01:59.420756Z","caller":"traceutil/trace.go:171","msg":"trace[1773009664] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"130.183154ms","start":"2026-08-11T09:01:59.290541Z","end":"2026-08-11T09:01:59.420724Z","steps":["trace[1773009664] 'process raft request'  (duration: 129.998141ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:00.53649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.932184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:02:00.536641Z","caller":"traceutil/trace.go:171","msg":"trace[1587782917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25248; }","duration":"125.150238ms","start":"2026-08-11T09:02:00.411468Z","end":"2026-08-11T09:02:00.536618Z","steps":["trace[1587782917] 'range keys from in-memory index tree'  (duration: 124.822341ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:12.874188Z","caller":"traceutil/trace.go:171","msg":"trace[1699150715] transaction","detail":"{read_only:false; response_revision:25341; number_of_response:1; }","duration":"111.278931ms","start":"2026-08-11T09:02:12.762889Z","end":"2026-08-11T09:02:12.874168Z","steps":["trace[1699150715] 'process raft request'  (duration: 111.167659ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:12.968027Z","caller":"traceutil/trace.go:171","msg":"trace[2032658083] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"108.473206ms","start":"2026-08-11T09:02:12.859534Z","end":"2026-08-11T09:02:12.968007Z","steps":["trace[2032658083] 'process raft request'  (duration: 108.336743ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:13.152479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.910917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:02:13.152557Z","caller":"traceutil/trace.go:171","msg":"trace[1697435840] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25342; }","duration":"120.047549ms","start":"2026-08-11T09:02:13.032494Z","end":"2026-08-11T09:02:13.152542Z","steps":["trace[1697435840] 'range keys from in-memory index tree'  (duration: 119.813395ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:13.283303Z","caller":"traceutil/trace.go:171","msg":"trace[2006011439] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"105.722914ms","start":"2026-08-11T09:02:13.177511Z","end":"2026-08-11T09:02:13.283234Z","steps":["trace[2006011439] 'process raft request'  (duration: 105.474609ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:19.122578Z","caller":"traceutil/trace.go:171","msg":"trace[755964898] transaction","detail":"{read_only:false; response_revision:25400; number_of_response:1; }","duration":"135.422205ms","start":"2026-08-11T09:02:18.987111Z","end":"2026-08-11T09:02:19.122533Z","steps":["trace[755964898] 'process raft request'  (duration: 135.1637ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:19.498747Z","caller":"traceutil/trace.go:171","msg":"trace[125335594] transaction","detail":"{read_only:false; response_revision:25404; number_of_response:1; }","duration":"125.729749ms","start":"2026-08-11T09:02:19.372992Z","end":"2026-08-11T09:02:19.498721Z","steps":["trace[125335594] 'process raft request'  (duration: 47.363461ms)","trace[125335594] 'compare'  (duration: 77.99369ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:02:24.34278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.083978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-08-11T09:02:24.342862Z","caller":"traceutil/trace.go:171","msg":"trace[579798504] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25441; }","duration":"136.196631ms","start":"2026-08-11T09:02:24.206639Z","end":"2026-08-11T09:02:24.342836Z","steps":["trace[579798504] 'range keys from in-memory index tree'  (duration: 135.938275ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:26.500621Z","caller":"traceutil/trace.go:171","msg":"trace[2086277121] linearizableReadLoop","detail":"{readStateIndex:26278; appliedIndex:26277; }","duration":"125.902332ms","start":"2026-08-11T09:02:26.374674Z","end":"2026-08-11T09:02:26.500577Z","steps":["trace[2086277121] 'read index received'  (duration: 33.455903ms)","trace[2086277121] 'applied index is now lower than readState.Index'  (duration: 92.444459ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:26.50067Z","caller":"traceutil/trace.go:171","msg":"trace[2017014077] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"298.230748ms","start":"2026-08-11T09:02:26.202389Z","end":"2026-08-11T09:02:26.50062Z","steps":["trace[2017014077] 'process raft request'  (duration: 205.765639ms)","trace[2017014077] 'compare'  (duration: 92.151173ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:02:26.500784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.098176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-11T09:02:26.500864Z","caller":"traceutil/trace.go:171","msg":"trace[1045200924] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:25456; }","duration":"126.194038ms","start":"2026-08-11T09:02:26.374649Z","end":"2026-08-11T09:02:26.500843Z","steps":["trace[1045200924] 'agreement among raft nodes before linearized reading'  (duration: 126.045455ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:26.795403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.112977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-11T09:02:26.79549Z","caller":"traceutil/trace.go:171","msg":"trace[988540407] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25456; }","duration":"112.25669ms","start":"2026-08-11T09:02:26.683214Z","end":"2026-08-11T09:02:26.79547Z","steps":["trace[988540407] 'count revisions from in-memory index tree'  (duration: 112.031455ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:28.352383Z","caller":"traceutil/trace.go:171","msg":"trace[2123855338] linearizableReadLoop","detail":"{readStateIndex:26290; appliedIndex:26289; }","duration":"109.740521ms","start":"2026-08-11T09:02:28.242617Z","end":"2026-08-11T09:02:28.352357Z","steps":["trace[2123855338] 'read index received'  (duration: 109.493557ms)","trace[2123855338] 'applied index is now lower than readState.Index'  (duration: 245.864µs)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:28.352498Z","caller":"traceutil/trace.go:171","msg":"trace[1845633186] transaction","detail":"{read_only:false; response_revision:25468; number_of_response:1; }","duration":"150.269441ms","start":"2026-08-11T09:02:28.202173Z","end":"2026-08-11T09:02:28.352443Z","steps":["trace[1845633186] 'process raft request'  (duration: 149.920924ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:28.35266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.025066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-11T09:02:28.352739Z","caller":"traceutil/trace.go:171","msg":"trace[2103819518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25468; }","duration":"110.159779ms","start":"2026-08-11T09:02:28.242562Z","end":"2026-08-11T09:02:28.352721Z","steps":["trace[2103819518] 'agreement among raft nodes before linearized reading'  (duration: 109.912685ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:28.488641Z","caller":"traceutil/trace.go:171","msg":"trace[1822769273] transaction","detail":"{read_only:false; response_revision:25469; number_of_response:1; }","duration":"131.624602ms","start":"2026-08-11T09:02:28.356979Z","end":"2026-08-11T09:02:28.488604Z","steps":["trace[1822769273] 'process raft request'  (duration: 81.241783ms)","trace[1822769273] 'compare'  (duration: 50.118684ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:30.630496Z","caller":"traceutil/trace.go:171","msg":"trace[1015320429] linearizableReadLoop","detail":"{readStateIndex:26306; appliedIndex:26305; }","duration":"218.712228ms","start":"2026-08-11T09:02:30.411757Z","end":"2026-08-11T09:02:30.630469Z","steps":["trace[1015320429] 'read index received'  (duration: 10.908741ms)","trace[1015320429] 'applied index is now lower than readState.Index'  (duration: 207.802787ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:30.630717Z","caller":"traceutil/trace.go:171","msg":"trace[818699015] transaction","detail":"{read_only:false; response_revision:25484; number_of_response:1; }","duration":"273.521802ms","start":"2026-08-11T09:02:30.357183Z","end":"2026-08-11T09:02:30.630704Z","steps":["trace[818699015] 'process raft request'  (duration: 193.826769ms)","trace[818699015] 'compare'  (duration: 79.214904ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:02:30.630937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.184957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:02:30.630961Z","caller":"traceutil/trace.go:171","msg":"trace[810893599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25484; }","duration":"219.448461ms","start":"2026-08-11T09:02:30.411506Z","end":"2026-08-11T09:02:30.630955Z","steps":["trace[810893599] 'agreement among raft nodes before linearized reading'  (duration: 219.324619ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:30.631093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.622056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:02:30.631118Z","caller":"traceutil/trace.go:171","msg":"trace[578776948] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:25484; }","duration":"191.691787ms","start":"2026-08-11T09:02:30.43942Z","end":"2026-08-11T09:02:30.631111Z","steps":["trace[578776948] 'agreement among raft nodes before linearized reading'  (duration: 191.646736ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:30.631319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.829841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-11T09:02:30.631347Z","caller":"traceutil/trace.go:171","msg":"trace[1388041114] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25484; }","duration":"138.885493ms","start":"2026-08-11T09:02:30.492455Z","end":"2026-08-11T09:02:30.631341Z","steps":["trace[1388041114] 'agreement among raft nodes before linearized reading'  (duration: 138.791301ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:30.631444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.911224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-11T09:02:30.631486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.363219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-11T09:02:30.631552Z","caller":"traceutil/trace.go:171","msg":"trace[1411993195] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:25484; }","duration":"164.077197ms","start":"2026-08-11T09:02:30.467453Z","end":"2026-08-11T09:02:30.63153Z","steps":["trace[1411993195] 'agreement among raft nodes before linearized reading'  (duration: 163.869013ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:30.631559Z","caller":"traceutil/trace.go:171","msg":"trace[1667301358] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25484; }","duration":"116.483891ms","start":"2026-08-11T09:02:30.515057Z","end":"2026-08-11T09:02:30.63154Z","steps":["trace[1667301358] 'agreement among raft nodes before linearized reading'  (duration: 116.218636ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:02:30.795599Z","caller":"traceutil/trace.go:171","msg":"trace[2050372137] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"160.787343ms","start":"2026-08-11T09:02:30.634781Z","end":"2026-08-11T09:02:30.795568Z","steps":["trace[2050372137] 'process raft request'  (duration: 149.121679ms)","trace[2050372137] 'compare'  (duration: 11.536032ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:30.805011Z","caller":"traceutil/trace.go:171","msg":"trace[512522126] linearizableReadLoop","detail":"{readStateIndex:26308; appliedIndex:26306; }","duration":"109.068888ms","start":"2026-08-11T09:02:30.695923Z","end":"2026-08-11T09:02:30.804992Z","steps":["trace[512522126] 'read index received'  (duration: 87.991862ms)","trace[512522126] 'applied index is now lower than readState.Index'  (duration: 21.075886ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:02:30.805117Z","caller":"traceutil/trace.go:171","msg":"trace[2135537420] transaction","detail":"{read_only:false; response_revision:25486; number_of_response:1; }","duration":"169.229236ms","start":"2026-08-11T09:02:30.635865Z","end":"2026-08-11T09:02:30.805094Z","steps":["trace[2135537420] 'process raft request'  (duration: 168.987622ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:02:30.8052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.269582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-11T09:02:30.80523Z","caller":"traceutil/trace.go:171","msg":"trace[1009709896] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:25486; }","duration":"109.347934ms","start":"2026-08-11T09:02:30.695873Z","end":"2026-08-11T09:02:30.805221Z","steps":["trace[1009709896] 'agreement among raft nodes before linearized reading'  (duration: 109.201211ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:03:37.57382Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23150}
{"level":"info","ts":"2026-08-11T09:03:37.704169Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23150,"took":"124.950803ms","hash":3045415272,"current-db-size-bytes":60194816,"current-db-size":"60 MB","current-db-size-in-use-bytes":36306944,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-08-11T09:03:37.70424Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3045415272,"revision":23150,"compact-revision":20139}
{"level":"info","ts":"2026-08-11T09:04:05.864638Z","caller":"traceutil/trace.go:171","msg":"trace[1200226702] transaction","detail":"{read_only:false; response_revision:26424; number_of_response:1; }","duration":"219.437231ms","start":"2026-08-11T09:04:05.645179Z","end":"2026-08-11T09:04:05.864617Z","steps":["trace[1200226702] 'process raft request'  (duration: 219.297829ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:04:05.864641Z","caller":"traceutil/trace.go:171","msg":"trace[1843167519] linearizableReadLoop","detail":"{readStateIndex:27269; appliedIndex:27269; }","duration":"217.905363ms","start":"2026-08-11T09:04:05.646717Z","end":"2026-08-11T09:04:05.864622Z","steps":["trace[1843167519] 'read index received'  (duration: 217.896022ms)","trace[1843167519] 'applied index is now lower than readState.Index'  (duration: 8.001µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-11T09:04:05.864726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.991094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:04:05.864767Z","caller":"traceutil/trace.go:171","msg":"trace[2129224284] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26424; }","duration":"218.083066ms","start":"2026-08-11T09:04:05.646676Z","end":"2026-08-11T09:04:05.864759Z","steps":["trace[2129224284] 'agreement among raft nodes before linearized reading'  (duration: 217.970774ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:04:05.920451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.620755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:04:05.920502Z","caller":"traceutil/trace.go:171","msg":"trace[255757798] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26427; }","duration":"273.721567ms","start":"2026-08-11T09:04:05.64677Z","end":"2026-08-11T09:04:05.920492Z","steps":["trace[255757798] 'agreement among raft nodes before linearized reading'  (duration: 273.621175ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:04:05.920539Z","caller":"traceutil/trace.go:171","msg":"trace[1868481243] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"174.270473ms","start":"2026-08-11T09:04:05.746239Z","end":"2026-08-11T09:04:05.92051Z","steps":["trace[1868481243] 'process raft request'  (duration: 174.1013ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:04:05.920602Z","caller":"traceutil/trace.go:171","msg":"trace[58578387] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"174.268032ms","start":"2026-08-11T09:04:05.746318Z","end":"2026-08-11T09:04:05.920586Z","steps":["trace[58578387] 'process raft request'  (duration: 174.049088ms)"],"step_count":1}
{"level":"info","ts":"2026-08-11T09:04:05.920613Z","caller":"traceutil/trace.go:171","msg":"trace[650423714] transaction","detail":"{read_only:false; response_revision:26425; number_of_response:1; }","duration":"174.391455ms","start":"2026-08-11T09:04:05.746185Z","end":"2026-08-11T09:04:05.920576Z","steps":["trace[650423714] 'process raft request'  (duration: 174.054579ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:04:05.92084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.618181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-11T09:04:05.920984Z","caller":"traceutil/trace.go:171","msg":"trace[632728192] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:26427; }","duration":"159.806135ms","start":"2026-08-11T09:04:05.761123Z","end":"2026-08-11T09:04:05.92093Z","steps":["trace[632728192] 'agreement among raft nodes before linearized reading'  (duration: 159.52668ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-11T09:05:48.97982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.445929ms","expected-duration":"100ms","prefix":"","request":"header:<ID:18221739944984712396 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:27510 > 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:18"}
{"level":"info","ts":"2026-08-11T09:05:48.979959Z","caller":"traceutil/trace.go:171","msg":"trace[1987596083] transaction","detail":"{read_only:false; response_revision:27525; number_of_response:1; }","duration":"129.309278ms","start":"2026-08-11T09:05:48.850629Z","end":"2026-08-11T09:05:48.979939Z","steps":["trace[1987596083] 'process raft request'  (duration: 11.652364ms)","trace[1987596083] 'compare'  (duration: 117.277086ms)"],"step_count":2}
{"level":"info","ts":"2026-08-11T09:08:37.580604Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26158}
{"level":"info","ts":"2026-08-11T09:08:37.724596Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26158,"took":"137.545897ms","hash":4253231006,"current-db-size-bytes":60194816,"current-db-size":"60 MB","current-db-size-in-use-bytes":34930688,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-11T09:08:37.724664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4253231006,"revision":26158,"compact-revision":23150}
{"level":"info","ts":"2026-08-11T09:09:04.322147Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-11T09:09:04.326554Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-11T09:09:04.326671Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-11T09:13:37.587349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28890}
{"level":"info","ts":"2026-08-11T09:13:37.725982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28890,"took":"135.64142ms","hash":913719647,"current-db-size-bytes":60194816,"current-db-size":"60 MB","current-db-size-in-use-bytes":31850496,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T09:13:37.726028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":913719647,"revision":28890,"compact-revision":26158}
{"level":"info","ts":"2026-08-11T09:18:37.594161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31110}
{"level":"info","ts":"2026-08-11T09:18:37.7267Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31110,"took":"127.946473ms","hash":2399765411,"current-db-size-bytes":60194816,"current-db-size":"60 MB","current-db-size-in-use-bytes":31490048,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T09:18:37.726756Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2399765411,"revision":31110,"compact-revision":28890}
{"level":"info","ts":"2026-08-11T09:23:37.600503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33380}
{"level":"info","ts":"2026-08-11T09:23:37.748548Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33380,"took":"143.050425ms","hash":1250569877,"current-db-size-bytes":61235200,"current-db-size":"61 MB","current-db-size-in-use-bytes":32464896,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T09:23:37.74865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1250569877,"revision":33380,"compact-revision":31110}
{"level":"info","ts":"2026-08-11T09:28:37.606823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35669}
{"level":"info","ts":"2026-08-11T09:28:37.759443Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35669,"took":"148.280635ms","hash":1207383567,"current-db-size-bytes":62554112,"current-db-size":"63 MB","current-db-size-in-use-bytes":31821824,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T09:28:37.759517Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1207383567,"revision":35669,"compact-revision":33380}
{"level":"info","ts":"2026-08-11T09:30:30.071485Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"185293d8d40ffce0","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-11T09:30:30.077463Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-08-11T09:30:30.077858Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-08-11T09:33:37.613847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37904}
{"level":"info","ts":"2026-08-11T09:33:37.731161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37904,"took":"114.137465ms","hash":3537836970,"current-db-size-bytes":62554112,"current-db-size":"63 MB","current-db-size-in-use-bytes":32157696,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-11T09:33:37.731237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3537836970,"revision":37904,"compact-revision":35669}