{"level":"warn","ts":"2026-08-31T07:30:13.973889Z","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-31T07:30:13.973996Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.32:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.32:2380","--initial-cluster=instance=https://162.253.55.32:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.32:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.32: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-31T07:30:13.974066Z","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-31T07:30:13.974079Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.32:2380"]}
{"level":"info","ts":"2026-08-31T07:30:13.974097Z","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-31T07:30:13.974741Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"]}
{"level":"info","ts":"2026-08-31T07:30:13.974813Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.32: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-31T07:30:13.979409Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.356503ms"}
{"level":"info","ts":"2026-08-31T07:30:13.995033Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c665390cd9eacc14","cluster-id":"d19b610fbe64baae"}
{"level":"info","ts":"2026-08-31T07:30:13.995105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-31T07:30:13.99513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 0"}
{"level":"info","ts":"2026-08-31T07:30:13.995143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c665390cd9eacc14 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-31T07:30:13.995153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 1"}
{"level":"info","ts":"2026-08-31T07:30:13.995206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"}
{"level":"warn","ts":"2026-08-31T07:30:14.000892Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-31T07:30:14.002558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-31T07:30:14.004509Z","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-31T07:30:14.007233Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c665390cd9eacc14","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-31T07:30:14.007439Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c665390cd9eacc14","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-31T07:30:14.007765Z","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-31T07:30:14.00782Z","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-31T07:30:14.007838Z","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-31T07:30:14.009301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"}
{"level":"info","ts":"2026-08-31T07:30:14.009575Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","added-peer-id":"c665390cd9eacc14","added-peer-peer-urls":["https://162.253.55.32:2380"]}
{"level":"info","ts":"2026-08-31T07:30:14.014763Z","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-31T07:30:14.014848Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.32:2380"}
{"level":"info","ts":"2026-08-31T07:30:14.014893Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.32:2380"}
{"level":"info","ts":"2026-08-31T07:30:14.015045Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c665390cd9eacc14","initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-31T07:30:14.015099Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-31T07:30:14.895428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-31T07:30:14.895513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-31T07:30:14.895562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgPreVoteResp from c665390cd9eacc14 at term 1"}
{"level":"info","ts":"2026-08-31T07:30:14.895589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became candidate at term 2"}
{"level":"info","ts":"2026-08-31T07:30:14.895645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgVoteResp from c665390cd9eacc14 at term 2"}
{"level":"info","ts":"2026-08-31T07:30:14.895679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became leader at term 2"}
{"level":"info","ts":"2026-08-31T07:30:14.895699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c665390cd9eacc14 elected leader c665390cd9eacc14 at term 2"}
{"level":"info","ts":"2026-08-31T07:30:14.897218Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-31T07:30:14.898552Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-31T07:30:14.898572Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c665390cd9eacc14","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.32:2379]}","request-path":"/0/members/c665390cd9eacc14/attributes","cluster-id":"d19b610fbe64baae","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-31T07:30:14.898726Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-31T07:30:14.898966Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-31T07:30:14.899017Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-31T07:30:14.899408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-31T07:30:14.899615Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-31T07:30:14.89976Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-31T07:30:14.901869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-31T07:30:14.901917Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.32:2379"}
{"level":"info","ts":"2026-08-31T07:30:29.198022Z","caller":"traceutil/trace.go:171","msg":"trace[1327691640] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"118.808256ms","start":"2026-08-31T07:30:29.079156Z","end":"2026-08-31T07:30:29.197964Z","steps":["trace[1327691640] 'process raft request'  (duration: 118.614431ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:30:34.801784Z","caller":"traceutil/trace.go:171","msg":"trace[610300715] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"118.294672ms","start":"2026-08-31T07:30:34.683454Z","end":"2026-08-31T07:30:34.801748Z","steps":["trace[610300715] 'process raft request'  (duration: 118.057556ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:30:53.510903Z","caller":"traceutil/trace.go:171","msg":"trace[1692402920] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"138.358504ms","start":"2026-08-31T07:30:53.372513Z","end":"2026-08-31T07:30:53.510872Z","steps":["trace[1692402920] 'process raft request'  (duration: 137.042227ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:30:53.514196Z","caller":"traceutil/trace.go:171","msg":"trace[2119919239] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"141.232073ms","start":"2026-08-31T07:30:53.372921Z","end":"2026-08-31T07:30:53.514153Z","steps":["trace[2119919239] 'process raft request'  (duration: 140.949866ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:30:53.514346Z","caller":"traceutil/trace.go:171","msg":"trace[920559800] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"122.557211ms","start":"2026-08-31T07:30:53.39177Z","end":"2026-08-31T07:30:53.514327Z","steps":["trace[920559800] 'process raft request'  (duration: 122.252793ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:31:00.210559Z","caller":"traceutil/trace.go:171","msg":"trace[1834963282] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"179.549238ms","start":"2026-08-31T07:31:00.030787Z","end":"2026-08-31T07:31:00.210336Z","steps":["trace[1834963282] 'read index received'  (duration: 176.372949ms)","trace[1834963282] 'applied index is now lower than readState.Index'  (duration: 3.174899ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:31:00.210634Z","caller":"traceutil/trace.go:171","msg":"trace[2066538264] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"192.389447ms","start":"2026-08-31T07:31:00.018217Z","end":"2026-08-31T07:31:00.210607Z","steps":["trace[2066538264] 'process raft request'  (duration: 190.074992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:00.210926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.132375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jscvn\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-08-31T07:31:00.211041Z","caller":"traceutil/trace.go:171","msg":"trace[943727422] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jscvn; range_end:; response_count:1; response_revision:626; }","duration":"180.325519ms","start":"2026-08-31T07:31:00.030692Z","end":"2026-08-31T07:31:00.211017Z","steps":["trace[943727422] 'agreement among raft nodes before linearized reading'  (duration: 179.99915ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:00.928285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.685773ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616785537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:729 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:31:00.928633Z","caller":"traceutil/trace.go:171","msg":"trace[407568929] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"639.684611ms","start":"2026-08-31T07:31:00.28892Z","end":"2026-08-31T07:31:00.928604Z","steps":["trace[407568929] 'process raft request'  (duration: 505.005449ms)","trace[407568929] 'compare'  (duration: 133.364575ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:31:00.928818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.804198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:31:00.928751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:31:00.288901Z","time spent":"639.799414ms","remote":"127.0.0.1:37234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:729 >> failure:<>"}
{"level":"info","ts":"2026-08-31T07:31:00.928885Z","caller":"traceutil/trace.go:171","msg":"trace[1385258941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"557.918361ms","start":"2026-08-31T07:31:00.370946Z","end":"2026-08-31T07:31:00.928864Z","steps":["trace[1385258941] 'agreement among raft nodes before linearized reading'  (duration: 557.739616ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:00.928927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:31:00.370921Z","time spent":"557.997183ms","remote":"127.0.0.1:36982","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-31T07:31:00.928632Z","caller":"traceutil/trace.go:171","msg":"trace[1676132180] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"557.580522ms","start":"2026-08-31T07:31:00.37099Z","end":"2026-08-31T07:31:00.928571Z","steps":["trace[1676132180] 'read index received'  (duration: 422.966562ms)","trace[1676132180] 'applied index is now lower than readState.Index'  (duration: 134.6115ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:31:00.929355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.907331ms","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-31T07:31:00.929407Z","caller":"traceutil/trace.go:171","msg":"trace[492726005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"523.027175ms","start":"2026-08-31T07:31:00.406367Z","end":"2026-08-31T07:31:00.929394Z","steps":["trace[492726005] 'agreement among raft nodes before linearized reading'  (duration: 522.929542ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:00.929498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:31:00.406332Z","time spent":"523.104357ms","remote":"127.0.0.1:37288","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-31T07:31:00.929524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.049964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-31T07:31:00.929605Z","caller":"traceutil/trace.go:171","msg":"trace[916678755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"364.150436ms","start":"2026-08-31T07:31:00.565422Z","end":"2026-08-31T07:31:00.929573Z","steps":["trace[916678755] 'agreement among raft nodes before linearized reading'  (duration: 363.952181ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:00.929655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:31:00.565399Z","time spent":"364.243369ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-31T07:31:15.870658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.534799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-31T07:31:15.870772Z","caller":"traceutil/trace.go:171","msg":"trace[649284148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"395.701354ms","start":"2026-08-31T07:31:15.475046Z","end":"2026-08-31T07:31:15.870747Z","steps":["trace[649284148] 'range keys from in-memory index tree'  (duration: 395.308232ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:31:15.870834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:31:15.475021Z","time spent":"395.803056ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-31T07:32:08.608481Z","caller":"traceutil/trace.go:171","msg":"trace[1320246847] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"117.44288ms","start":"2026-08-31T07:32:08.490993Z","end":"2026-08-31T07:32:08.608435Z","steps":["trace[1320246847] 'process raft request'  (duration: 117.180323ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:08.902301Z","caller":"traceutil/trace.go:171","msg":"trace[1267007942] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"106.179433ms","start":"2026-08-31T07:32:08.796091Z","end":"2026-08-31T07:32:08.902271Z","steps":["trace[1267007942] 'process raft request'  (duration: 105.964537ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:21.535542Z","caller":"traceutil/trace.go:171","msg":"trace[1776755990] linearizableReadLoop","detail":"{readStateIndex:1768; appliedIndex:1767; }","duration":"113.978419ms","start":"2026-08-31T07:32:21.421534Z","end":"2026-08-31T07:32:21.535513Z","steps":["trace[1776755990] 'read index received'  (duration: 113.622849ms)","trace[1776755990] 'applied index is now lower than readState.Index'  (duration: 353.54µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:21.535615Z","caller":"traceutil/trace.go:171","msg":"trace[46895267] transaction","detail":"{read_only:false; response_revision:1699; number_of_response:1; }","duration":"115.15125ms","start":"2026-08-31T07:32:21.420415Z","end":"2026-08-31T07:32:21.535566Z","steps":["trace[46895267] 'process raft request'  (duration: 114.861222ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:32:21.536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.41397ms","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-31T07:32:21.536142Z","caller":"traceutil/trace.go:171","msg":"trace[2068604190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1699; }","duration":"114.650467ms","start":"2026-08-31T07:32:21.421478Z","end":"2026-08-31T07:32:21.536128Z","steps":["trace[2068604190] 'agreement among raft nodes before linearized reading'  (duration: 114.262616ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:22.053326Z","caller":"traceutil/trace.go:171","msg":"trace[930285268] transaction","detail":"{read_only:false; response_revision:1707; number_of_response:1; }","duration":"112.95165ms","start":"2026-08-31T07:32:21.940346Z","end":"2026-08-31T07:32:22.053297Z","steps":["trace[930285268] 'process raft request'  (duration: 112.430385ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:22.053655Z","caller":"traceutil/trace.go:171","msg":"trace[1319735866] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"101.893714ms","start":"2026-08-31T07:32:21.951735Z","end":"2026-08-31T07:32:22.053629Z","steps":["trace[1319735866] 'process raft request'  (duration: 101.485012ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:22.396223Z","caller":"traceutil/trace.go:171","msg":"trace[1530938844] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"107.865098ms","start":"2026-08-31T07:32:22.288315Z","end":"2026-08-31T07:32:22.39618Z","steps":["trace[1530938844] 'process raft request'  (duration: 107.484288ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:22.759479Z","caller":"traceutil/trace.go:171","msg":"trace[1769788791] transaction","detail":"{read_only:false; response_revision:1716; number_of_response:1; }","duration":"140.958398ms","start":"2026-08-31T07:32:22.618486Z","end":"2026-08-31T07:32:22.759445Z","steps":["trace[1769788791] 'process raft request'  (duration: 97.583402ms)","trace[1769788791] 'compare'  (duration: 43.14ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:25.074846Z","caller":"traceutil/trace.go:171","msg":"trace[1755825393] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1731; }","duration":"114.238025ms","start":"2026-08-31T07:32:24.960573Z","end":"2026-08-31T07:32:25.074811Z","steps":["trace[1755825393] 'process raft request'  (duration: 113.992488ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:36.438283Z","caller":"traceutil/trace.go:171","msg":"trace[127986322] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1975; }","duration":"101.509832ms","start":"2026-08-31T07:32:36.336749Z","end":"2026-08-31T07:32:36.438259Z","steps":["trace[127986322] 'read index received'  (duration: 101.336087ms)","trace[127986322] 'applied index is now lower than readState.Index'  (duration: 172.445µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:36.438716Z","caller":"traceutil/trace.go:171","msg":"trace[1259056395] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"248.911218ms","start":"2026-08-31T07:32:36.189783Z","end":"2026-08-31T07:32:36.438694Z","steps":["trace[1259056395] 'process raft request'  (duration: 248.349732ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:32:36.438856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.087578ms","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-31T07:32:36.438933Z","caller":"traceutil/trace.go:171","msg":"trace[85438852] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1900; }","duration":"102.223131ms","start":"2026-08-31T07:32:36.336692Z","end":"2026-08-31T07:32:36.438915Z","steps":["trace[85438852] 'agreement among raft nodes before linearized reading'  (duration: 102.002325ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:32:36.780464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.163286ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616787990 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1877 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:32:36.780585Z","caller":"traceutil/trace.go:171","msg":"trace[2113798151] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1977; }","duration":"184.767896ms","start":"2026-08-31T07:32:36.595796Z","end":"2026-08-31T07:32:36.780564Z","steps":["trace[2113798151] 'read index received'  (duration: 51.451µs)","trace[2113798151] 'applied index is now lower than readState.Index'  (duration: 184.714925ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:36.780637Z","caller":"traceutil/trace.go:171","msg":"trace[1292685859] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"247.375057ms","start":"2026-08-31T07:32:36.533228Z","end":"2026-08-31T07:32:36.780604Z","steps":["trace[1292685859] 'process raft request'  (duration: 51.79707ms)","trace[1292685859] 'compare'  (duration: 195.015131ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:32:36.780751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.96021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4df92563-12df-40cf-ac96-2939e5875b20\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-08-31T07:32:36.78079Z","caller":"traceutil/trace.go:171","msg":"trace[736485632] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4df92563-12df-40cf-ac96-2939e5875b20; range_end:; response_count:1; response_revision:1902; }","duration":"185.069263ms","start":"2026-08-31T07:32:36.595707Z","end":"2026-08-31T07:32:36.780776Z","steps":["trace[736485632] 'agreement among raft nodes before linearized reading'  (duration: 184.910459ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:36.892338Z","caller":"traceutil/trace.go:171","msg":"trace[1012931785] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"102.347335ms","start":"2026-08-31T07:32:36.789964Z","end":"2026-08-31T07:32:36.892311Z","steps":["trace[1012931785] 'process raft request'  (duration: 101.737168ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:50.421861Z","caller":"traceutil/trace.go:171","msg":"trace[573103174] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"148.353294ms","start":"2026-08-31T07:32:50.273463Z","end":"2026-08-31T07:32:50.421816Z","steps":["trace[573103174] 'process raft request'  (duration: 120.257863ms)","trace[573103174] 'compare'  (duration: 27.775862ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:50.452892Z","caller":"traceutil/trace.go:171","msg":"trace[842381362] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"178.163751ms","start":"2026-08-31T07:32:50.274696Z","end":"2026-08-31T07:32:50.452859Z","steps":["trace[842381362] 'process raft request'  (duration: 177.915875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:50.45291Z","caller":"traceutil/trace.go:171","msg":"trace[1068510970] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"175.689512ms","start":"2026-08-31T07:32:50.277194Z","end":"2026-08-31T07:32:50.452884Z","steps":["trace[1068510970] 'process raft request'  (duration: 175.579179ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:32:50.453101Z","caller":"traceutil/trace.go:171","msg":"trace[652009356] linearizableReadLoop","detail":"{readStateIndex:2101; appliedIndex:2097; }","duration":"134.995162ms","start":"2026-08-31T07:32:50.31807Z","end":"2026-08-31T07:32:50.453065Z","steps":["trace[652009356] 'read index received'  (duration: 75.795007ms)","trace[652009356] 'applied index is now lower than readState.Index'  (duration: 59.197325ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:32:50.453257Z","caller":"traceutil/trace.go:171","msg":"trace[1045391632] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"174.813538ms","start":"2026-08-31T07:32:50.27841Z","end":"2026-08-31T07:32:50.453223Z","steps":["trace[1045391632] 'process raft request'  (duration: 174.410177ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:32:50.453347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.261069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-31T07:32:50.453509Z","caller":"traceutil/trace.go:171","msg":"trace[1365621465] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2021; }","duration":"135.471134ms","start":"2026-08-31T07:32:50.318004Z","end":"2026-08-31T07:32:50.453475Z","steps":["trace[1365621465] 'agreement among raft nodes before linearized reading'  (duration: 135.235048ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:32:50.453376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.802604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:32:50.453631Z","caller":"traceutil/trace.go:171","msg":"trace[710466027] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2021; }","duration":"118.120013ms","start":"2026-08-31T07:32:50.335495Z","end":"2026-08-31T07:32:50.453615Z","steps":["trace[710466027] 'agreement among raft nodes before linearized reading'  (duration: 117.809734ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:33:27.193686Z","caller":"traceutil/trace.go:171","msg":"trace[604927378] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"108.324073ms","start":"2026-08-31T07:33:27.08533Z","end":"2026-08-31T07:33:27.193654Z","steps":["trace[604927378] 'process raft request'  (duration: 108.138408ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:33:33.373084Z","caller":"traceutil/trace.go:171","msg":"trace[316219082] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"159.03639ms","start":"2026-08-31T07:33:33.214006Z","end":"2026-08-31T07:33:33.373042Z","steps":["trace[316219082] 'process raft request'  (duration: 158.788864ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:33:33.731798Z","caller":"traceutil/trace.go:171","msg":"trace[404801613] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"146.092973ms","start":"2026-08-31T07:33:33.585677Z","end":"2026-08-31T07:33:33.73177Z","steps":["trace[404801613] 'process raft request'  (duration: 145.893377ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:33:33.871181Z","caller":"traceutil/trace.go:171","msg":"trace[1129793562] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"173.130652ms","start":"2026-08-31T07:33:33.697961Z","end":"2026-08-31T07:33:33.871091Z","steps":["trace[1129793562] 'process raft request'  (duration: 141.215608ms)","trace[1129793562] 'compare'  (duration: 31.632797ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:36:04.170564Z","caller":"traceutil/trace.go:171","msg":"trace[1465146809] transaction","detail":"{read_only:false; response_revision:3267; number_of_response:1; }","duration":"107.420693ms","start":"2026-08-31T07:36:04.063111Z","end":"2026-08-31T07:36:04.170532Z","steps":["trace[1465146809] 'process raft request'  (duration: 57.275515ms)","trace[1465146809] 'compare'  (duration: 49.765038ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:38:18.579033Z","caller":"traceutil/trace.go:171","msg":"trace[574621908] transaction","detail":"{read_only:false; response_revision:4166; number_of_response:1; }","duration":"136.02021ms","start":"2026-08-31T07:38:18.44298Z","end":"2026-08-31T07:38:18.579Z","steps":["trace[574621908] 'process raft request'  (duration: 134.285021ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:38:18.579239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.074401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:38:18.579325Z","caller":"traceutil/trace.go:171","msg":"trace[1600840247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4166; }","duration":"136.251006ms","start":"2026-08-31T07:38:18.443058Z","end":"2026-08-31T07:38:18.579309Z","steps":["trace[1600840247] 'agreement among raft nodes before linearized reading'  (duration: 136.059141ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:38:18.579045Z","caller":"traceutil/trace.go:171","msg":"trace[1975884353] linearizableReadLoop","detail":"{readStateIndex:4329; appliedIndex:4328; }","duration":"135.870046ms","start":"2026-08-31T07:38:18.443133Z","end":"2026-08-31T07:38:18.579003Z","steps":["trace[1975884353] 'read index received'  (duration: 134.053775ms)","trace[1975884353] 'applied index is now lower than readState.Index'  (duration: 1.813761ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:38:18.579729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.820215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z94f4\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-08-31T07:38:18.57983Z","caller":"traceutil/trace.go:171","msg":"trace[958740025] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z94f4; range_end:; response_count:1; response_revision:4166; }","duration":"101.987329ms","start":"2026-08-31T07:38:18.477814Z","end":"2026-08-31T07:38:18.579802Z","steps":["trace[958740025] 'agreement among raft nodes before linearized reading'  (duration: 101.715152ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:44.083696Z","caller":"traceutil/trace.go:171","msg":"trace[249712493] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"100.654105ms","start":"2026-08-31T07:39:43.982997Z","end":"2026-08-31T07:39:44.083651Z","steps":["trace[249712493] 'process raft request'  (duration: 100.136461ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:39:50.407819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.495011ms","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-31T07:39:50.407906Z","caller":"traceutil/trace.go:171","msg":"trace[183580681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5244; }","duration":"104.616635ms","start":"2026-08-31T07:39:50.30327Z","end":"2026-08-31T07:39:50.407887Z","steps":["trace[183580681] 'range keys from in-memory index tree'  (duration: 104.328197ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:39:50.407816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.665852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-31T07:39:50.408021Z","caller":"traceutil/trace.go:171","msg":"trace[964670941] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5244; }","duration":"100.92593ms","start":"2026-08-31T07:39:50.307071Z","end":"2026-08-31T07:39:50.407997Z","steps":["trace[964670941] 'count revisions from in-memory index tree'  (duration: 100.538169ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:50.527218Z","caller":"traceutil/trace.go:171","msg":"trace[710638134] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"116.40272ms","start":"2026-08-31T07:39:50.410776Z","end":"2026-08-31T07:39:50.527178Z","steps":["trace[710638134] 'process raft request'  (duration: 116.141233ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:50.618927Z","caller":"traceutil/trace.go:171","msg":"trace[217746758] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"208.040296ms","start":"2026-08-31T07:39:50.410849Z","end":"2026-08-31T07:39:50.618889Z","steps":["trace[217746758] 'process raft request'  (duration: 201.136951ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:50.61915Z","caller":"traceutil/trace.go:171","msg":"trace[1182155088] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"207.767339ms","start":"2026-08-31T07:39:50.411356Z","end":"2026-08-31T07:39:50.619124Z","steps":["trace[1182155088] 'process raft request'  (duration: 207.46178ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:50.619298Z","caller":"traceutil/trace.go:171","msg":"trace[702093396] linearizableReadLoop","detail":"{readStateIndex:5455; appliedIndex:5452; }","duration":"176.306154ms","start":"2026-08-31T07:39:50.442962Z","end":"2026-08-31T07:39:50.619268Z","steps":["trace[702093396] 'read index received'  (duration: 84.05159ms)","trace[702093396] 'applied index is now lower than readState.Index'  (duration: 92.253454ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:39:50.619408Z","caller":"traceutil/trace.go:171","msg":"trace[1120064965] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"142.42102ms","start":"2026-08-31T07:39:50.476945Z","end":"2026-08-31T07:39:50.619366Z","steps":["trace[1120064965] 'process raft request'  (duration: 142.07195ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:39:50.61946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.487389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-hft8w\" ","response":"range_response_count:1 size:5150"}
{"level":"info","ts":"2026-08-31T07:39:50.619508Z","caller":"traceutil/trace.go:171","msg":"trace[1146605532] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-hft8w; range_end:; response_count:1; response_revision:5248; }","duration":"176.588061ms","start":"2026-08-31T07:39:50.442909Z","end":"2026-08-31T07:39:50.619497Z","steps":["trace[1146605532] 'agreement among raft nodes before linearized reading'  (duration: 176.437067ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:39:57.024509Z","caller":"traceutil/trace.go:171","msg":"trace[459104761] transaction","detail":"{read_only:false; response_revision:5467; number_of_response:1; }","duration":"115.157385ms","start":"2026-08-31T07:39:56.909288Z","end":"2026-08-31T07:39:57.024446Z","steps":["trace[459104761] 'process raft request'  (duration: 114.885848ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:06.483249Z","caller":"traceutil/trace.go:171","msg":"trace[706790759] transaction","detail":"{read_only:false; response_revision:5629; number_of_response:1; }","duration":"137.312785ms","start":"2026-08-31T07:40:06.345905Z","end":"2026-08-31T07:40:06.483218Z","steps":["trace[706790759] 'process raft request'  (duration: 137.247723ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:06.483336Z","caller":"traceutil/trace.go:171","msg":"trace[1926284999] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"140.179697ms","start":"2026-08-31T07:40:06.34311Z","end":"2026-08-31T07:40:06.483289Z","steps":["trace[1926284999] 'process raft request'  (duration: 76.019392ms)","trace[1926284999] 'compare'  (duration: 63.579929ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:40:07.054513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.523375ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616796906 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5586 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:40:07.054724Z","caller":"traceutil/trace.go:171","msg":"trace[796663717] transaction","detail":"{read_only:false; response_revision:5635; number_of_response:1; }","duration":"320.947047ms","start":"2026-08-31T07:40:06.733752Z","end":"2026-08-31T07:40:07.054699Z","steps":["trace[796663717] 'process raft request'  (duration: 320.872235ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:07.054781Z","caller":"traceutil/trace.go:171","msg":"trace[1593745958] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"321.373699ms","start":"2026-08-31T07:40:06.733357Z","end":"2026-08-31T07:40:07.054731Z","steps":["trace[1593745958] 'process raft request'  (duration: 64.521035ms)","trace[1593745958] 'compare'  (duration: 256.395671ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:40:07.055003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:40:06.733723Z","time spent":"321.045039ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5587 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-31T07:40:07.055048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:40:06.733326Z","time spent":"321.597405ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5586 > 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-31T07:40:15.202431Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3008}
{"level":"warn","ts":"2026-08-31T07:40:15.203624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.000185ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616797314 username:\"kube-apiserver-etcd-client\" auth_revision:1 > compaction:<revision:3008 > ","response":"size:5"}
{"level":"info","ts":"2026-08-31T07:40:15.203806Z","caller":"traceutil/trace.go:171","msg":"trace[2011669903] linearizableReadLoop","detail":"{readStateIndex:6041; appliedIndex:6040; }","duration":"192.433693ms","start":"2026-08-31T07:40:15.011349Z","end":"2026-08-31T07:40:15.203782Z","steps":["trace[2011669903] 'read index received'  (duration: 84.997578ms)","trace[2011669903] 'applied index is now lower than readState.Index'  (duration: 107.434325ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:40:15.203902Z","caller":"traceutil/trace.go:171","msg":"trace[521158934] compact","detail":"{revision:3008; response_revision:5816; }","duration":"195.065797ms","start":"2026-08-31T07:40:15.00879Z","end":"2026-08-31T07:40:15.203855Z","steps":["trace[521158934] 'process raft request'  (duration: 87.585481ms)","trace[521158934] 'check and update compact revision'  (duration: 105.795099ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:40:15.20404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.6652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-28265a6d-e277-4373-9fba-f76b45b2efba\" ","response":"range_response_count:1 size:1293"}
{"level":"info","ts":"2026-08-31T07:40:15.20411Z","caller":"traceutil/trace.go:171","msg":"trace[1455760863] range","detail":"{range_begin:/registry/persistentvolumes/pvc-28265a6d-e277-4373-9fba-f76b45b2efba; range_end:; response_count:1; response_revision:5816; }","duration":"192.809123ms","start":"2026-08-31T07:40:15.011278Z","end":"2026-08-31T07:40:15.204087Z","steps":["trace[1455760863] 'agreement among raft nodes before linearized reading'  (duration: 192.575117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:40:15.204244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.924814ms","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-31T07:40:15.204294Z","caller":"traceutil/trace.go:171","msg":"trace[945360076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5816; }","duration":"111.021547ms","start":"2026-08-31T07:40:15.093258Z","end":"2026-08-31T07:40:15.204279Z","steps":["trace[945360076] 'agreement among raft nodes before linearized reading'  (duration: 110.723368ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:40:15.204281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.404607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-31T07:40:15.204395Z","caller":"traceutil/trace.go:171","msg":"trace[1878709057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5816; }","duration":"112.584061ms","start":"2026-08-31T07:40:15.091784Z","end":"2026-08-31T07:40:15.204368Z","steps":["trace[1878709057] 'agreement among raft nodes before linearized reading'  (duration: 112.160649ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:15.494018Z","caller":"traceutil/trace.go:171","msg":"trace[570281155] transaction","detail":"{read_only:false; response_revision:5817; number_of_response:1; }","duration":"284.556403ms","start":"2026-08-31T07:40:15.209426Z","end":"2026-08-31T07:40:15.493982Z","steps":["trace[570281155] 'process raft request'  (duration: 248.23725ms)","trace[570281155] 'compare'  (duration: 29.778536ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:40:15.494395Z","caller":"traceutil/trace.go:171","msg":"trace[2128123728] transaction","detail":"{read_only:false; response_revision:5818; number_of_response:1; }","duration":"284.352497ms","start":"2026-08-31T07:40:15.210017Z","end":"2026-08-31T07:40:15.494369Z","steps":["trace[2128123728] 'process raft request'  (duration: 283.891634ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:15.49458Z","caller":"traceutil/trace.go:171","msg":"trace[1283926353] transaction","detail":"{read_only:false; response_revision:5819; number_of_response:1; }","duration":"281.673621ms","start":"2026-08-31T07:40:15.212874Z","end":"2026-08-31T07:40:15.494547Z","steps":["trace[1283926353] 'process raft request'  (duration: 281.366823ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:15.494581Z","caller":"traceutil/trace.go:171","msg":"trace[1339594888] linearizableReadLoop","detail":"{readStateIndex:6044; appliedIndex:6041; }","duration":"281.619519ms","start":"2026-08-31T07:40:15.212925Z","end":"2026-08-31T07:40:15.494545Z","steps":["trace[1339594888] 'read index received'  (duration: 244.755121ms)","trace[1339594888] 'applied index is now lower than readState.Index'  (duration: 36.863088ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:40:15.495055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.976355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:40:15.495063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.105414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z94f4\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-08-31T07:40:15.495107Z","caller":"traceutil/trace.go:171","msg":"trace[1130221954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5820; }","duration":"124.114339ms","start":"2026-08-31T07:40:15.370977Z","end":"2026-08-31T07:40:15.495092Z","steps":["trace[1130221954] 'agreement among raft nodes before linearized reading'  (duration: 124.009027ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:15.495126Z","caller":"traceutil/trace.go:171","msg":"trace[1962374244] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z94f4; range_end:; response_count:1; response_revision:5820; }","duration":"282.217626ms","start":"2026-08-31T07:40:15.212889Z","end":"2026-08-31T07:40:15.495107Z","steps":["trace[1962374244] 'agreement among raft nodes before linearized reading'  (duration: 281.934818ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:40:15.552141Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3008,"took":"347.248406ms","hash":3013812762,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":29679616,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-31T07:40:15.552229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3013812762,"revision":3008,"compact-revision":-1}
{"level":"info","ts":"2026-08-31T07:40:27.871334Z","caller":"traceutil/trace.go:171","msg":"trace[417671929] transaction","detail":"{read_only:false; response_revision:5980; number_of_response:1; }","duration":"129.838392ms","start":"2026-08-31T07:40:27.741469Z","end":"2026-08-31T07:40:27.871307Z","steps":["trace[417671929] 'process raft request'  (duration: 120.462415ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:45:15.212056Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5816}
{"level":"info","ts":"2026-08-31T07:45:15.3034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5816,"took":"89.168735ms","hash":2115953871,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":26849280,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-31T07:45:15.303475Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2115953871,"revision":5816,"compact-revision":3008}
{"level":"info","ts":"2026-08-31T07:46:32.697625Z","caller":"traceutil/trace.go:171","msg":"trace[93565199] transaction","detail":"{read_only:false; response_revision:8698; number_of_response:1; }","duration":"205.351758ms","start":"2026-08-31T07:46:32.49225Z","end":"2026-08-31T07:46:32.697602Z","steps":["trace[93565199] 'process raft request'  (duration: 205.189983ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:46:32.922017Z","caller":"traceutil/trace.go:171","msg":"trace[733621733] transaction","detail":"{read_only:false; response_revision:8699; number_of_response:1; }","duration":"198.497155ms","start":"2026-08-31T07:46:32.723481Z","end":"2026-08-31T07:46:32.921978Z","steps":["trace[733621733] 'process raft request'  (duration: 168.123855ms)","trace[733621733] 'compare'  (duration: 29.875876ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:46:43.212627Z","caller":"traceutil/trace.go:171","msg":"trace[1072262484] transaction","detail":"{read_only:false; response_revision:8754; number_of_response:1; }","duration":"108.999294ms","start":"2026-08-31T07:46:43.103607Z","end":"2026-08-31T07:46:43.212606Z","steps":["trace[1072262484] 'process raft request'  (duration: 108.88264ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:46:43.61412Z","caller":"traceutil/trace.go:171","msg":"trace[320483559] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"115.423101ms","start":"2026-08-31T07:46:43.498671Z","end":"2026-08-31T07:46:43.614094Z","steps":["trace[320483559] 'process raft request'  (duration: 115.225335ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:46:43.958798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.344076ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616804903 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8746 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:46:43.958923Z","caller":"traceutil/trace.go:171","msg":"trace[1207995040] linearizableReadLoop","detail":"{readStateIndex:9073; appliedIndex:9072; }","duration":"339.481538ms","start":"2026-08-31T07:46:43.619424Z","end":"2026-08-31T07:46:43.958905Z","steps":["trace[1207995040] 'read index received'  (duration: 35.065248ms)","trace[1207995040] 'applied index is now lower than readState.Index'  (duration: 304.41467ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:46:43.959005Z","caller":"traceutil/trace.go:171","msg":"trace[1416764641] transaction","detail":"{read_only:false; response_revision:8756; number_of_response:1; }","duration":"340.875547ms","start":"2026-08-31T07:46:43.618086Z","end":"2026-08-31T07:46:43.958961Z","steps":["trace[1416764641] 'process raft request'  (duration: 36.253822ms)","trace[1416764641] 'compare'  (duration: 304.168871ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:46:43.95908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.628842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20312"}
{"level":"info","ts":"2026-08-31T07:46:43.95916Z","caller":"traceutil/trace.go:171","msg":"trace[1995467925] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8756; }","duration":"339.745274ms","start":"2026-08-31T07:46:43.619397Z","end":"2026-08-31T07:46:43.959142Z","steps":["trace[1995467925] 'agreement among raft nodes before linearized reading'  (duration: 339.573809ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:46:43.959199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:46:43.619387Z","time spent":"339.800117ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":20336,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-08-31T07:46:43.959203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:46:43.61806Z","time spent":"341.028692ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8746 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-31T07:46:43.973931Z","caller":"traceutil/trace.go:171","msg":"trace[1174694393] transaction","detail":"{read_only:false; response_revision:8757; number_of_response:1; }","duration":"326.039403ms","start":"2026-08-31T07:46:43.647868Z","end":"2026-08-31T07:46:43.973908Z","steps":["trace[1174694393] 'process raft request'  (duration: 325.93331ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:46:43.97405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:46:43.647834Z","time spent":"326.152227ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8747 > 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-31T07:46:43.998658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.667791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-31T07:46:43.998747Z","caller":"traceutil/trace.go:171","msg":"trace[1650752513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8757; }","duration":"213.806375ms","start":"2026-08-31T07:46:43.784923Z","end":"2026-08-31T07:46:43.998729Z","steps":["trace[1650752513] 'agreement among raft nodes before linearized reading'  (duration: 213.590729ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:46:55.111182Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b8.wal"}
{"level":"info","ts":"2026-08-31T07:47:10.922665Z","caller":"traceutil/trace.go:171","msg":"trace[1883355615] linearizableReadLoop","detail":"{readStateIndex:9279; appliedIndex:9278; }","duration":"110.156438ms","start":"2026-08-31T07:47:10.812489Z","end":"2026-08-31T07:47:10.922645Z","steps":["trace[1883355615] 'read index received'  (duration: 108.173929ms)","trace[1883355615] 'applied index is now lower than readState.Index'  (duration: 1.981709ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:47:10.922676Z","caller":"traceutil/trace.go:171","msg":"trace[163007698] transaction","detail":"{read_only:false; response_revision:8954; number_of_response:1; }","duration":"110.760926ms","start":"2026-08-31T07:47:10.811885Z","end":"2026-08-31T07:47:10.922646Z","steps":["trace[163007698] 'process raft request'  (duration: 108.765307ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:10.922998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.472678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/rook-ceph/csi-cephfsplugin\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:47:10.923145Z","caller":"traceutil/trace.go:171","msg":"trace[1092999295] range","detail":"{range_begin:/registry/daemonsets/rook-ceph/csi-cephfsplugin; range_end:; response_count:0; response_revision:8955; }","duration":"110.641803ms","start":"2026-08-31T07:47:10.812477Z","end":"2026-08-31T07:47:10.923119Z","steps":["trace[1092999295] 'agreement among raft nodes before linearized reading'  (duration: 110.248071ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:47:14.019143Z","caller":"traceutil/trace.go:171","msg":"trace[1026984232] transaction","detail":"{read_only:false; response_revision:8974; number_of_response:1; }","duration":"270.256329ms","start":"2026-08-31T07:47:13.74886Z","end":"2026-08-31T07:47:14.019116Z","steps":["trace[1026984232] 'process raft request'  (duration: 270.107425ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:47:14.258677Z","caller":"traceutil/trace.go:171","msg":"trace[875911790] linearizableReadLoop","detail":"{readStateIndex:9301; appliedIndex:9299; }","duration":"150.727727ms","start":"2026-08-31T07:47:14.107927Z","end":"2026-08-31T07:47:14.258655Z","steps":["trace[875911790] 'read index received'  (duration: 111.976341ms)","trace[875911790] 'applied index is now lower than readState.Index'  (duration: 38.750426ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:47:14.258806Z","caller":"traceutil/trace.go:171","msg":"trace[1449274674] transaction","detail":"{read_only:false; response_revision:8975; number_of_response:1; }","duration":"182.760976ms","start":"2026-08-31T07:47:14.076032Z","end":"2026-08-31T07:47:14.258793Z","steps":["trace[1449274674] 'process raft request'  (duration: 182.476068ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:14.259585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.631583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-31T07:47:14.25965Z","caller":"traceutil/trace.go:171","msg":"trace[1775895309] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8975; }","duration":"151.734436ms","start":"2026-08-31T07:47:14.107902Z","end":"2026-08-31T07:47:14.259637Z","steps":["trace[1775895309] 'agreement among raft nodes before linearized reading'  (duration: 151.560541ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:23.981161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.028441ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616805761 > lease_revoke:<id:4c14a056b9d3be15>","response":"size:29"}
{"level":"info","ts":"2026-08-31T07:47:24.481555Z","caller":"traceutil/trace.go:171","msg":"trace[18231349] linearizableReadLoop","detail":"{readStateIndex:9357; appliedIndex:9356; }","duration":"107.592318ms","start":"2026-08-31T07:47:24.373929Z","end":"2026-08-31T07:47:24.481521Z","steps":["trace[18231349] 'read index received'  (duration: 107.216146ms)","trace[18231349] 'applied index is now lower than readState.Index'  (duration: 374.732µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:47:24.481609Z","caller":"traceutil/trace.go:171","msg":"trace[938989616] transaction","detail":"{read_only:false; response_revision:9029; number_of_response:1; }","duration":"108.696562ms","start":"2026-08-31T07:47:24.372876Z","end":"2026-08-31T07:47:24.481572Z","steps":["trace[938989616] 'process raft request'  (duration: 108.412773ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:24.481754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.800034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:47:24.48183Z","caller":"traceutil/trace.go:171","msg":"trace[1828016239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9029; }","duration":"107.910237ms","start":"2026-08-31T07:47:24.373905Z","end":"2026-08-31T07:47:24.481815Z","steps":["trace[1828016239] 'agreement among raft nodes before linearized reading'  (duration: 107.780523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:28.723366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.267806ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616805855 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9038 > 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-31T07:47:28.723496Z","caller":"traceutil/trace.go:171","msg":"trace[36026948] linearizableReadLoop","detail":"{readStateIndex:9389; appliedIndex:9388; }","duration":"206.420081ms","start":"2026-08-31T07:47:28.517058Z","end":"2026-08-31T07:47:28.723478Z","steps":["trace[36026948] 'read index received'  (duration: 17.906607ms)","trace[36026948] 'applied index is now lower than readState.Index'  (duration: 188.512254ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:47:28.723497Z","caller":"traceutil/trace.go:171","msg":"trace[511289096] transaction","detail":"{read_only:false; response_revision:9060; number_of_response:1; }","duration":"226.718422ms","start":"2026-08-31T07:47:28.496761Z","end":"2026-08-31T07:47:28.72348Z","steps":["trace[511289096] 'process raft request'  (duration: 38.25214ms)","trace[511289096] 'compare'  (duration: 188.160373ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:47:28.723705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.601407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z94f4\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-08-31T07:47:28.723761Z","caller":"traceutil/trace.go:171","msg":"trace[92615664] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z94f4; range_end:; response_count:1; response_revision:9060; }","duration":"206.739811ms","start":"2026-08-31T07:47:28.517009Z","end":"2026-08-31T07:47:28.723749Z","steps":["trace[92615664] 'agreement among raft nodes before linearized reading'  (duration: 206.551765ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:28.72396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.07667ms","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-31T07:47:28.724002Z","caller":"traceutil/trace.go:171","msg":"trace[569798950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9060; }","duration":"197.158503ms","start":"2026-08-31T07:47:28.526831Z","end":"2026-08-31T07:47:28.72399Z","steps":["trace[569798950] 'agreement among raft nodes before linearized reading'  (duration: 196.943286ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:47:28.724028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.853463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-31T07:47:28.724025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.298543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-31T07:47:28.724113Z","caller":"traceutil/trace.go:171","msg":"trace[1297013727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9060; }","duration":"150.988917ms","start":"2026-08-31T07:47:28.573099Z","end":"2026-08-31T07:47:28.724088Z","steps":["trace[1297013727] 'agreement among raft nodes before linearized reading'  (duration: 150.744429ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:47:28.724124Z","caller":"traceutil/trace.go:171","msg":"trace[676166479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9060; }","duration":"148.453697ms","start":"2026-08-31T07:47:28.575648Z","end":"2026-08-31T07:47:28.724102Z","steps":["trace[676166479] 'agreement among raft nodes before linearized reading'  (duration: 148.143698ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:47:28.917107Z","caller":"traceutil/trace.go:171","msg":"trace[604702941] transaction","detail":"{read_only:false; response_revision:9062; number_of_response:1; }","duration":"187.491512ms","start":"2026-08-31T07:47:28.729588Z","end":"2026-08-31T07:47:28.917079Z","steps":["trace[604702941] 'process raft request'  (duration: 176.14961ms)","trace[604702941] 'compare'  (duration: 11.068974ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:47:28.917153Z","caller":"traceutil/trace.go:171","msg":"trace[1134841232] transaction","detail":"{read_only:false; response_revision:9063; number_of_response:1; }","duration":"187.501423ms","start":"2026-08-31T07:47:28.729626Z","end":"2026-08-31T07:47:28.917127Z","steps":["trace[1134841232] 'process raft request'  (duration: 187.372349ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:27.208926Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-31T07:48:27.22223Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-31T07:48:27.222321Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-31T07:48:41.412387Z","caller":"traceutil/trace.go:171","msg":"trace[535858482] linearizableReadLoop","detail":"{readStateIndex:10169; appliedIndex:10168; }","duration":"101.866708ms","start":"2026-08-31T07:48:41.3105Z","end":"2026-08-31T07:48:41.412366Z","steps":["trace[535858482] 'read index received'  (duration: 101.019934ms)","trace[535858482] 'applied index is now lower than readState.Index'  (duration: 845.974µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:48:41.412557Z","caller":"traceutil/trace.go:171","msg":"trace[510520261] transaction","detail":"{read_only:false; response_revision:9817; number_of_response:1; }","duration":"104.36595ms","start":"2026-08-31T07:48:41.308112Z","end":"2026-08-31T07:48:41.412478Z","steps":["trace[510520261] 'process raft request'  (duration: 103.492365ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:41.41281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.293491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:289500"}
{"level":"info","ts":"2026-08-31T07:48:41.412847Z","caller":"traceutil/trace.go:171","msg":"trace[1602322675] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9817; }","duration":"102.522437ms","start":"2026-08-31T07:48:41.310316Z","end":"2026-08-31T07:48:41.412839Z","steps":["trace[1602322675] 'agreement among raft nodes before linearized reading'  (duration: 102.126195ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:55.455332Z","caller":"traceutil/trace.go:171","msg":"trace[157325853] linearizableReadLoop","detail":"{readStateIndex:10250; appliedIndex:10249; }","duration":"125.170435ms","start":"2026-08-31T07:48:55.330136Z","end":"2026-08-31T07:48:55.455307Z","steps":["trace[157325853] 'read index received'  (duration: 124.98382ms)","trace[157325853] 'applied index is now lower than readState.Index'  (duration: 185.605µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:48:55.455632Z","caller":"traceutil/trace.go:171","msg":"trace[802123383] transaction","detail":"{read_only:false; response_revision:9895; number_of_response:1; }","duration":"126.74105ms","start":"2026-08-31T07:48:55.32865Z","end":"2026-08-31T07:48:55.455391Z","steps":["trace[802123383] 'process raft request'  (duration: 126.473333ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:55.455809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.607808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:48:55.455893Z","caller":"traceutil/trace.go:171","msg":"trace[1266876968] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:9895; }","duration":"125.775953ms","start":"2026-08-31T07:48:55.330094Z","end":"2026-08-31T07:48:55.45587Z","steps":["trace[1266876968] 'agreement among raft nodes before linearized reading'  (duration: 125.559567ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:55.577056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.837881ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808160 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9886 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:48:55.577272Z","caller":"traceutil/trace.go:171","msg":"trace[1151591830] transaction","detail":"{read_only:false; response_revision:9896; number_of_response:1; }","duration":"214.174196ms","start":"2026-08-31T07:48:55.363054Z","end":"2026-08-31T07:48:55.577228Z","steps":["trace[1151591830] 'process raft request'  (duration: 99.985545ms)","trace[1151591830] 'compare'  (duration: 113.46274ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:55.577331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.116955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:48:55.577393Z","caller":"traceutil/trace.go:171","msg":"trace[1567366550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9896; }","duration":"206.217658ms","start":"2026-08-31T07:48:55.371152Z","end":"2026-08-31T07:48:55.577369Z","steps":["trace[1567366550] 'agreement among raft nodes before linearized reading'  (duration: 206.102465ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:55.577199Z","caller":"traceutil/trace.go:171","msg":"trace[1716216496] linearizableReadLoop","detail":"{readStateIndex:10251; appliedIndex:10250; }","duration":"121.770069ms","start":"2026-08-31T07:48:55.455406Z","end":"2026-08-31T07:48:55.577176Z","steps":["trace[1716216496] 'read index received'  (duration: 7.562067ms)","trace[1716216496] 'applied index is now lower than readState.Index'  (duration: 114.206172ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:55.577543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.331545ms","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-31T07:48:55.577653Z","caller":"traceutil/trace.go:171","msg":"trace[1086633028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9896; }","duration":"211.48534ms","start":"2026-08-31T07:48:55.366148Z","end":"2026-08-31T07:48:55.577633Z","steps":["trace[1086633028] 'agreement among raft nodes before linearized reading'  (duration: 211.262904ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:55.577925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.248841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-31T07:48:55.57799Z","caller":"traceutil/trace.go:171","msg":"trace[434191357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9896; }","duration":"101.351953ms","start":"2026-08-31T07:48:55.476621Z","end":"2026-08-31T07:48:55.577973Z","steps":["trace[434191357] 'agreement among raft nodes before linearized reading'  (duration: 101.184309ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:56.912174Z","caller":"traceutil/trace.go:171","msg":"trace[1703961456] transaction","detail":"{read_only:false; response_revision:9903; number_of_response:1; }","duration":"177.069052ms","start":"2026-08-31T07:48:56.73507Z","end":"2026-08-31T07:48:56.912139Z","steps":["trace[1703961456] 'process raft request'  (duration: 176.881207ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:57.239533Z","caller":"traceutil/trace.go:171","msg":"trace[1658537941] transaction","detail":"{read_only:false; response_revision:9904; number_of_response:1; }","duration":"111.156634ms","start":"2026-08-31T07:48:57.12832Z","end":"2026-08-31T07:48:57.239477Z","steps":["trace[1658537941] 'process raft request'  (duration: 110.923618ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:57.239432Z","caller":"traceutil/trace.go:171","msg":"trace[1841020561] linearizableReadLoop","detail":"{readStateIndex:10259; appliedIndex:10258; }","duration":"110.477324ms","start":"2026-08-31T07:48:57.128926Z","end":"2026-08-31T07:48:57.239403Z","steps":["trace[1841020561] 'read index received'  (duration: 110.262748ms)","trace[1841020561] 'applied index is now lower than readState.Index'  (duration: 213.816µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:57.493881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.932665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-08-31T07:48:57.493967Z","caller":"traceutil/trace.go:171","msg":"trace[1788732303] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9904; }","duration":"365.070029ms","start":"2026-08-31T07:48:57.128876Z","end":"2026-08-31T07:48:57.493946Z","steps":["trace[1788732303] 'agreement among raft nodes before linearized reading'  (duration: 111.350949ms)","trace[1788732303] 'range keys from in-memory index tree'  (duration: 253.496813ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:57.493984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.514951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:48:57.49401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:57.128856Z","time spent":"365.14221ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-08-31T07:48:57.494073Z","caller":"traceutil/trace.go:171","msg":"trace[1528151878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9904; }","duration":"122.656235ms","start":"2026-08-31T07:48:57.371394Z","end":"2026-08-31T07:48:57.49405Z","steps":["trace[1528151878] 'range keys from in-memory index tree'  (duration: 122.425398ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:57.686776Z","caller":"traceutil/trace.go:171","msg":"trace[449205573] transaction","detail":"{read_only:false; response_revision:9906; number_of_response:1; }","duration":"101.153988ms","start":"2026-08-31T07:48:57.585557Z","end":"2026-08-31T07:48:57.686711Z","steps":["trace[449205573] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 91.840371ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.075793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.402612ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808196 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9898 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:48:58.076046Z","caller":"traceutil/trace.go:171","msg":"trace[2094326190] transaction","detail":"{read_only:false; response_revision:9908; number_of_response:1; }","duration":"383.655011ms","start":"2026-08-31T07:48:57.692352Z","end":"2026-08-31T07:48:58.076007Z","steps":["trace[2094326190] 'process raft request'  (duration: 205.924759ms)","trace[2094326190] 'compare'  (duration: 177.096623ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:58.076205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:57.692333Z","time spent":"383.786575ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9898 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-08-31T07:48:58.07632Z","caller":"traceutil/trace.go:171","msg":"trace[887073752] transaction","detail":"{read_only:false; response_revision:9909; number_of_response:1; }","duration":"365.78069ms","start":"2026-08-31T07:48:57.710423Z","end":"2026-08-31T07:48:58.076204Z","steps":["trace[887073752] 'process raft request'  (duration: 365.45622ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:58.076602Z","caller":"traceutil/trace.go:171","msg":"trace[944119163] transaction","detail":"{read_only:false; response_revision:9910; number_of_response:1; }","duration":"245.097892ms","start":"2026-08-31T07:48:57.831491Z","end":"2026-08-31T07:48:58.076588Z","steps":["trace[944119163] 'process raft request'  (duration: 244.509796ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.076676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:57.710385Z","time spent":"366.120719ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:9868 > 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":"info","ts":"2026-08-31T07:48:58.076749Z","caller":"traceutil/trace.go:171","msg":"trace[96038976] linearizableReadLoop","detail":"{readStateIndex:10265; appliedIndex:10262; }","duration":"230.212405ms","start":"2026-08-31T07:48:57.84649Z","end":"2026-08-31T07:48:58.076702Z","steps":["trace[96038976] 'read index received'  (duration: 51.849725ms)","trace[96038976] 'applied index is now lower than readState.Index'  (duration: 178.36048ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:58.076961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.457442ms","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-31T07:48:58.07704Z","caller":"traceutil/trace.go:171","msg":"trace[66375580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9910; }","duration":"230.595366ms","start":"2026-08-31T07:48:57.846427Z","end":"2026-08-31T07:48:58.077023Z","steps":["trace[66375580] 'agreement among raft nodes before linearized reading'  (duration: 230.359049ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.128822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.652677ms","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-31T07:48:58.128831Z","caller":"traceutil/trace.go:171","msg":"trace[67022306] transaction","detail":"{read_only:false; response_revision:9911; number_of_response:1; }","duration":"205.519668ms","start":"2026-08-31T07:48:57.923268Z","end":"2026-08-31T07:48:58.128787Z","steps":["trace[67022306] 'process raft request'  (duration: 205.099816ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:58.128893Z","caller":"traceutil/trace.go:171","msg":"trace[433877982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9911; }","duration":"246.780901ms","start":"2026-08-31T07:48:57.882096Z","end":"2026-08-31T07:48:58.128877Z","steps":["trace[433877982] 'agreement among raft nodes before linearized reading'  (duration: 246.392709ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.488081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.824528ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808204 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9901 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:48:58.488203Z","caller":"traceutil/trace.go:171","msg":"trace[715416532] linearizableReadLoop","detail":"{readStateIndex:10268; appliedIndex:10267; }","duration":"256.5479ms","start":"2026-08-31T07:48:58.231635Z","end":"2026-08-31T07:48:58.488183Z","steps":["trace[715416532] 'read index received'  (duration: 34.361µs)","trace[715416532] 'applied index is now lower than readState.Index'  (duration: 256.512029ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:58.488332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.726275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:48:58.48836Z","caller":"traceutil/trace.go:171","msg":"trace[293517792] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9913; }","duration":"256.789757ms","start":"2026-08-31T07:48:58.23156Z","end":"2026-08-31T07:48:58.488349Z","steps":["trace[293517792] 'agreement among raft nodes before linearized reading'  (duration: 256.725955ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:58.488319Z","caller":"traceutil/trace.go:171","msg":"trace[308213233] transaction","detail":"{read_only:false; response_revision:9913; number_of_response:1; }","duration":"354.9644ms","start":"2026-08-31T07:48:58.133299Z","end":"2026-08-31T07:48:58.488264Z","steps":["trace[308213233] 'process raft request'  (duration: 68.854923ms)","trace[308213233] 'compare'  (duration: 285.615463ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:58.488523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.315459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.32\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-08-31T07:48:58.488544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:58.133275Z","time spent":"355.143095ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9901 > 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-31T07:48:58.488602Z","caller":"traceutil/trace.go:171","msg":"trace[996103277] range","detail":"{range_begin:/registry/masterleases/162.253.55.32; range_end:; response_count:1; response_revision:9913; }","duration":"170.472444ms","start":"2026-08-31T07:48:58.318108Z","end":"2026-08-31T07:48:58.488581Z","steps":["trace[996103277] 'agreement among raft nodes before linearized reading'  (duration: 170.272928ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.488768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.329375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/glance-db-sync-25qmz\" ","response":"range_response_count:1 size:2757"}
{"level":"info","ts":"2026-08-31T07:48:58.488841Z","caller":"traceutil/trace.go:171","msg":"trace[1786023824] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/glance-db-sync-25qmz; range_end:; response_count:1; response_revision:9913; }","duration":"129.461308ms","start":"2026-08-31T07:48:58.359361Z","end":"2026-08-31T07:48:58.488822Z","steps":["trace[1786023824] 'agreement among raft nodes before linearized reading'  (duration: 129.231992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.830432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.117856ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808208 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:4c14a056b9d3c90f>","response":"size:41"}
{"level":"warn","ts":"2026-08-31T07:48:58.830579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:58.489914Z","time spent":"340.6606ms","remote":"127.0.0.1:37028","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-08-31T07:48:58.96322Z","caller":"traceutil/trace.go:171","msg":"trace[508394438] linearizableReadLoop","detail":"{readStateIndex:10271; appliedIndex:10269; }","duration":"216.732258ms","start":"2026-08-31T07:48:58.746461Z","end":"2026-08-31T07:48:58.963193Z","steps":["trace[508394438] 'read index received'  (duration: 215.74194ms)","trace[508394438] 'applied index is now lower than readState.Index'  (duration: 989.198µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:48:58.96335Z","caller":"traceutil/trace.go:171","msg":"trace[1868899053] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9914; }","duration":"472.086944ms","start":"2026-08-31T07:48:58.491234Z","end":"2026-08-31T07:48:58.963321Z","steps":["trace[1868899053] 'process raft request'  (duration: 470.87585ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.963641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:58.491212Z","time spent":"472.226348ms","remote":"127.0.0.1:34974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":70,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/openstack/glance-db-sync-25qmz\" mod_revision:9782 > success:<request_delete_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/glance-db-sync-25qmz\" > > failure:<request_range:<key:\"/registry/cilium.io/ciliumendpoints/openstack/glance-db-sync-25qmz\" > >"}
{"level":"warn","ts":"2026-08-31T07:48:58.963533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.063989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-db-sync-25qmz\" ","response":"range_response_count:1 size:6930"}
{"level":"info","ts":"2026-08-31T07:48:58.963741Z","caller":"traceutil/trace.go:171","msg":"trace[265464049] range","detail":"{range_begin:/registry/pods/openstack/glance-db-sync-25qmz; range_end:; response_count:1; response_revision:9915; }","duration":"217.287096ms","start":"2026-08-31T07:48:58.746413Z","end":"2026-08-31T07:48:58.9637Z","steps":["trace[265464049] 'agreement among raft nodes before linearized reading'  (duration: 216.969696ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:58.96394Z","caller":"traceutil/trace.go:171","msg":"trace[1531389417] transaction","detail":"{read_only:false; response_revision:9915; number_of_response:1; }","duration":"447.403428ms","start":"2026-08-31T07:48:58.516502Z","end":"2026-08-31T07:48:58.963906Z","steps":["trace[1531389417] 'process raft request'  (duration: 446.603375ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:58.964119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:48:58.516481Z","time spent":"447.543392ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9902 > 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-31T07:48:59.060331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.847968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:48:59.060334Z","caller":"traceutil/trace.go:171","msg":"trace[1661356570] transaction","detail":"{read_only:false; response_revision:9916; number_of_response:1; }","duration":"228.226327ms","start":"2026-08-31T07:48:58.832066Z","end":"2026-08-31T07:48:59.060292Z","steps":["trace[1661356570] 'process raft request'  (duration: 228.042192ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:59.060409Z","caller":"traceutil/trace.go:171","msg":"trace[5907670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9916; }","duration":"190.973821ms","start":"2026-08-31T07:48:58.869417Z","end":"2026-08-31T07:48:59.060391Z","steps":["trace[5907670] 'agreement among raft nodes before linearized reading'  (duration: 190.823517ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:59.163445Z","caller":"traceutil/trace.go:171","msg":"trace[101040178] linearizableReadLoop","detail":"{readStateIndex:10273; appliedIndex:10272; }","duration":"100.325905ms","start":"2026-08-31T07:48:59.063086Z","end":"2026-08-31T07:48:59.163412Z","steps":["trace[101040178] 'read index received'  (duration: 99.201022ms)","trace[101040178] 'applied index is now lower than readState.Index'  (duration: 1.123173ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:48:59.163521Z","caller":"traceutil/trace.go:171","msg":"trace[749237963] transaction","detail":"{read_only:false; response_revision:9917; number_of_response:1; }","duration":"183.308512ms","start":"2026-08-31T07:48:58.980188Z","end":"2026-08-31T07:48:59.163496Z","steps":["trace[749237963] 'process raft request'  (duration: 182.089877ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:48:59.163796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.688825ms","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-31T07:48:59.163857Z","caller":"traceutil/trace.go:171","msg":"trace[1577483202] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:9917; }","duration":"100.800568ms","start":"2026-08-31T07:48:59.063042Z","end":"2026-08-31T07:48:59.163842Z","steps":["trace[1577483202] 'agreement among raft nodes before linearized reading'  (duration: 100.540161ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:59.349357Z","caller":"traceutil/trace.go:171","msg":"trace[558997936] linearizableReadLoop","detail":"{readStateIndex:10274; appliedIndex:10273; }","duration":"181.16756ms","start":"2026-08-31T07:48:59.168166Z","end":"2026-08-31T07:48:59.349334Z","steps":["trace[558997936] 'read index received'  (duration: 155.144295ms)","trace[558997936] 'applied index is now lower than readState.Index'  (duration: 26.022365ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:48:59.349511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.325794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-31T07:48:59.349534Z","caller":"traceutil/trace.go:171","msg":"trace[218367151] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:9918; }","duration":"181.368335ms","start":"2026-08-31T07:48:59.168158Z","end":"2026-08-31T07:48:59.349527Z","steps":["trace[218367151] 'agreement among raft nodes before linearized reading'  (duration: 181.253442ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:48:59.349661Z","caller":"traceutil/trace.go:171","msg":"trace[1645457699] transaction","detail":"{read_only:false; response_revision:9918; number_of_response:1; }","duration":"182.866478ms","start":"2026-08-31T07:48:59.166734Z","end":"2026-08-31T07:48:59.3496Z","steps":["trace[1645457699] 'process raft request'  (duration: 156.72793ms)","trace[1645457699] 'compare'  (duration: 25.776888ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:48:59.357205Z","caller":"traceutil/trace.go:171","msg":"trace[1925620221] transaction","detail":"{read_only:false; response_revision:9919; number_of_response:1; }","duration":"110.862846ms","start":"2026-08-31T07:48:59.246322Z","end":"2026-08-31T07:48:59.357185Z","steps":["trace[1925620221] 'process raft request'  (duration: 110.754043ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:00.018038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.798087ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808228 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9906 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:49:00.018151Z","caller":"traceutil/trace.go:171","msg":"trace[915675781] linearizableReadLoop","detail":"{readStateIndex:10278; appliedIndex:10277; }","duration":"202.039188ms","start":"2026-08-31T07:48:59.816095Z","end":"2026-08-31T07:49:00.018134Z","steps":["trace[915675781] 'read index received'  (duration: 101.061326ms)","trace[915675781] 'applied index is now lower than readState.Index'  (duration: 100.976372ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:00.018252Z","caller":"traceutil/trace.go:171","msg":"trace[766578513] transaction","detail":"{read_only:false; response_revision:9922; number_of_response:1; }","duration":"228.990781ms","start":"2026-08-31T07:48:59.789225Z","end":"2026-08-31T07:49:00.018216Z","steps":["trace[766578513] 'process raft request'  (duration: 127.911125ms)","trace[766578513] 'compare'  (duration: 100.54231ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:00.018338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.788093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:00.018426Z","caller":"traceutil/trace.go:171","msg":"trace[161900109] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:9922; }","duration":"221.941768ms","start":"2026-08-31T07:48:59.796463Z","end":"2026-08-31T07:49:00.018405Z","steps":["trace[161900109] 'agreement among raft nodes before linearized reading'  (duration: 221.758743ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.236154Z","caller":"traceutil/trace.go:171","msg":"trace[280156127] transaction","detail":"{read_only:false; response_revision:9923; number_of_response:1; }","duration":"155.048543ms","start":"2026-08-31T07:49:00.081078Z","end":"2026-08-31T07:49:00.236127Z","steps":["trace[280156127] 'process raft request'  (duration: 154.864038ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.380376Z","caller":"traceutil/trace.go:171","msg":"trace[1779025998] transaction","detail":"{read_only:false; response_revision:9924; number_of_response:1; }","duration":"296.33405ms","start":"2026-08-31T07:49:00.084005Z","end":"2026-08-31T07:49:00.380339Z","steps":["trace[1779025998] 'process raft request'  (duration: 246.985347ms)","trace[1779025998] 'compare'  (duration: 49.130767ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:00.380501Z","caller":"traceutil/trace.go:171","msg":"trace[293441513] linearizableReadLoop","detail":"{readStateIndex:10280; appliedIndex:10278; }","duration":"210.067169ms","start":"2026-08-31T07:49:00.170406Z","end":"2026-08-31T07:49:00.380473Z","steps":["trace[293441513] 'read index received'  (duration: 65.455337ms)","trace[293441513] 'applied index is now lower than readState.Index'  (duration: 144.610762ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:00.380635Z","caller":"traceutil/trace.go:171","msg":"trace[1110740176] transaction","detail":"{read_only:false; response_revision:9925; number_of_response:1; }","duration":"206.109734ms","start":"2026-08-31T07:49:00.174493Z","end":"2026-08-31T07:49:00.380603Z","steps":["trace[1110740176] 'process raft request'  (duration: 205.768975ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:00.38088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.131665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-31T07:49:00.380943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.536982ms","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-31T07:49:00.380974Z","caller":"traceutil/trace.go:171","msg":"trace[471055815] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:9925; }","duration":"125.288189ms","start":"2026-08-31T07:49:00.255665Z","end":"2026-08-31T07:49:00.380954Z","steps":["trace[471055815] 'agreement among raft nodes before linearized reading'  (duration: 125.093464ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.380993Z","caller":"traceutil/trace.go:171","msg":"trace[1138122715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9925; }","duration":"210.649556ms","start":"2026-08-31T07:49:00.170329Z","end":"2026-08-31T07:49:00.380978Z","steps":["trace[1138122715] 'agreement among raft nodes before linearized reading'  (duration: 210.452849ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.735215Z","caller":"traceutil/trace.go:171","msg":"trace[1052619935] linearizableReadLoop","detail":"{readStateIndex:10283; appliedIndex:10282; }","duration":"241.642022ms","start":"2026-08-31T07:49:00.493551Z","end":"2026-08-31T07:49:00.735193Z","steps":["trace[1052619935] 'read index received'  (duration: 241.417076ms)","trace[1052619935] 'applied index is now lower than readState.Index'  (duration: 224.136µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:00.735542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.979102ms","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":"warn","ts":"2026-08-31T07:49:00.735605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.603118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:00.735646Z","caller":"traceutil/trace.go:171","msg":"trace[2012402325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9927; }","duration":"242.131686ms","start":"2026-08-31T07:49:00.493497Z","end":"2026-08-31T07:49:00.735628Z","steps":["trace[2012402325] 'agreement among raft nodes before linearized reading'  (duration: 241.858879ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.735678Z","caller":"traceutil/trace.go:171","msg":"trace[1503245389] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:9927; }","duration":"133.734501ms","start":"2026-08-31T07:49:00.601929Z","end":"2026-08-31T07:49:00.735664Z","steps":["trace[1503245389] 'agreement among raft nodes before linearized reading'  (duration: 133.526526ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.735763Z","caller":"traceutil/trace.go:171","msg":"trace[1279728369] transaction","detail":"{read_only:false; response_revision:9927; number_of_response:1; }","duration":"344.234561ms","start":"2026-08-31T07:49:00.391354Z","end":"2026-08-31T07:49:00.735589Z","steps":["trace[1279728369] 'process raft request'  (duration: 343.711956ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:00.735774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.215819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:49:00.735969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:00.391338Z","time spent":"344.547041ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6815,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/glance-db-sync-25qmz\" mod_revision:9917 > success:<request_put:<key:\"/registry/pods/openstack/glance-db-sync-25qmz\" value_size:6762 >> failure:<request_range:<key:\"/registry/pods/openstack/glance-db-sync-25qmz\" > >"}
{"level":"info","ts":"2026-08-31T07:49:00.736035Z","caller":"traceutil/trace.go:171","msg":"trace[2078661503] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:9927; }","duration":"101.555069ms","start":"2026-08-31T07:49:00.634455Z","end":"2026-08-31T07:49:00.73601Z","steps":["trace[2078661503] 'agreement among raft nodes before linearized reading'  (duration: 101.132617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:00.952094Z","caller":"traceutil/trace.go:171","msg":"trace[1220858255] linearizableReadLoop","detail":"{readStateIndex:10285; appliedIndex:10284; }","duration":"143.550862ms","start":"2026-08-31T07:49:00.808513Z","end":"2026-08-31T07:49:00.952063Z","steps":["trace[1220858255] 'read index received'  (duration: 133.395302ms)","trace[1220858255] 'applied index is now lower than readState.Index'  (duration: 10.15412ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:00.952118Z","caller":"traceutil/trace.go:171","msg":"trace[1935378498] transaction","detail":"{read_only:false; response_revision:9929; number_of_response:1; }","duration":"208.680439ms","start":"2026-08-31T07:49:00.743398Z","end":"2026-08-31T07:49:00.952078Z","steps":["trace[1935378498] 'process raft request'  (duration: 198.513658ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:00.952356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.829041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-5d4684f59d-nqs97.18d0d43616375cef\" ","response":"range_response_count:1 size:1134"}
{"level":"info","ts":"2026-08-31T07:49:00.952449Z","caller":"traceutil/trace.go:171","msg":"trace[1700956399] range","detail":"{range_begin:/registry/events/openstack/barbican-api-5d4684f59d-nqs97.18d0d43616375cef; range_end:; response_count:1; response_revision:9929; }","duration":"143.965184ms","start":"2026-08-31T07:49:00.808461Z","end":"2026-08-31T07:49:00.952426Z","steps":["trace[1700956399] 'agreement among raft nodes before linearized reading'  (duration: 143.733028ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.196202Z","caller":"traceutil/trace.go:171","msg":"trace[796809879] linearizableReadLoop","detail":"{readStateIndex:10286; appliedIndex:10285; }","duration":"243.982581ms","start":"2026-08-31T07:49:00.952183Z","end":"2026-08-31T07:49:01.196165Z","steps":["trace[796809879] 'read index received'  (duration: 228.196739ms)","trace[796809879] 'applied index is now lower than readState.Index'  (duration: 15.784391ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:01.196666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.847136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:01.196764Z","caller":"traceutil/trace.go:171","msg":"trace[1649091712] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:9930; }","duration":"348.007941ms","start":"2026-08-31T07:49:00.848717Z","end":"2026-08-31T07:49:01.196725Z","steps":["trace[1649091712] 'agreement among raft nodes before linearized reading'  (duration: 347.831406ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.19653Z","caller":"traceutil/trace.go:171","msg":"trace[1695644137] transaction","detail":"{read_only:false; response_revision:9930; number_of_response:1; }","duration":"350.76229ms","start":"2026-08-31T07:49:00.845714Z","end":"2026-08-31T07:49:01.196476Z","steps":["trace[1695644137] 'process raft request'  (duration: 334.516214ms)","trace[1695644137] 'compare'  (duration: 15.791782ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:01.196864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:00.848704Z","time spent":"348.135864ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-08-31T07:49:01.19703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:00.845685Z","time spent":"351.223263ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:9870 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-08-31T07:49:01.208511Z","caller":"traceutil/trace.go:171","msg":"trace[699958371] transaction","detail":"{read_only:false; response_revision:9931; number_of_response:1; }","duration":"253.187803ms","start":"2026-08-31T07:49:00.955296Z","end":"2026-08-31T07:49:01.208484Z","steps":["trace[699958371] 'process raft request'  (duration: 252.937896ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.2086Z","caller":"traceutil/trace.go:171","msg":"trace[690189575] transaction","detail":"{read_only:false; response_revision:9932; number_of_response:1; }","duration":"251.535107ms","start":"2026-08-31T07:49:00.956995Z","end":"2026-08-31T07:49:01.20853Z","steps":["trace[690189575] 'process raft request'  (duration: 251.394203ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.208857Z","caller":"traceutil/trace.go:171","msg":"trace[2051579337] transaction","detail":"{read_only:false; response_revision:9933; number_of_response:1; }","duration":"239.609355ms","start":"2026-08-31T07:49:00.969231Z","end":"2026-08-31T07:49:01.20884Z","steps":["trace[2051579337] 'process raft request'  (duration: 239.203563ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:01.208867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.962675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/glance-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:01.208929Z","caller":"traceutil/trace.go:171","msg":"trace[108618052] range","detail":"{range_begin:/registry/jobs/openstack/glance-rabbit-init; range_end:; response_count:0; response_revision:9933; }","duration":"240.082579ms","start":"2026-08-31T07:49:00.968827Z","end":"2026-08-31T07:49:01.208909Z","steps":["trace[108618052] 'agreement among raft nodes before linearized reading'  (duration: 239.917104ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.450307Z","caller":"traceutil/trace.go:171","msg":"trace[137124215] transaction","detail":"{read_only:false; response_revision:9934; number_of_response:1; }","duration":"210.765898ms","start":"2026-08-31T07:49:01.239516Z","end":"2026-08-31T07:49:01.450282Z","steps":["trace[137124215] 'process raft request'  (duration: 208.07726ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.638675Z","caller":"traceutil/trace.go:171","msg":"trace[441108716] linearizableReadLoop","detail":"{readStateIndex:10291; appliedIndex:10291; }","duration":"175.895258ms","start":"2026-08-31T07:49:01.462763Z","end":"2026-08-31T07:49:01.638658Z","steps":["trace[441108716] 'read index received'  (duration: 175.884798ms)","trace[441108716] 'applied index is now lower than readState.Index'  (duration: 8.73µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:01.638726Z","caller":"traceutil/trace.go:171","msg":"trace[1498306694] transaction","detail":"{read_only:false; response_revision:9935; number_of_response:1; }","duration":"276.436499ms","start":"2026-08-31T07:49:01.362114Z","end":"2026-08-31T07:49:01.63855Z","steps":["trace[1498306694] 'process raft request'  (duration: 276.287605ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:01.638818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.038873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:01.638902Z","caller":"traceutil/trace.go:171","msg":"trace[2093482604] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:9935; }","duration":"176.169597ms","start":"2026-08-31T07:49:01.462711Z","end":"2026-08-31T07:49:01.638881Z","steps":["trace[2093482604] 'agreement among raft nodes before linearized reading'  (duration: 176.024422ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:01.878345Z","caller":"traceutil/trace.go:171","msg":"trace[1808822054] transaction","detail":"{read_only:false; response_revision:9937; number_of_response:1; }","duration":"237.579857ms","start":"2026-08-31T07:49:01.640726Z","end":"2026-08-31T07:49:01.878305Z","steps":["trace[1808822054] 'process raft request'  (duration: 199.383172ms)","trace[1808822054] 'compare'  (duration: 37.862825ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:02.056286Z","caller":"traceutil/trace.go:171","msg":"trace[1133722467] transaction","detail":"{read_only:false; response_revision:9939; number_of_response:1; }","duration":"123.643103ms","start":"2026-08-31T07:49:01.932594Z","end":"2026-08-31T07:49:02.056237Z","steps":["trace[1133722467] 'process raft request'  (duration: 84.914203ms)","trace[1133722467] 'compare'  (duration: 37.866675ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:02.413099Z","caller":"traceutil/trace.go:171","msg":"trace[1035031421] transaction","detail":"{read_only:false; response_revision:9943; number_of_response:1; }","duration":"351.067367ms","start":"2026-08-31T07:49:02.062015Z","end":"2026-08-31T07:49:02.413083Z","steps":["trace[1035031421] 'process raft request'  (duration: 351.000955ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:02.413217Z","caller":"traceutil/trace.go:171","msg":"trace[383545291] transaction","detail":"{read_only:false; response_revision:9942; number_of_response:1; }","duration":"351.914582ms","start":"2026-08-31T07:49:02.061263Z","end":"2026-08-31T07:49:02.413177Z","steps":["trace[383545291] 'process raft request'  (duration: 351.681786ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.413276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.061998Z","time spent":"351.189011ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4856,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/glance-rabbit-init\" mod_revision:9937 > success:<request_put:<key:\"/registry/jobs/openstack/glance-rabbit-init\" value_size:4805 >> failure:<request_range:<key:\"/registry/jobs/openstack/glance-rabbit-init\" > >"}
{"level":"warn","ts":"2026-08-31T07:49:02.413372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.061235Z","time spent":"352.068896ms","remote":"127.0.0.1:37082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":679,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/glance-rabbit-init.18d0d45ba010d18d\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/glance-rabbit-init.18d0d45ba010d18d\" value_size:599 lease:5482182940762031891 >> failure:<>"}
{"level":"info","ts":"2026-08-31T07:49:02.413097Z","caller":"traceutil/trace.go:171","msg":"trace[2038451342] transaction","detail":"{read_only:false; response_revision:9941; number_of_response:1; }","duration":"351.83073ms","start":"2026-08-31T07:49:02.061232Z","end":"2026-08-31T07:49:02.413062Z","steps":["trace[2038451342] 'process raft request'  (duration: 351.544502ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.413695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.061208Z","time spent":"352.438377ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:9922 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-31T07:49:02.673703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.865971ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808271 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/glance-rabbit-init-jfh4x.18d0d45ba48dc466\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/glance-rabbit-init-jfh4x.18d0d45ba48dc466\" value_size:626 lease:5482182940762031891 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:49:02.673898Z","caller":"traceutil/trace.go:171","msg":"trace[1274227993] linearizableReadLoop","detail":"{readStateIndex:10300; appliedIndex:10296; }","duration":"529.369895ms","start":"2026-08-31T07:49:02.144508Z","end":"2026-08-31T07:49:02.673878Z","steps":["trace[1274227993] 'read index received'  (duration: 268.250825ms)","trace[1274227993] 'applied index is now lower than readState.Index'  (duration: 261.11802ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:02.673981Z","caller":"traceutil/trace.go:171","msg":"trace[520282198] transaction","detail":"{read_only:false; response_revision:9945; number_of_response:1; }","duration":"431.76355ms","start":"2026-08-31T07:49:02.242207Z","end":"2026-08-31T07:49:02.673971Z","steps":["trace[520282198] 'process raft request'  (duration: 431.584915ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.674063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.242182Z","time spent":"431.820991ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9923 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-31T07:49:02.67411Z","caller":"traceutil/trace.go:171","msg":"trace[977928298] transaction","detail":"{read_only:false; response_revision:9944; number_of_response:1; }","duration":"537.247172ms","start":"2026-08-31T07:49:02.136832Z","end":"2026-08-31T07:49:02.674079Z","steps":["trace[977928298] 'process raft request'  (duration: 428.898037ms)","trace[977928298] 'compare'  (duration: 107.741678ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:02.67424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.136806Z","time spent":"537.371996ms","remote":"127.0.0.1:37082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/glance-rabbit-init-jfh4x.18d0d45ba48dc466\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/glance-rabbit-init-jfh4x.18d0d45ba48dc466\" value_size:626 lease:5482182940762031891 >> failure:<>"}
{"level":"warn","ts":"2026-08-31T07:49:02.674263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.782598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:49:02.674346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.754422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-08-31T07:49:02.674435Z","caller":"traceutil/trace.go:171","msg":"trace[1311703692] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9945; }","duration":"155.878305ms","start":"2026-08-31T07:49:02.518539Z","end":"2026-08-31T07:49:02.674417Z","steps":["trace[1311703692] 'agreement among raft nodes before linearized reading'  (duration: 155.636559ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.674533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.162169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-31T07:49:02.674555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.011144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-rabbit-init-jfh4x\" ","response":"range_response_count:1 size:5111"}
{"level":"info","ts":"2026-08-31T07:49:02.674587Z","caller":"traceutil/trace.go:171","msg":"trace[288738158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9945; }","duration":"211.278363ms","start":"2026-08-31T07:49:02.46329Z","end":"2026-08-31T07:49:02.674569Z","steps":["trace[288738158] 'agreement among raft nodes before linearized reading'  (duration: 211.098428ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:02.674648Z","caller":"traceutil/trace.go:171","msg":"trace[2144370901] range","detail":"{range_begin:/registry/pods/openstack/glance-rabbit-init-jfh4x; range_end:; response_count:1; response_revision:9945; }","duration":"530.146058ms","start":"2026-08-31T07:49:02.144462Z","end":"2026-08-31T07:49:02.674608Z","steps":["trace[2144370901] 'agreement among raft nodes before linearized reading'  (duration: 529.941582ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:02.674366Z","caller":"traceutil/trace.go:171","msg":"trace[580360729] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:9945; }","duration":"492.945682ms","start":"2026-08-31T07:49:02.181401Z","end":"2026-08-31T07:49:02.674346Z","steps":["trace[580360729] 'agreement among raft nodes before linearized reading'  (duration: 492.767027ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.674686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.144442Z","time spent":"530.23521ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":5135,"request content":"key:\"/registry/pods/openstack/glance-rabbit-init-jfh4x\" "}
{"level":"warn","ts":"2026-08-31T07:49:02.674719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.18138Z","time spent":"493.316432ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-08-31T07:49:02.674728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.911607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:02.674784Z","caller":"traceutil/trace.go:171","msg":"trace[642073397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9945; }","duration":"304.025009ms","start":"2026-08-31T07:49:02.370744Z","end":"2026-08-31T07:49:02.674769Z","steps":["trace[642073397] 'agreement among raft nodes before linearized reading'  (duration: 303.923336ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.674822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.370726Z","time spent":"304.087682ms","remote":"127.0.0.1:36978","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-31T07:49:02.674892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.541129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/glance-rabbit-init\" ","response":"range_response_count:1 size:538"}
{"level":"info","ts":"2026-08-31T07:49:02.674925Z","caller":"traceutil/trace.go:171","msg":"trace[1938779615] range","detail":"{range_begin:/registry/serviceaccounts/openstack/glance-rabbit-init; range_end:; response_count:1; response_revision:9945; }","duration":"352.632842ms","start":"2026-08-31T07:49:02.322282Z","end":"2026-08-31T07:49:02.674915Z","steps":["trace[1938779615] 'agreement among raft nodes before linearized reading'  (duration: 352.529019ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.674906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.886324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-31T07:49:02.674954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.322264Z","time spent":"352.682654ms","remote":"127.0.0.1:37234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":562,"request content":"key:\"/registry/serviceaccounts/openstack/glance-rabbit-init\" "}
{"level":"info","ts":"2026-08-31T07:49:02.674974Z","caller":"traceutil/trace.go:171","msg":"trace[1337132252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9945; }","duration":"290.026659ms","start":"2026-08-31T07:49:02.384929Z","end":"2026-08-31T07:49:02.674956Z","steps":["trace[1337132252] 'agreement among raft nodes before linearized reading'  (duration: 289.868194ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:02.980123Z","caller":"traceutil/trace.go:171","msg":"trace[833591608] linearizableReadLoop","detail":"{readStateIndex:10304; appliedIndex:10301; }","duration":"226.029725ms","start":"2026-08-31T07:49:02.754065Z","end":"2026-08-31T07:49:02.980095Z","steps":["trace[833591608] 'read index received'  (duration: 17.974694ms)","trace[833591608] 'applied index is now lower than readState.Index'  (duration: 208.053971ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:02.980301Z","caller":"traceutil/trace.go:171","msg":"trace[1721595724] transaction","detail":"{read_only:false; response_revision:9948; number_of_response:1; }","duration":"297.120692ms","start":"2026-08-31T07:49:02.683162Z","end":"2026-08-31T07:49:02.980282Z","steps":["trace[1721595724] 'process raft request'  (duration: 296.861055ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.980542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.444446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:02.980657Z","caller":"traceutil/trace.go:171","msg":"trace[1293472668] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9948; }","duration":"226.587ms","start":"2026-08-31T07:49:02.75402Z","end":"2026-08-31T07:49:02.980607Z","steps":["trace[1293472668] 'agreement among raft nodes before linearized reading'  (duration: 226.430666ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:02.980526Z","caller":"traceutil/trace.go:171","msg":"trace[1605643112] transaction","detail":"{read_only:false; response_revision:9947; number_of_response:1; }","duration":"300.155409ms","start":"2026-08-31T07:49:02.680332Z","end":"2026-08-31T07:49:02.980488Z","steps":["trace[1605643112] 'process raft request'  (duration: 299.525221ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:02.980816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:02.680311Z","time spent":"300.415428ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9924 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-31T07:49:02.9809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.14675ms","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-31T07:49:02.980997Z","caller":"traceutil/trace.go:171","msg":"trace[1578500712] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9948; }","duration":"210.295094ms","start":"2026-08-31T07:49:02.770677Z","end":"2026-08-31T07:49:02.980973Z","steps":["trace[1578500712] 'agreement among raft nodes before linearized reading'  (duration: 209.751938ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:03.840353Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14705554977616808289,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-31T07:49:04.054274Z","caller":"traceutil/trace.go:171","msg":"trace[1383767986] transaction","detail":"{read_only:false; response_revision:9951; number_of_response:1; }","duration":"839.561542ms","start":"2026-08-31T07:49:03.214683Z","end":"2026-08-31T07:49:04.054245Z","steps":["trace[1383767986] 'process raft request'  (duration: 838.718387ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.054414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.214655Z","time spent":"839.681456ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9933 > 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-31T07:49:04.504413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.033935ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808291 > lease_revoke:<id:4c14a056b9d3c877>","response":"size:29"}
{"level":"info","ts":"2026-08-31T07:49:04.504837Z","caller":"traceutil/trace.go:171","msg":"trace[1965980266] transaction","detail":"{read_only:false; response_revision:9952; number_of_response:1; }","duration":"861.255925ms","start":"2026-08-31T07:49:03.643558Z","end":"2026-08-31T07:49:04.504814Z","steps":["trace[1965980266] 'process raft request'  (duration: 860.964056ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.504977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.643532Z","time spent":"861.362308ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9935 > 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-31T07:49:04.505174Z","caller":"traceutil/trace.go:171","msg":"trace[859161951] transaction","detail":"{read_only:false; response_revision:9953; number_of_response:1; }","duration":"842.575529ms","start":"2026-08-31T07:49:03.662551Z","end":"2026-08-31T07:49:04.505127Z","steps":["trace[859161951] 'process raft request'  (duration: 842.190418ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:04.505295Z","caller":"traceutil/trace.go:171","msg":"trace[1921610935] linearizableReadLoop","detail":"{readStateIndex:10310; appliedIndex:10306; }","duration":"1.165595313s","start":"2026-08-31T07:49:03.339678Z","end":"2026-08-31T07:49:04.505273Z","steps":["trace[1921610935] 'read index received'  (duration: 714.394466ms)","trace[1921610935] 'applied index is now lower than readState.Index'  (duration: 451.199767ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:04.50533Z","caller":"traceutil/trace.go:171","msg":"trace[1210160678] transaction","detail":"{read_only:false; response_revision:9954; number_of_response:1; }","duration":"597.547879ms","start":"2026-08-31T07:49:03.907742Z","end":"2026-08-31T07:49:04.50529Z","steps":["trace[1210160678] 'process raft request'  (duration: 597.257081ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.505391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.662521Z","time spent":"842.757344ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:9936 > 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-31T07:49:04.505476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.165787619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:04.505556Z","caller":"traceutil/trace.go:171","msg":"trace[295282344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:9954; }","duration":"1.165928242s","start":"2026-08-31T07:49:03.339605Z","end":"2026-08-31T07:49:04.505534Z","steps":["trace[295282344] 'agreement among raft nodes before linearized reading'  (duration: 1.165779348s)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.505494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.907702Z","time spent":"597.721145ms","remote":"127.0.0.1:35010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2257,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/32942\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/32942\" value_size:2207 >> failure:<>"}
{"level":"warn","ts":"2026-08-31T07:49:04.505613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.339581Z","time spent":"1.166016905s","remote":"127.0.0.1:43982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-08-31T07:49:04.505695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.518013ms","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-31T07:49:04.505732Z","caller":"traceutil/trace.go:171","msg":"trace[2050132117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9954; }","duration":"571.602045ms","start":"2026-08-31T07:49:03.93412Z","end":"2026-08-31T07:49:04.505722Z","steps":["trace[2050132117] 'agreement among raft nodes before linearized reading'  (duration: 571.41087ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.505763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.934102Z","time spent":"571.655157ms","remote":"127.0.0.1:37288","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-31T07:49:04.50557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.424161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:49:04.505823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.017539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-31T07:49:04.50586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.153158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z94f4\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-08-31T07:49:04.505881Z","caller":"traceutil/trace.go:171","msg":"trace[529233889] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:9954; }","duration":"771.087081ms","start":"2026-08-31T07:49:03.734781Z","end":"2026-08-31T07:49:04.505868Z","steps":["trace[529233889] 'agreement among raft nodes before linearized reading'  (duration: 770.625028ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:04.505846Z","caller":"traceutil/trace.go:171","msg":"trace[1319199788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9954; }","duration":"134.784391ms","start":"2026-08-31T07:49:04.371039Z","end":"2026-08-31T07:49:04.505824Z","steps":["trace[1319199788] 'agreement among raft nodes before linearized reading'  (duration: 134.38432ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.505921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.734661Z","time spent":"771.246735ms","remote":"127.0.0.1:37370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":88,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"info","ts":"2026-08-31T07:49:04.506066Z","caller":"traceutil/trace.go:171","msg":"trace[1396062431] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z94f4; range_end:; response_count:1; response_revision:9954; }","duration":"611.497148ms","start":"2026-08-31T07:49:03.894525Z","end":"2026-08-31T07:49:04.506022Z","steps":["trace[1396062431] 'agreement among raft nodes before linearized reading'  (duration: 610.926842ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.50622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.894502Z","time spent":"611.699954ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6471,"request content":"key:\"/registry/pods/openstack/keepalived-z94f4\" "}
{"level":"warn","ts":"2026-08-31T07:49:04.505817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.066202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:04.506571Z","caller":"traceutil/trace.go:171","msg":"trace[1577197234] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:9954; }","duration":"725.953818ms","start":"2026-08-31T07:49:03.780594Z","end":"2026-08-31T07:49:04.506548Z","steps":["trace[1577197234] 'agreement among raft nodes before linearized reading'  (duration: 724.951339ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.507321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:03.780567Z","time spent":"726.046381ms","remote":"127.0.0.1:37404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "}
{"level":"info","ts":"2026-08-31T07:49:04.628208Z","caller":"traceutil/trace.go:171","msg":"trace[838189138] linearizableReadLoop","detail":"{readStateIndex:10313; appliedIndex:10311; }","duration":"114.226323ms","start":"2026-08-31T07:49:04.513959Z","end":"2026-08-31T07:49:04.628185Z","steps":["trace[838189138] 'read index received'  (duration: 50.874688ms)","trace[838189138] 'applied index is now lower than readState.Index'  (duration: 63.350735ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:04.628251Z","caller":"traceutil/trace.go:171","msg":"trace[1597255999] transaction","detail":"{read_only:false; response_revision:9956; number_of_response:1; }","duration":"116.507009ms","start":"2026-08-31T07:49:04.511703Z","end":"2026-08-31T07:49:04.62821Z","steps":["trace[1597255999] 'process raft request'  (duration: 97.37407ms)","trace[1597255999] 'compare'  (duration: 18.919003ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:04.628439Z","caller":"traceutil/trace.go:171","msg":"trace[232425315] transaction","detail":"{read_only:false; response_revision:9957; number_of_response:1; }","duration":"111.818843ms","start":"2026-08-31T07:49:04.516589Z","end":"2026-08-31T07:49:04.628408Z","steps":["trace[232425315] 'process raft request'  (duration: 111.539735ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:04.628922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.934583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:32 size:295798"}
{"level":"info","ts":"2026-08-31T07:49:04.629018Z","caller":"traceutil/trace.go:171","msg":"trace[1705286416] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:32; response_revision:9957; }","duration":"115.086667ms","start":"2026-08-31T07:49:04.513914Z","end":"2026-08-31T07:49:04.629Z","steps":["trace[1705286416] 'agreement among raft nodes before linearized reading'  (duration: 114.517121ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:06.94161Z","caller":"traceutil/trace.go:171","msg":"trace[909372506] linearizableReadLoop","detail":"{readStateIndex:10329; appliedIndex:10328; }","duration":"287.154486ms","start":"2026-08-31T07:49:06.65443Z","end":"2026-08-31T07:49:06.941584Z","steps":["trace[909372506] 'read index received'  (duration: 287.017212ms)","trace[909372506] 'applied index is now lower than readState.Index'  (duration: 136.054µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:06.942137Z","caller":"traceutil/trace.go:171","msg":"trace[1463554159] transaction","detail":"{read_only:false; response_revision:9972; number_of_response:1; }","duration":"287.97411ms","start":"2026-08-31T07:49:06.653903Z","end":"2026-08-31T07:49:06.941877Z","steps":["trace[1463554159] 'process raft request'  (duration: 287.547357ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:06.94249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.043172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:32 size:296104"}
{"level":"info","ts":"2026-08-31T07:49:06.942597Z","caller":"traceutil/trace.go:171","msg":"trace[115614692] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:32; response_revision:9972; }","duration":"288.199146ms","start":"2026-08-31T07:49:06.654377Z","end":"2026-08-31T07:49:06.942576Z","steps":["trace[115614692] 'agreement among raft nodes before linearized reading'  (duration: 287.528417ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:07.035067Z","caller":"traceutil/trace.go:171","msg":"trace[1645647133] transaction","detail":"{read_only:false; response_revision:9973; number_of_response:1; }","duration":"262.432109ms","start":"2026-08-31T07:49:06.772599Z","end":"2026-08-31T07:49:07.035031Z","steps":["trace[1645647133] 'process raft request'  (duration: 262.201943ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:07.035117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.560284ms","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-31T07:49:07.035394Z","caller":"traceutil/trace.go:171","msg":"trace[1684977778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9973; }","duration":"216.780021ms","start":"2026-08-31T07:49:06.818476Z","end":"2026-08-31T07:49:07.035256Z","steps":["trace[1684977778] 'agreement among raft nodes before linearized reading'  (duration: 216.465953ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:07.624593Z","caller":"traceutil/trace.go:171","msg":"trace[1727501036] transaction","detail":"{read_only:false; response_revision:9977; number_of_response:1; }","duration":"145.601691ms","start":"2026-08-31T07:49:07.478966Z","end":"2026-08-31T07:49:07.624567Z","steps":["trace[1727501036] 'process raft request'  (duration: 145.425646ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:07.989585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.801631ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808345 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" mod_revision:9699 > success:<request_put:<key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" value_size:1879 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:49:07.989866Z","caller":"traceutil/trace.go:171","msg":"trace[1306700866] transaction","detail":"{read_only:false; response_revision:9979; number_of_response:1; }","duration":"357.848092ms","start":"2026-08-31T07:49:07.631965Z","end":"2026-08-31T07:49:07.989813Z","steps":["trace[1306700866] 'process raft request'  (duration: 170.731901ms)","trace[1306700866] 'compare'  (duration: 186.711639ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:07.989987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:07.63193Z","time spent":"357.986486ms","remote":"127.0.0.1:37294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1946,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" mod_revision:9699 > success:<request_put:<key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" value_size:1879 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rook-ceph-rgw-ceph-vmsxh\" > >"}
{"level":"info","ts":"2026-08-31T07:49:07.989998Z","caller":"traceutil/trace.go:171","msg":"trace[700642164] transaction","detail":"{read_only:false; response_revision:9980; number_of_response:1; }","duration":"353.689383ms","start":"2026-08-31T07:49:07.636259Z","end":"2026-08-31T07:49:07.989949Z","steps":["trace[700642164] 'process raft request'  (duration: 353.433766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:07.990027Z","caller":"traceutil/trace.go:171","msg":"trace[1334305431] transaction","detail":"{read_only:false; response_revision:9981; number_of_response:1; }","duration":"233.942292ms","start":"2026-08-31T07:49:07.756047Z","end":"2026-08-31T07:49:07.98999Z","steps":["trace[1334305431] 'process raft request'  (duration: 233.718936ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:07.990185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:07.636228Z","time spent":"353.846398ms","remote":"127.0.0.1:37500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24179,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/openstack/rook-ceph-rgw-ceph-a-699b8bdb59\" mod_revision:9575 > success:<request_put:<key:\"/registry/replicasets/openstack/rook-ceph-rgw-ceph-a-699b8bdb59\" value_size:24106 >> failure:<request_range:<key:\"/registry/replicasets/openstack/rook-ceph-rgw-ceph-a-699b8bdb59\" > >"}
{"level":"info","ts":"2026-08-31T07:49:08.512432Z","caller":"traceutil/trace.go:171","msg":"trace[2003748170] transaction","detail":"{read_only:false; response_revision:9982; number_of_response:1; }","duration":"503.720531ms","start":"2026-08-31T07:49:08.008682Z","end":"2026-08-31T07:49:08.512402Z","steps":["trace[2003748170] 'process raft request'  (duration: 503.486824ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:08.512604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:08.008652Z","time spent":"503.861515ms","remote":"127.0.0.1:37464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24666,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/deployments/openstack/rook-ceph-rgw-ceph-a\" mod_revision:9586 > success:<request_put:<key:\"/registry/deployments/openstack/rook-ceph-rgw-ceph-a\" value_size:24604 >> failure:<request_range:<key:\"/registry/deployments/openstack/rook-ceph-rgw-ceph-a\" > >"}
{"level":"info","ts":"2026-08-31T07:49:08.616764Z","caller":"traceutil/trace.go:171","msg":"trace[640177557] linearizableReadLoop","detail":"{readStateIndex:10340; appliedIndex:10338; }","duration":"505.321576ms","start":"2026-08-31T07:49:08.111413Z","end":"2026-08-31T07:49:08.616734Z","steps":["trace[640177557] 'read index received'  (duration: 400.699809ms)","trace[640177557] 'applied index is now lower than readState.Index'  (duration: 104.620557ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:08.616816Z","caller":"traceutil/trace.go:171","msg":"trace[847969118] transaction","detail":"{read_only:false; response_revision:9983; number_of_response:1; }","duration":"527.694078ms","start":"2026-08-31T07:49:08.089092Z","end":"2026-08-31T07:49:08.616786Z","steps":["trace[847969118] 'process raft request'  (duration: 527.356608ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:08.617001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:08.089067Z","time spent":"527.829611ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9967 > 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-31T07:49:08.617127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.711979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-08-31T07:49:08.617219Z","caller":"traceutil/trace.go:171","msg":"trace[158035312] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9983; }","duration":"505.839723ms","start":"2026-08-31T07:49:08.111361Z","end":"2026-08-31T07:49:08.617201Z","steps":["trace[158035312] 'agreement among raft nodes before linearized reading'  (duration: 505.520663ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:08.617388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:08.111342Z","time spent":"505.966836ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-31T07:49:08.629252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.748845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:08.629537Z","caller":"traceutil/trace.go:171","msg":"trace[967690152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9985; }","duration":"258.092624ms","start":"2026-08-31T07:49:08.371422Z","end":"2026-08-31T07:49:08.629515Z","steps":["trace[967690152] 'agreement among raft nodes before linearized reading'  (duration: 257.770785ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:08.629557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.114144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.32\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-08-31T07:49:08.629656Z","caller":"traceutil/trace.go:171","msg":"trace[1131040897] range","detail":"{range_begin:/registry/masterleases/162.253.55.32; range_end:; response_count:1; response_revision:9985; }","duration":"311.231047ms","start":"2026-08-31T07:49:08.318379Z","end":"2026-08-31T07:49:08.62961Z","steps":["trace[1131040897] 'agreement among raft nodes before linearized reading'  (duration: 311.030181ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:08.629727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:49:08.318357Z","time spent":"311.35412ms","remote":"127.0.0.1:37028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.32\" "}
{"level":"warn","ts":"2026-08-31T07:49:08.811752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.553936ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808362 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.32\" mod_revision:9916 > success:<request_put:<key:\"/registry/masterleases/162.253.55.32\" value_size:66 lease:5482182940762032550 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.32\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:49:08.812189Z","caller":"traceutil/trace.go:171","msg":"trace[1042816076] transaction","detail":"{read_only:false; response_revision:9987; number_of_response:1; }","duration":"125.29461ms","start":"2026-08-31T07:49:08.686862Z","end":"2026-08-31T07:49:08.812156Z","steps":["trace[1042816076] 'process raft request'  (duration: 125.028133ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:08.812329Z","caller":"traceutil/trace.go:171","msg":"trace[551850015] transaction","detail":"{read_only:false; response_revision:9986; number_of_response:1; }","duration":"128.997485ms","start":"2026-08-31T07:49:08.683309Z","end":"2026-08-31T07:49:08.812306Z","steps":["trace[551850015] 'process raft request'  (duration: 23.71376ms)","trace[551850015] 'compare'  (duration: 104.37263ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:08.962735Z","caller":"traceutil/trace.go:171","msg":"trace[1742400188] transaction","detail":"{read_only:false; response_revision:9989; number_of_response:1; }","duration":"107.914502ms","start":"2026-08-31T07:49:08.8548Z","end":"2026-08-31T07:49:08.962714Z","steps":["trace[1742400188] 'process raft request'  (duration: 107.603083ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:09.266859Z","caller":"traceutil/trace.go:171","msg":"trace[1233810577] linearizableReadLoop","detail":"{readStateIndex:10350; appliedIndex:10349; }","duration":"113.727007ms","start":"2026-08-31T07:49:09.153096Z","end":"2026-08-31T07:49:09.266823Z","steps":["trace[1233810577] 'read index received'  (duration: 87.62068ms)","trace[1233810577] 'applied index is now lower than readState.Index'  (duration: 26.104997ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:09.26695Z","caller":"traceutil/trace.go:171","msg":"trace[35403102] transaction","detail":"{read_only:false; response_revision:9992; number_of_response:1; }","duration":"127.315767ms","start":"2026-08-31T07:49:09.139588Z","end":"2026-08-31T07:49:09.266904Z","steps":["trace[35403102] 'process raft request'  (duration: 101.119497ms)","trace[35403102] 'compare'  (duration: 25.881851ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:09.267203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.078738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-31T07:49:09.267304Z","caller":"traceutil/trace.go:171","msg":"trace[1070829219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9992; }","duration":"114.186701ms","start":"2026-08-31T07:49:09.15309Z","end":"2026-08-31T07:49:09.267277Z","steps":["trace[1070829219] 'agreement among raft nodes before linearized reading'  (duration: 113.916804ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:49:09.501581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.723732ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616808386 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9975 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:49:09.501769Z","caller":"traceutil/trace.go:171","msg":"trace[145226865] transaction","detail":"{read_only:false; response_revision:9994; number_of_response:1; }","duration":"228.701752ms","start":"2026-08-31T07:49:09.273036Z","end":"2026-08-31T07:49:09.501738Z","steps":["trace[145226865] 'process raft request'  (duration: 117.740363ms)","trace[145226865] 'compare'  (duration: 110.555887ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:49:09.501779Z","caller":"traceutil/trace.go:171","msg":"trace[1612666389] linearizableReadLoop","detail":"{readStateIndex:10352; appliedIndex:10351; }","duration":"130.143968ms","start":"2026-08-31T07:49:09.371559Z","end":"2026-08-31T07:49:09.501703Z","steps":["trace[1612666389] 'read index received'  (duration: 19.124108ms)","trace[1612666389] 'applied index is now lower than readState.Index'  (duration: 111.01883ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:49:09.501925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.354294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:49:09.50199Z","caller":"traceutil/trace.go:171","msg":"trace[556571475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9994; }","duration":"130.460517ms","start":"2026-08-31T07:49:09.371515Z","end":"2026-08-31T07:49:09.501975Z","steps":["trace[556571475] 'agreement among raft nodes before linearized reading'  (duration: 130.332744ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:49:10.00062Z","caller":"traceutil/trace.go:171","msg":"trace[1486634953] transaction","detail":"{read_only:false; response_revision:9997; number_of_response:1; }","duration":"127.985346ms","start":"2026-08-31T07:49:09.872608Z","end":"2026-08-31T07:49:10.000594Z","steps":["trace[1486634953] 'process raft request'  (duration: 127.807201ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:50:15.221758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8060}
{"level":"info","ts":"2026-08-31T07:50:15.318105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8060,"took":"93.884168ms","hash":1039469559,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":24891392,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-08-31T07:50:15.318244Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1039469559,"revision":8060,"compact-revision":5816}
{"level":"warn","ts":"2026-08-31T07:54:34.476036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.039247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:34.476278Z","caller":"traceutil/trace.go:171","msg":"trace[454025025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12320; }","duration":"106.351786ms","start":"2026-08-31T07:54:34.369867Z","end":"2026-08-31T07:54:34.476219Z","steps":["trace[454025025] 'range keys from in-memory index tree'  (duration: 105.951865ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:54:34.600832Z","caller":"traceutil/trace.go:171","msg":"trace[1921275272] transaction","detail":"{read_only:false; response_revision:12321; number_of_response:1; }","duration":"113.522791ms","start":"2026-08-31T07:54:34.487277Z","end":"2026-08-31T07:54:34.6008Z","steps":["trace[1921275272] 'process raft request'  (duration: 113.374297ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.220818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.408092ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.220924Z","caller":"traceutil/trace.go:171","msg":"trace[1715325092] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:12325; }","duration":"130.528545ms","start":"2026-08-31T07:54:36.090379Z","end":"2026-08-31T07:54:36.220908Z","steps":["trace[1715325092] 'range keys from in-memory index tree'  (duration: 130.391141ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.221295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.120576ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616814544 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:12317 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-31T07:54:36.221574Z","caller":"traceutil/trace.go:171","msg":"trace[2043861268] transaction","detail":"{read_only:false; response_revision:12327; number_of_response:1; }","duration":"190.241583ms","start":"2026-08-31T07:54:36.03131Z","end":"2026-08-31T07:54:36.221551Z","steps":["trace[2043861268] 'process raft request'  (duration: 190.11928ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:54:36.221773Z","caller":"traceutil/trace.go:171","msg":"trace[2071732983] linearizableReadLoop","detail":"{readStateIndex:12760; appliedIndex:12759; }","duration":"762.98842ms","start":"2026-08-31T07:54:35.458721Z","end":"2026-08-31T07:54:36.221709Z","steps":["trace[2071732983] 'read index received'  (duration: 485.186646ms)","trace[2071732983] 'applied index is now lower than readState.Index'  (duration: 277.798064ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:54:36.221931Z","caller":"traceutil/trace.go:171","msg":"trace[1921076149] transaction","detail":"{read_only:false; response_revision:12326; number_of_response:1; }","duration":"867.903076ms","start":"2026-08-31T07:54:35.354009Z","end":"2026-08-31T07:54:36.221913Z","steps":["trace[1921076149] 'process raft request'  (duration: 590.020609ms)","trace[1921076149] 'compare'  (duration: 276.727205ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T07:54:36.222079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.353991Z","time spent":"867.996758ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:12317 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-31T07:54:36.222098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.370541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.222136Z","caller":"traceutil/trace.go:171","msg":"trace[607078559] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12327; }","duration":"763.442183ms","start":"2026-08-31T07:54:35.458684Z","end":"2026-08-31T07:54:36.222126Z","steps":["trace[607078559] 'agreement among raft nodes before linearized reading'  (duration: 763.375151ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.22216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.458668Z","time spent":"763.485604ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" "}
{"level":"info","ts":"2026-08-31T07:54:36.280715Z","caller":"traceutil/trace.go:171","msg":"trace[493480294] transaction","detail":"{read_only:false; response_revision:12329; number_of_response:1; }","duration":"107.963272ms","start":"2026-08-31T07:54:36.172728Z","end":"2026-08-31T07:54:36.280691Z","steps":["trace[493480294] 'process raft request'  (duration: 107.932801ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.280854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.0447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.280919Z","caller":"traceutil/trace.go:171","msg":"trace[1864220421] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12329; }","duration":"822.166584ms","start":"2026-08-31T07:54:35.458737Z","end":"2026-08-31T07:54:36.280904Z","steps":["trace[1864220421] 'agreement among raft nodes before linearized reading'  (duration: 822.005879ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.280971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.458715Z","time spent":"822.228266ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-ks-user\" "}
{"level":"info","ts":"2026-08-31T07:54:36.281053Z","caller":"traceutil/trace.go:171","msg":"trace[2111607312] transaction","detail":"{read_only:false; response_revision:12328; number_of_response:1; }","duration":"156.029009ms","start":"2026-08-31T07:54:36.125015Z","end":"2026-08-31T07:54:36.281044Z","steps":["trace[2111607312] 'process raft request'  (duration: 155.545745ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.48319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-31T07:54:36.281223Z","caller":"traceutil/trace.go:171","msg":"trace[1929518510] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:12329; }","duration":"410.591802ms","start":"2026-08-31T07:54:35.870622Z","end":"2026-08-31T07:54:36.281214Z","steps":["trace[1929518510] 'agreement among raft nodes before linearized reading'  (duration: 410.543991ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.870598Z","time spent":"410.637834ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "}
{"level":"warn","ts":"2026-08-31T07:54:36.281317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.076478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.281345Z","caller":"traceutil/trace.go:171","msg":"trace[2054946606] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12329; }","duration":"721.15364ms","start":"2026-08-31T07:54:35.560183Z","end":"2026-08-31T07:54:36.281336Z","steps":["trace[2054946606] 'agreement among raft nodes before linearized reading'  (duration: 721.090578ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.560164Z","time spent":"721.198242ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.28142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.728196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-z94f4\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-08-31T07:54:36.281444Z","caller":"traceutil/trace.go:171","msg":"trace[855463139] range","detail":"{range_begin:/registry/pods/openstack/keepalived-z94f4; range_end:; response_count:1; response_revision:12329; }","duration":"754.773358ms","start":"2026-08-31T07:54:35.526662Z","end":"2026-08-31T07:54:36.281435Z","steps":["trace[855463139] 'agreement among raft nodes before linearized reading'  (duration: 754.681154ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.526648Z","time spent":"754.807728ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6471,"request content":"key:\"/registry/pods/openstack/keepalived-z94f4\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.2816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.398431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"}
{"level":"info","ts":"2026-08-31T07:54:36.28162Z","caller":"traceutil/trace.go:171","msg":"trace[2065613551] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12329; }","duration":"822.429543ms","start":"2026-08-31T07:54:35.459186Z","end":"2026-08-31T07:54:36.281615Z","steps":["trace[2065613551] 'agreement among raft nodes before linearized reading'  (duration: 822.369641ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.459178Z","time spent":"822.453063ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5028,"request content":"key:\"/registry/jobs/openstack/cinder-db-sync\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.281654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.845574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.281675Z","caller":"traceutil/trace.go:171","msg":"trace[458642954] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12329; }","duration":"822.904365ms","start":"2026-08-31T07:54:35.458765Z","end":"2026-08-31T07:54:36.281669Z","steps":["trace[458642954] 'agreement among raft nodes before linearized reading'  (duration: 822.867154ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.458745Z","time spent":"822.940007ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.281733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.574766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.281744Z","caller":"traceutil/trace.go:171","msg":"trace[123989249] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12329; }","duration":"822.653018ms","start":"2026-08-31T07:54:35.459087Z","end":"2026-08-31T07:54:36.28174Z","steps":["trace[123989249] 'agreement among raft nodes before linearized reading'  (duration: 822.636198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.45908Z","time spent":"822.670939ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-storage-init\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.281847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.966277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-31T07:54:36.281859Z","caller":"traceutil/trace.go:171","msg":"trace[572417492] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12329; }","duration":"823.004078ms","start":"2026-08-31T07:54:35.458851Z","end":"2026-08-31T07:54:36.281855Z","steps":["trace[572417492] 'agreement among raft nodes before linearized reading'  (duration: 822.959037ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.281869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.458845Z","time spent":"823.021769ms","remote":"127.0.0.1:37188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":692,"request content":"key:\"/registry/services/endpoints/openstack/cinder-api\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.282131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.13369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-31T07:54:36.282135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.692056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.282147Z","caller":"traceutil/trace.go:171","msg":"trace[1547490666] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12329; }","duration":"721.159751ms","start":"2026-08-31T07:54:35.560982Z","end":"2026-08-31T07:54:36.282142Z","steps":["trace[1547490666] 'agreement among raft nodes before linearized reading'  (duration: 721.132431ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T07:54:36.282158Z","caller":"traceutil/trace.go:171","msg":"trace[485406301] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12329; }","duration":"721.725997ms","start":"2026-08-31T07:54:35.560426Z","end":"2026-08-31T07:54:36.282152Z","steps":["trace[485406301] 'agreement among raft nodes before linearized reading'  (duration: 721.687296ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.282167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.560977Z","time spent":"721.185482ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-ks-user\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.282182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.560419Z","time spent":"721.758827ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-storage-init\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.282275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.741737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"}
{"level":"info","ts":"2026-08-31T07:54:36.282292Z","caller":"traceutil/trace.go:171","msg":"trace[1606674186] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12329; }","duration":"721.795898ms","start":"2026-08-31T07:54:35.56049Z","end":"2026-08-31T07:54:36.282286Z","steps":["trace[1606674186] 'agreement among raft nodes before linearized reading'  (duration: 721.743117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.282306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.560468Z","time spent":"721.83404ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5028,"request content":"key:\"/registry/jobs/openstack/cinder-db-sync\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.282456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.017655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-31T07:54:36.28249Z","caller":"traceutil/trace.go:171","msg":"trace[848758924] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12329; }","duration":"722.071407ms","start":"2026-08-31T07:54:35.5604Z","end":"2026-08-31T07:54:36.282471Z","steps":["trace[848758924] 'agreement among raft nodes before linearized reading'  (duration: 722.035546ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.282505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.560394Z","time spent":"722.107307ms","remote":"127.0.0.1:37262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-31T07:54:36.281533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.606317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-08-31T07:54:36.282676Z","caller":"traceutil/trace.go:171","msg":"trace[1109689611] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12329; }","duration":"500.77414ms","start":"2026-08-31T07:54:35.781886Z","end":"2026-08-31T07:54:36.28266Z","steps":["trace[1109689611] 'agreement among raft nodes before linearized reading'  (duration: 499.570626ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T07:54:36.282721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T07:54:35.78187Z","time spent":"500.836021ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-08-31T07:54:36.370468Z","caller":"traceutil/trace.go:171","msg":"trace[36088219] transaction","detail":"{read_only:false; response_revision:12330; number_of_response:1; }","duration":"131.047098ms","start":"2026-08-31T07:54:36.239395Z","end":"2026-08-31T07:54:36.370442Z","steps":["trace[36088219] 'process raft request'  (duration: 120.196989ms)","trace[36088219] 'compare'  (duration: 10.280572ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T07:55:15.228694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10422}
{"level":"info","ts":"2026-08-31T07:55:15.319631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10422,"took":"88.950387ms","hash":1748388708,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":26075136,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-31T07:55:15.319686Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1748388708,"revision":10422,"compact-revision":8060}
{"level":"info","ts":"2026-08-31T08:00:15.236336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12610}
{"level":"info","ts":"2026-08-31T08:00:15.328005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12610,"took":"89.257671ms","hash":2333164576,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":28344320,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-31T08:00:15.328074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2333164576,"revision":12610,"compact-revision":10422}
{"level":"info","ts":"2026-08-31T08:00:54.360444Z","caller":"traceutil/trace.go:171","msg":"trace[1048098684] transaction","detail":"{read_only:false; response_revision:14877; number_of_response:1; }","duration":"104.74758ms","start":"2026-08-31T08:00:54.255671Z","end":"2026-08-31T08:00:54.360418Z","steps":["trace[1048098684] 'process raft request'  (duration: 104.591065ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:01:33.816999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.558621ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616822321 > lease_revoke:<id:4c14a056b9d3ff3c>","response":"size:29"}
{"level":"info","ts":"2026-08-31T08:01:33.817126Z","caller":"traceutil/trace.go:171","msg":"trace[1460283341] linearizableReadLoop","detail":"{readStateIndex:15624; appliedIndex:15623; }","duration":"357.092798ms","start":"2026-08-31T08:01:33.460015Z","end":"2026-08-31T08:01:33.817108Z","steps":["trace[1460283341] 'read index received'  (duration: 193.350601ms)","trace[1460283341] 'applied index is now lower than readState.Index'  (duration: 163.740467ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T08:01:33.817409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.376585ms","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-31T08:01:33.817452Z","caller":"traceutil/trace.go:171","msg":"trace[951724203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15090; }","duration":"357.463718ms","start":"2026-08-31T08:01:33.459977Z","end":"2026-08-31T08:01:33.817441Z","steps":["trace[951724203] 'agreement among raft nodes before linearized reading'  (duration: 357.218921ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:01:33.817492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:01:33.459955Z","time spent":"357.528009ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-31T08:01:33.817469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.40949ms","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-31T08:01:33.817571Z","caller":"traceutil/trace.go:171","msg":"trace[1575799482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15090; }","duration":"202.569985ms","start":"2026-08-31T08:01:33.614973Z","end":"2026-08-31T08:01:33.817543Z","steps":["trace[1575799482] 'agreement among raft nodes before linearized reading'  (duration: 202.283107ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:01:58.147306Z","caller":"traceutil/trace.go:171","msg":"trace[2143165267] transaction","detail":"{read_only:false; response_revision:15411; number_of_response:1; }","duration":"168.144092ms","start":"2026-08-31T08:01:57.979134Z","end":"2026-08-31T08:01:58.147278Z","steps":["trace[2143165267] 'process raft request'  (duration: 167.966567ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:01:58.212602Z","caller":"traceutil/trace.go:171","msg":"trace[83760379] transaction","detail":"{read_only:false; response_revision:15412; number_of_response:1; }","duration":"232.073347ms","start":"2026-08-31T08:01:57.980505Z","end":"2026-08-31T08:01:58.212578Z","steps":["trace[83760379] 'process raft request'  (duration: 231.894262ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:01:58.212832Z","caller":"traceutil/trace.go:171","msg":"trace[1982486357] transaction","detail":"{read_only:false; response_revision:15413; number_of_response:1; }","duration":"185.177268ms","start":"2026-08-31T08:01:58.027637Z","end":"2026-08-31T08:01:58.212814Z","steps":["trace[1982486357] 'process raft request'  (duration: 184.90552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:01:58.212923Z","caller":"traceutil/trace.go:171","msg":"trace[2103885013] linearizableReadLoop","detail":"{readStateIndex:15958; appliedIndex:15956; }","duration":"197.934262ms","start":"2026-08-31T08:01:58.014962Z","end":"2026-08-31T08:01:58.212896Z","steps":["trace[2103885013] 'read index received'  (duration: 132.160344ms)","trace[2103885013] 'applied index is now lower than readState.Index'  (duration: 65.771628ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:01:58.212963Z","caller":"traceutil/trace.go:171","msg":"trace[642752009] transaction","detail":"{read_only:false; response_revision:15414; number_of_response:1; }","duration":"170.703535ms","start":"2026-08-31T08:01:58.042247Z","end":"2026-08-31T08:01:58.212951Z","steps":["trace[642752009] 'process raft request'  (duration: 170.488748ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:01:58.213133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.163339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-v9rzd\" ","response":"range_response_count:1 size:20561"}
{"level":"info","ts":"2026-08-31T08:01:58.213196Z","caller":"traceutil/trace.go:171","msg":"trace[254805346] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-v9rzd; range_end:; response_count:1; response_revision:15414; }","duration":"198.278062ms","start":"2026-08-31T08:01:58.014901Z","end":"2026-08-31T08:01:58.213179Z","steps":["trace[254805346] 'agreement among raft nodes before linearized reading'  (duration: 198.104617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:02:51.686218Z","caller":"traceutil/trace.go:171","msg":"trace[931634916] transaction","detail":"{read_only:false; response_revision:16055; number_of_response:1; }","duration":"121.86856ms","start":"2026-08-31T08:02:51.564292Z","end":"2026-08-31T08:02:51.68616Z","steps":["trace[931634916] 'process raft request'  (duration: 121.615263ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:03:15.611681Z","caller":"traceutil/trace.go:171","msg":"trace[282185069] transaction","detail":"{read_only:false; response_revision:16181; number_of_response:1; }","duration":"131.778387ms","start":"2026-08-31T08:03:15.479879Z","end":"2026-08-31T08:03:15.611658Z","steps":["trace[282185069] 'process raft request'  (duration: 131.657773ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:03:16.837894Z","caller":"traceutil/trace.go:171","msg":"trace[1858053046] transaction","detail":"{read_only:false; response_revision:16183; number_of_response:1; }","duration":"296.623384ms","start":"2026-08-31T08:03:16.54124Z","end":"2026-08-31T08:03:16.837863Z","steps":["trace[1858053046] 'process raft request'  (duration: 296.421488ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:03:16.839664Z","caller":"traceutil/trace.go:171","msg":"trace[797264076] transaction","detail":"{read_only:false; response_revision:16184; number_of_response:1; }","duration":"296.595743ms","start":"2026-08-31T08:03:16.543033Z","end":"2026-08-31T08:03:16.839628Z","steps":["trace[797264076] 'process raft request'  (duration: 296.421838ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:03:16.840009Z","caller":"traceutil/trace.go:171","msg":"trace[1605039562] linearizableReadLoop","detail":"{readStateIndex:16751; appliedIndex:16749; }","duration":"282.177272ms","start":"2026-08-31T08:03:16.557807Z","end":"2026-08-31T08:03:16.839984Z","steps":["trace[1605039562] 'read index received'  (duration: 279.97496ms)","trace[1605039562] 'applied index is now lower than readState.Index'  (duration: 2.201062ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:03:16.840132Z","caller":"traceutil/trace.go:171","msg":"trace[1254815036] transaction","detail":"{read_only:false; response_revision:16185; number_of_response:1; }","duration":"196.003914ms","start":"2026-08-31T08:03:16.644109Z","end":"2026-08-31T08:03:16.840113Z","steps":["trace[1254815036] 'process raft request'  (duration: 195.47578ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.840251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.420139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-08-31T08:03:16.840312Z","caller":"traceutil/trace.go:171","msg":"trace[2004953754] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:16186; }","duration":"282.526711ms","start":"2026-08-31T08:03:16.557769Z","end":"2026-08-31T08:03:16.840296Z","steps":["trace[2004953754] 'agreement among raft nodes before linearized reading'  (duration: 282.348346ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.840346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.164081ms","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-31T08:03:16.840382Z","caller":"traceutil/trace.go:171","msg":"trace[30569486] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16186; }","duration":"227.241733ms","start":"2026-08-31T08:03:16.613126Z","end":"2026-08-31T08:03:16.840367Z","steps":["trace[30569486] 'agreement among raft nodes before linearized reading'  (duration: 227.145181ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.840409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.122744ms","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-31T08:03:16.840466Z","caller":"traceutil/trace.go:171","msg":"trace[1415291988] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16186; }","duration":"271.223127ms","start":"2026-08-31T08:03:16.56923Z","end":"2026-08-31T08:03:16.840454Z","steps":["trace[1415291988] 'agreement among raft nodes before linearized reading'  (duration: 271.041332ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.840623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.470859ms","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-31T08:03:16.840703Z","caller":"traceutil/trace.go:171","msg":"trace[2063715486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16186; }","duration":"218.587992ms","start":"2026-08-31T08:03:16.622098Z","end":"2026-08-31T08:03:16.840686Z","steps":["trace[2063715486] 'agreement among raft nodes before linearized reading'  (duration: 218.421857ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.840725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.622347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-31T08:03:16.840765Z","caller":"traceutil/trace.go:171","msg":"trace[719824634] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:16186; }","duration":"253.687609ms","start":"2026-08-31T08:03:16.587067Z","end":"2026-08-31T08:03:16.840755Z","steps":["trace[719824634] 'agreement among raft nodes before linearized reading'  (duration: 253.554145ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:03:16.841355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.926172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:126287"}
{"level":"info","ts":"2026-08-31T08:03:16.841422Z","caller":"traceutil/trace.go:171","msg":"trace[2240519] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:16186; }","duration":"256.027275ms","start":"2026-08-31T08:03:16.585378Z","end":"2026-08-31T08:03:16.841405Z","steps":["trace[2240519] 'agreement among raft nodes before linearized reading'  (duration: 255.295214ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:05:15.242666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14623}
{"level":"info","ts":"2026-08-31T08:05:15.330002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14623,"took":"84.68702ms","hash":119300768,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":31023104,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-31T08:05:15.330069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":119300768,"revision":14623,"compact-revision":12610}
{"level":"info","ts":"2026-08-31T08:07:52.222958Z","caller":"traceutil/trace.go:171","msg":"trace[1065306526] transaction","detail":"{read_only:false; response_revision:18226; number_of_response:1; }","duration":"103.740401ms","start":"2026-08-31T08:07:52.119186Z","end":"2026-08-31T08:07:52.222927Z","steps":["trace[1065306526] 'process raft request'  (duration: 103.401361ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:09:52.063484Z","caller":"traceutil/trace.go:171","msg":"trace[1411947176] linearizableReadLoop","detail":"{readStateIndex:19701; appliedIndex:19700; }","duration":"168.953605ms","start":"2026-08-31T08:09:51.894502Z","end":"2026-08-31T08:09:52.063456Z","steps":["trace[1411947176] 'read index received'  (duration: 168.81577ms)","trace[1411947176] 'applied index is now lower than readState.Index'  (duration: 136.835µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:09:52.063688Z","caller":"traceutil/trace.go:171","msg":"trace[2029136310] transaction","detail":"{read_only:false; response_revision:19039; number_of_response:1; }","duration":"262.823548ms","start":"2026-08-31T08:09:51.800805Z","end":"2026-08-31T08:09:52.063629Z","steps":["trace[2029136310] 'process raft request'  (duration: 262.465677ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:52.063761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.201502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-31T08:09:52.063807Z","caller":"traceutil/trace.go:171","msg":"trace[840828632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19039; }","duration":"169.333966ms","start":"2026-08-31T08:09:51.894461Z","end":"2026-08-31T08:09:52.063795Z","steps":["trace[840828632] 'agreement among raft nodes before linearized reading'  (duration: 169.11536ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:09:58.256236Z","caller":"traceutil/trace.go:171","msg":"trace[2005416193] linearizableReadLoop","detail":"{readStateIndex:19742; appliedIndex:19741; }","duration":"151.160931ms","start":"2026-08-31T08:09:58.105046Z","end":"2026-08-31T08:09:58.256207Z","steps":["trace[2005416193] 'read index received'  (duration: 150.948845ms)","trace[2005416193] 'applied index is now lower than readState.Index'  (duration: 210.726µs)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:09:58.256348Z","caller":"traceutil/trace.go:171","msg":"trace[750268245] transaction","detail":"{read_only:false; response_revision:19079; number_of_response:1; }","duration":"291.700512ms","start":"2026-08-31T08:09:57.964591Z","end":"2026-08-31T08:09:58.256291Z","steps":["trace[750268245] 'process raft request'  (duration: 291.404994ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:58.256633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.574022ms","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-31T08:09:58.256716Z","caller":"traceutil/trace.go:171","msg":"trace[1237619751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19079; }","duration":"151.675934ms","start":"2026-08-31T08:09:58.105023Z","end":"2026-08-31T08:09:58.256698Z","steps":["trace[1237619751] 'agreement among raft nodes before linearized reading'  (duration: 151.307764ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:58.748242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.96118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-31T08:09:58.748331Z","caller":"traceutil/trace.go:171","msg":"trace[830708551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19081; }","duration":"377.089123ms","start":"2026-08-31T08:09:58.371211Z","end":"2026-08-31T08:09:58.7483Z","steps":["trace[830708551] 'range keys from in-memory index tree'  (duration: 376.838916ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:58.748363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.371187Z","time spent":"377.168266ms","remote":"127.0.0.1:36978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-31T08:09:58.748407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.85597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6hr4v\" ","response":"range_response_count:1 size:22018"}
{"level":"info","ts":"2026-08-31T08:09:58.748487Z","caller":"traceutil/trace.go:171","msg":"trace[1840256538] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6hr4v; range_end:; response_count:1; response_revision:19081; }","duration":"167.987584ms","start":"2026-08-31T08:09:58.58048Z","end":"2026-08-31T08:09:58.748468Z","steps":["trace[1840256538] 'range keys from in-memory index tree'  (duration: 167.599572ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:58.748657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.581057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.32\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-08-31T08:09:58.748927Z","caller":"traceutil/trace.go:171","msg":"trace[1727158550] range","detail":"{range_begin:/registry/masterleases/162.253.55.32; range_end:; response_count:1; response_revision:19081; }","duration":"361.745802ms","start":"2026-08-31T08:09:58.387004Z","end":"2026-08-31T08:09:58.74875Z","steps":["trace[1727158550] 'range keys from in-memory index tree'  (duration: 361.396002ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:58.748994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.914855ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616837397 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:19067 > 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\" > >>","response":"size:18"}
{"level":"warn","ts":"2026-08-31T08:09:58.749008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.386984Z","time spent":"362.007529ms","remote":"127.0.0.1:37028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/162.253.55.32\" "}
{"level":"info","ts":"2026-08-31T08:09:58.749055Z","caller":"traceutil/trace.go:171","msg":"trace[700834606] transaction","detail":"{read_only:false; response_revision:19082; number_of_response:1; }","duration":"135.024867ms","start":"2026-08-31T08:09:58.614016Z","end":"2026-08-31T08:09:58.749041Z","steps":["trace[700834606] 'process raft request'  (duration: 32.995028ms)","trace[700834606] 'compare'  (duration: 101.274158ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T08:09:59.155605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.453142ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616837398 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:19068 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-31T08:09:59.155889Z","caller":"traceutil/trace.go:171","msg":"trace[96829766] transaction","detail":"{read_only:false; response_revision:19083; number_of_response:1; }","duration":"541.261599ms","start":"2026-08-31T08:09:58.614597Z","end":"2026-08-31T08:09:59.155858Z","steps":["trace[96829766] 'process raft request'  (duration: 364.475278ms)","trace[96829766] 'compare'  (duration: 176.340099ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T08:09:59.156054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.614571Z","time spent":"541.392672ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:19068 > 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-31T08:09:59.156528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.757637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-31T08:09:59.156576Z","caller":"traceutil/trace.go:171","msg":"trace[1430873508] linearizableReadLoop","detail":"{readStateIndex:19746; appliedIndex:19745; }","duration":"406.81005ms","start":"2026-08-31T08:09:58.749746Z","end":"2026-08-31T08:09:59.156556Z","steps":["trace[1430873508] 'read index received'  (duration: 229.344689ms)","trace[1430873508] 'applied index is now lower than readState.Index'  (duration: 176.615996ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:09:59.156599Z","caller":"traceutil/trace.go:171","msg":"trace[410772098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19083; }","duration":"407.011285ms","start":"2026-08-31T08:09:58.74957Z","end":"2026-08-31T08:09:59.156581Z","steps":["trace[410772098] 'agreement among raft nodes before linearized reading'  (duration: 406.532521ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:59.156655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.749546Z","time spent":"407.096697ms","remote":"127.0.0.1:36982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-31T08:09:59.303571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.750226Z","time spent":"553.340419ms","remote":"127.0.0.1:37028","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-08-31T08:09:59.303665Z","caller":"traceutil/trace.go:171","msg":"trace[2126925181] transaction","detail":"{read_only:false; response_revision:19084; number_of_response:1; }","duration":"502.615832ms","start":"2026-08-31T08:09:58.801041Z","end":"2026-08-31T08:09:59.303656Z","steps":["trace[2126925181] 'process raft request'  (duration: 502.235262ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:09:59.303883Z","caller":"traceutil/trace.go:171","msg":"trace[214346515] linearizableReadLoop","detail":"{readStateIndex:19749; appliedIndex:19746; }","duration":"147.24918ms","start":"2026-08-31T08:09:59.156612Z","end":"2026-08-31T08:09:59.303861Z","steps":["trace[214346515] 'read index received'  (duration: 134.262435ms)","trace[214346515] 'applied index is now lower than readState.Index'  (duration: 12.984265ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T08:09:59.303973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.801013Z","time spent":"502.804617ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:19069 > 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-31T08:09:59.304149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.831319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-6p8d9\" ","response":"range_response_count:1 size:9712"}
{"level":"info","ts":"2026-08-31T08:09:59.304224Z","caller":"traceutil/trace.go:171","msg":"trace[1805042296] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-6p8d9; range_end:; response_count:1; response_revision:19085; }","duration":"390.964173ms","start":"2026-08-31T08:09:58.913241Z","end":"2026-08-31T08:09:59.304206Z","steps":["trace[1805042296] 'agreement among raft nodes before linearized reading'  (duration: 390.762247ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:59.304256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.281991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-08-31T08:09:59.30426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.913217Z","time spent":"391.033355ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9736,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-6p8d9\" "}
{"level":"info","ts":"2026-08-31T08:09:59.304284Z","caller":"traceutil/trace.go:171","msg":"trace[1852957237] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19085; }","duration":"115.345513ms","start":"2026-08-31T08:09:59.188929Z","end":"2026-08-31T08:09:59.304275Z","steps":["trace[1852957237] 'agreement among raft nodes before linearized reading'  (duration: 115.26905ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:09:59.303613Z","caller":"traceutil/trace.go:171","msg":"trace[2011357714] transaction","detail":"{read_only:false; response_revision:19085; number_of_response:1; }","duration":"500.188805ms","start":"2026-08-31T08:09:58.803396Z","end":"2026-08-31T08:09:59.303585Z","steps":["trace[2011357714] 'process raft request'  (duration: 500.042741ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:59.304414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.803379Z","time spent":"500.976487ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:19070 > 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-31T08:09:59.30447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.685207ms","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-31T08:09:59.304533Z","caller":"traceutil/trace.go:171","msg":"trace[1854075574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19085; }","duration":"192.82106ms","start":"2026-08-31T08:09:59.111696Z","end":"2026-08-31T08:09:59.304517Z","steps":["trace[1854075574] 'agreement among raft nodes before linearized reading'  (duration: 192.597714ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:59.307253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.160017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:946719"}
{"level":"info","ts":"2026-08-31T08:09:59.307333Z","caller":"traceutil/trace.go:171","msg":"trace[2135262820] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:19085; }","duration":"551.27054ms","start":"2026-08-31T08:09:58.756049Z","end":"2026-08-31T08:09:59.30732Z","steps":["trace[2135262820] 'agreement among raft nodes before linearized reading'  (duration: 547.970718ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:09:59.307375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-31T08:09:58.756038Z","time spent":"551.318611ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":95,"response size":946743,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-08-31T08:10:07.463208Z","caller":"traceutil/trace.go:171","msg":"trace[1102913277] transaction","detail":"{read_only:false; response_revision:19197; number_of_response:1; }","duration":"101.077302ms","start":"2026-08-31T08:10:07.362104Z","end":"2026-08-31T08:10:07.463181Z","steps":["trace[1102913277] 'process raft request'  (duration: 100.922688ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:10:15.250499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16949}
{"level":"info","ts":"2026-08-31T08:10:15.367411Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16949,"took":"113.584693ms","hash":3028089381,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":32641024,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-31T08:10:15.367776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3028089381,"revision":16949,"compact-revision":14623}
{"level":"info","ts":"2026-08-31T08:10:15.375811Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-31T08:10:15.382305Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-31T08:10:15.382492Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-31T08:15:15.258059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19325}
{"level":"info","ts":"2026-08-31T08:15:15.373027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19325,"took":"110.101812ms","hash":3422191744,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":34217984,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-31T08:15:15.373114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3422191744,"revision":19325,"compact-revision":16949}
{"level":"info","ts":"2026-08-31T08:15:39.405178Z","caller":"traceutil/trace.go:171","msg":"trace[263095315] transaction","detail":"{read_only:false; response_revision:21736; number_of_response:1; }","duration":"112.342636ms","start":"2026-08-31T08:15:39.292795Z","end":"2026-08-31T08:15:39.405138Z","steps":["trace[263095315] 'process raft request'  (duration: 112.11975ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:15:39.406586Z","caller":"traceutil/trace.go:171","msg":"trace[832342023] transaction","detail":"{read_only:false; response_revision:21737; number_of_response:1; }","duration":"112.353036ms","start":"2026-08-31T08:15:39.294196Z","end":"2026-08-31T08:15:39.406549Z","steps":["trace[832342023] 'process raft request'  (duration: 112.063968ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:15:44.896212Z","caller":"traceutil/trace.go:171","msg":"trace[1943493552] transaction","detail":"{read_only:false; response_revision:21762; number_of_response:1; }","duration":"251.344121ms","start":"2026-08-31T08:15:44.64483Z","end":"2026-08-31T08:15:44.896174Z","steps":["trace[1943493552] 'process raft request'  (duration: 251.104415ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:15:44.965453Z","caller":"traceutil/trace.go:171","msg":"trace[1165022542] transaction","detail":"{read_only:false; response_revision:21763; number_of_response:1; }","duration":"264.056927ms","start":"2026-08-31T08:15:44.70137Z","end":"2026-08-31T08:15:44.965427Z","steps":["trace[1165022542] 'process raft request'  (duration: 263.899253ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:16:00.718579Z","caller":"traceutil/trace.go:171","msg":"trace[342700198] transaction","detail":"{read_only:false; response_revision:21845; number_of_response:1; }","duration":"120.994869ms","start":"2026-08-31T08:16:00.597545Z","end":"2026-08-31T08:16:00.71854Z","steps":["trace[342700198] 'process raft request'  (duration: 120.780193ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:16:01.81408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.221711ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705554977616845186 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21840 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-31T08:16:01.814218Z","caller":"traceutil/trace.go:171","msg":"trace[297272343] linearizableReadLoop","detail":"{readStateIndex:22608; appliedIndex:22607; }","duration":"171.013674ms","start":"2026-08-31T08:16:01.64318Z","end":"2026-08-31T08:16:01.814194Z","steps":["trace[297272343] 'read index received'  (duration: 31.526436ms)","trace[297272343] 'applied index is now lower than readState.Index'  (duration: 139.485998ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:16:01.81425Z","caller":"traceutil/trace.go:171","msg":"trace[366469049] transaction","detail":"{read_only:false; response_revision:21850; number_of_response:1; }","duration":"208.483036ms","start":"2026-08-31T08:16:01.605726Z","end":"2026-08-31T08:16:01.814209Z","steps":["trace[366469049] 'process raft request'  (duration: 69.006007ms)","trace[366469049] 'compare'  (duration: 139.033187ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-31T08:16:01.814593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.407915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7913"}
{"level":"info","ts":"2026-08-31T08:16:01.814639Z","caller":"traceutil/trace.go:171","msg":"trace[1506891903] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:21850; }","duration":"171.497987ms","start":"2026-08-31T08:16:01.643127Z","end":"2026-08-31T08:16:01.814625Z","steps":["trace[1506891903] 'agreement among raft nodes before linearized reading'  (duration: 171.121327ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:20:15.265036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21614}
{"level":"info","ts":"2026-08-31T08:20:15.394043Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21614,"took":"122.48519ms","hash":3641363003,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":41373696,"current-db-size-in-use":"41 MB"}
{"level":"info","ts":"2026-08-31T08:20:15.394167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3641363003,"revision":21614,"compact-revision":19325}
{"level":"info","ts":"2026-08-31T08:20:19.522481Z","caller":"traceutil/trace.go:171","msg":"trace[102367972] transaction","detail":"{read_only:false; response_revision:24446; number_of_response:1; }","duration":"215.398011ms","start":"2026-08-31T08:20:19.307057Z","end":"2026-08-31T08:20:19.522455Z","steps":["trace[102367972] 'process raft request'  (duration: 215.198325ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:20:19.538312Z","caller":"traceutil/trace.go:171","msg":"trace[194711348] transaction","detail":"{read_only:false; response_revision:24448; number_of_response:1; }","duration":"195.383569ms","start":"2026-08-31T08:20:19.342898Z","end":"2026-08-31T08:20:19.538282Z","steps":["trace[194711348] 'process raft request'  (duration: 195.289326ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:20:19.538346Z","caller":"traceutil/trace.go:171","msg":"trace[2060140070] transaction","detail":"{read_only:false; response_revision:24447; number_of_response:1; }","duration":"228.797047ms","start":"2026-08-31T08:20:19.30951Z","end":"2026-08-31T08:20:19.538307Z","steps":["trace[2060140070] 'process raft request'  (duration: 228.509249ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:20:19.538474Z","caller":"traceutil/trace.go:171","msg":"trace[702485024] linearizableReadLoop","detail":"{readStateIndex:25288; appliedIndex:25286; }","duration":"164.261544ms","start":"2026-08-31T08:20:19.374195Z","end":"2026-08-31T08:20:19.538456Z","steps":["trace[702485024] 'read index received'  (duration: 148.315116ms)","trace[702485024] 'applied index is now lower than readState.Index'  (duration: 15.945588ms)"],"step_count":2}
{"level":"info","ts":"2026-08-31T08:20:19.538562Z","caller":"traceutil/trace.go:171","msg":"trace[59852297] transaction","detail":"{read_only:false; response_revision:24449; number_of_response:1; }","duration":"135.522027ms","start":"2026-08-31T08:20:19.402991Z","end":"2026-08-31T08:20:19.538513Z","steps":["trace[59852297] 'process raft request'  (duration: 135.245599ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-31T08:20:19.53868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.46155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-31T08:20:19.538731Z","caller":"traceutil/trace.go:171","msg":"trace[1855419914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24449; }","duration":"164.594864ms","start":"2026-08-31T08:20:19.374128Z","end":"2026-08-31T08:20:19.538723Z","steps":["trace[1855419914] 'agreement among raft nodes before linearized reading'  (duration: 164.387068ms)"],"step_count":1}
{"level":"info","ts":"2026-08-31T08:25:15.273723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24354}
{"level":"info","ts":"2026-08-31T08:25:15.433454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24354,"took":"154.43744ms","hash":1572902530,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":33198080,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-31T08:25:15.433539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1572902530,"revision":24354,"compact-revision":21614}
{"level":"info","ts":"2026-08-31T08:25:37.56735Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006d7c.wal"}
{"level":"info","ts":"2026-08-31T08:30:00.063974Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-31T08:30:00.070768Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-31T08:30:00.070974Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-31T08:30:15.280714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26953}
{"level":"info","ts":"2026-08-31T08:30:15.421429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26953,"took":"136.485613ms","hash":3157998390,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":29679616,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-31T08:30:15.421527Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3157998390,"revision":26953,"compact-revision":24354}