{"level":"warn","ts":"2026-08-28T04:07:21.274706Z","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-28T04:07:21.274873Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.148: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.148:2380","--initial-cluster=instance=https://162.253.55.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.148: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-28T04:07:21.274985Z","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-28T04:07:21.275005Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.148:2380"]}
{"level":"info","ts":"2026-08-28T04:07:21.275038Z","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-28T04:07:21.276275Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"]}
{"level":"info","ts":"2026-08-28T04:07:21.276409Z","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.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.148: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-28T04:07:21.280006Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.19785ms"}
{"level":"info","ts":"2026-08-28T04:07:21.287058Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6342599e225e01b","cluster-id":"8ad3da7aa894cc05"}
{"level":"info","ts":"2026-08-28T04:07:21.287174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-28T04:07:21.287205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 0"}
{"level":"info","ts":"2026-08-28T04:07:21.287223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6342599e225e01b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-28T04:07:21.287235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 1"}
{"level":"info","ts":"2026-08-28T04:07:21.287283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"}
{"level":"warn","ts":"2026-08-28T04:07:21.293649Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-28T04:07:21.296353Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-28T04:07:21.298228Z","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-28T04:07:21.301474Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6342599e225e01b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-28T04:07:21.301754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6342599e225e01b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-28T04:07:21.301818Z","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-28T04:07:21.302046Z","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-28T04:07:21.302079Z","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-28T04:07:21.304195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"}
{"level":"info","ts":"2026-08-28T04:07:21.304393Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","added-peer-id":"a6342599e225e01b","added-peer-peer-urls":["https://162.253.55.148:2380"]}
{"level":"info","ts":"2026-08-28T04:07:21.307106Z","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-28T04:07:21.30728Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.148:2380"}
{"level":"info","ts":"2026-08-28T04:07:21.307396Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.148:2380"}
{"level":"info","ts":"2026-08-28T04:07:21.307675Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6342599e225e01b","initial-advertise-peer-urls":["https://162.253.55.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-28T04:07:21.307754Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-28T04:07:21.38751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-28T04:07:21.387571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-28T04:07:21.387592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgPreVoteResp from a6342599e225e01b at term 1"}
{"level":"info","ts":"2026-08-28T04:07:21.387632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became candidate at term 2"}
{"level":"info","ts":"2026-08-28T04:07:21.387646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgVoteResp from a6342599e225e01b at term 2"}
{"level":"info","ts":"2026-08-28T04:07:21.387682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became leader at term 2"}
{"level":"info","ts":"2026-08-28T04:07:21.3877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6342599e225e01b elected leader a6342599e225e01b at term 2"}
{"level":"info","ts":"2026-08-28T04:07:21.389043Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6342599e225e01b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.148:2379]}","request-path":"/0/members/a6342599e225e01b/attributes","cluster-id":"8ad3da7aa894cc05","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-28T04:07:21.389048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-28T04:07:21.389061Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-28T04:07:21.389121Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-28T04:07:21.389431Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-28T04:07:21.389498Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-28T04:07:21.390252Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-28T04:07:21.390384Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-28T04:07:21.390425Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-28T04:07:21.392324Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-28T04:07:21.39241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.148:2379"}
{"level":"info","ts":"2026-08-28T04:07:37.180476Z","caller":"traceutil/trace.go:171","msg":"trace[1917974268] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"179.972365ms","start":"2026-08-28T04:07:37.000479Z","end":"2026-08-28T04:07:37.180451Z","steps":["trace[1917974268] 'process raft request'  (duration: 179.834691ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:07:37.390573Z","caller":"traceutil/trace.go:171","msg":"trace[780180874] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"174.621069ms","start":"2026-08-28T04:07:37.215926Z","end":"2026-08-28T04:07:37.390547Z","steps":["trace[780180874] 'process raft request'  (duration: 170.531885ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:08:06.98209Z","caller":"traceutil/trace.go:171","msg":"trace[321583974] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"124.549326ms","start":"2026-08-28T04:08:06.857502Z","end":"2026-08-28T04:08:06.982051Z","steps":["trace[321583974] 'process raft request'  (duration: 123.065538ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:08:07.187359Z","caller":"traceutil/trace.go:171","msg":"trace[985833116] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"187.200095ms","start":"2026-08-28T04:08:07.00013Z","end":"2026-08-28T04:08:07.18733Z","steps":["trace[985833116] 'process raft request'  (duration: 186.944859ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:08:07.418163Z","caller":"traceutil/trace.go:171","msg":"trace[946823132] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"361.024377ms","start":"2026-08-28T04:08:07.057098Z","end":"2026-08-28T04:08:07.418122Z","steps":["trace[946823132] 'process raft request'  (duration: 360.790481ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:07.418906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:08:07.057066Z","time spent":"361.194781ms","remote":"127.0.0.1:45520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:1006 >> failure:<>"}
{"level":"warn","ts":"2026-08-28T04:08:07.976502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.524507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-28T04:08:07.976603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.705064ms","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-28T04:08:07.976653Z","caller":"traceutil/trace.go:171","msg":"trace[507673036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"410.759853ms","start":"2026-08-28T04:08:07.565865Z","end":"2026-08-28T04:08:07.976625Z","steps":["trace[507673036] 'range keys from in-memory index tree'  (duration: 410.235989ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:07.976709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:08:07.565833Z","time spent":"410.864866ms","remote":"127.0.0.1:45442","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":"info","ts":"2026-08-28T04:08:07.976711Z","caller":"traceutil/trace.go:171","msg":"trace[893023285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"234.828686ms","start":"2026-08-28T04:08:07.741855Z","end":"2026-08-28T04:08:07.976683Z","steps":["trace[893023285] 'range keys from in-memory index tree'  (duration: 234.325114ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:07.976528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.859891ms","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-28T04:08:07.976816Z","caller":"traceutil/trace.go:171","msg":"trace[1721779809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"269.268192ms","start":"2026-08-28T04:08:07.707527Z","end":"2026-08-28T04:08:07.976795Z","steps":["trace[1721779809] 'range keys from in-memory index tree'  (duration: 268.491982ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:07.976411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.624338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:08:07.976983Z","caller":"traceutil/trace.go:171","msg":"trace[1917339549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"402.46582ms","start":"2026-08-28T04:08:07.574496Z","end":"2026-08-28T04:08:07.976962Z","steps":["trace[1917339549] 'range keys from in-memory index tree'  (duration: 401.478955ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:07.977028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:08:07.574486Z","time spent":"402.528132ms","remote":"127.0.0.1:45206","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-28T04:08:07.995523Z","caller":"traceutil/trace.go:171","msg":"trace[1615511790] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"153.622523ms","start":"2026-08-28T04:08:07.841883Z","end":"2026-08-28T04:08:07.995505Z","steps":["trace[1615511790] 'process raft request'  (duration: 153.071749ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:08:25.398637Z","caller":"traceutil/trace.go:171","msg":"trace[1237723867] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"242.525975ms","start":"2026-08-28T04:08:25.156063Z","end":"2026-08-28T04:08:25.398589Z","steps":["trace[1237723867] 'process raft request'  (duration: 196.548755ms)","trace[1237723867] 'compare'  (duration: 45.729023ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:08:25.401268Z","caller":"traceutil/trace.go:171","msg":"trace[476781725] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"237.584947ms","start":"2026-08-28T04:08:25.163654Z","end":"2026-08-28T04:08:25.401239Z","steps":["trace[476781725] 'process raft request'  (duration: 237.431714ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:08:55.379375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.254381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-28T04:08:55.379515Z","caller":"traceutil/trace.go:171","msg":"trace[373995099] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1206; }","duration":"149.502417ms","start":"2026-08-28T04:08:55.229985Z","end":"2026-08-28T04:08:55.379488Z","steps":["trace[373995099] 'count revisions from in-memory index tree'  (duration: 149.138048ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:08:55.379577Z","caller":"traceutil/trace.go:171","msg":"trace[1508705062] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"110.334231ms","start":"2026-08-28T04:08:55.269193Z","end":"2026-08-28T04:08:55.379527Z","steps":["trace[1508705062] 'process raft request'  (duration: 76.01411ms)","trace[1508705062] 'compare'  (duration: 33.966643ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:09:42.189544Z","caller":"traceutil/trace.go:171","msg":"trace[161262767] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"243.941403ms","start":"2026-08-28T04:09:41.945561Z","end":"2026-08-28T04:09:42.189502Z","steps":["trace[161262767] 'process raft request'  (duration: 191.58827ms)","trace[161262767] 'compare'  (duration: 51.926522ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:09:42.21839Z","caller":"traceutil/trace.go:171","msg":"trace[369603232] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"272.489751ms","start":"2026-08-28T04:09:41.945878Z","end":"2026-08-28T04:09:42.218368Z","steps":["trace[369603232] 'process raft request'  (duration: 272.373558ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:09:42.485035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.39851ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677113740908054 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1808 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-28T04:09:42.485161Z","caller":"traceutil/trace.go:171","msg":"trace[405467526] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"229.400424ms","start":"2026-08-28T04:09:42.255743Z","end":"2026-08-28T04:09:42.485144Z","steps":["trace[405467526] 'read index received'  (duration: 58.594623ms)","trace[405467526] 'applied index is now lower than readState.Index'  (duration: 170.799691ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:09:42.485242Z","caller":"traceutil/trace.go:171","msg":"trace[2008917955] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"262.475816ms","start":"2026-08-28T04:09:42.222721Z","end":"2026-08-28T04:09:42.485197Z","steps":["trace[2008917955] 'process raft request'  (duration: 91.567583ms)","trace[2008917955] 'compare'  (duration: 170.234316ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:09:42.485351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.615439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-75a82bae-2cf1-4907-8e38-768289a2df71\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-28T04:09:42.48538Z","caller":"traceutil/trace.go:171","msg":"trace[578558179] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-75a82bae-2cf1-4907-8e38-768289a2df71; range_end:; response_count:1; response_revision:1871; }","duration":"229.67113ms","start":"2026-08-28T04:09:42.255699Z","end":"2026-08-28T04:09:42.48537Z","steps":["trace[578558179] 'agreement among raft nodes before linearized reading'  (duration: 229.536477ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:10:27.444086Z","caller":"traceutil/trace.go:171","msg":"trace[1540332606] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"129.069767ms","start":"2026-08-28T04:10:27.314986Z","end":"2026-08-28T04:10:27.444056Z","steps":["trace[1540332606] 'process raft request'  (duration: 128.876491ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:10:27.745248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.630667ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677113740908761 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2163 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-28T04:10:27.745404Z","caller":"traceutil/trace.go:171","msg":"trace[1289049776] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2255; }","duration":"220.366118ms","start":"2026-08-28T04:10:27.524998Z","end":"2026-08-28T04:10:27.745364Z","steps":["trace[1289049776] 'read index received'  (duration: 114.424703ms)","trace[1289049776] 'applied index is now lower than readState.Index'  (duration: 105.939725ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:10:27.745499Z","caller":"traceutil/trace.go:171","msg":"trace[1375211840] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"246.170456ms","start":"2026-08-28T04:10:27.499268Z","end":"2026-08-28T04:10:27.745439Z","steps":["trace[1375211840] 'process raft request'  (duration: 140.222421ms)","trace[1375211840] 'compare'  (duration: 105.446673ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:10:27.745624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.622816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-28T04:10:27.74566Z","caller":"traceutil/trace.go:171","msg":"trace[1156390034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2174; }","duration":"220.701118ms","start":"2026-08-28T04:10:27.524946Z","end":"2026-08-28T04:10:27.745647Z","steps":["trace[1156390034] 'agreement among raft nodes before linearized reading'  (duration: 220.512682ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:10:27.811493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.191972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:10:27.811522Z","caller":"traceutil/trace.go:171","msg":"trace[499027209] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"115.764826ms","start":"2026-08-28T04:10:27.695711Z","end":"2026-08-28T04:10:27.811476Z","steps":["trace[499027209] 'process raft request'  (duration: 115.529461ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:10:27.81156Z","caller":"traceutil/trace.go:171","msg":"trace[241191487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2175; }","duration":"236.312535ms","start":"2026-08-28T04:10:27.575232Z","end":"2026-08-28T04:10:27.811545Z","steps":["trace[241191487] 'agreement among raft nodes before linearized reading'  (duration: 236.164571ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:10:27.935234Z","caller":"traceutil/trace.go:171","msg":"trace[1430352143] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2257; }","duration":"122.531281ms","start":"2026-08-28T04:10:27.812664Z","end":"2026-08-28T04:10:27.935196Z","steps":["trace[1430352143] 'read index received'  (duration: 121.128684ms)","trace[1430352143] 'applied index is now lower than readState.Index'  (duration: 1.401367ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:10:27.935342Z","caller":"traceutil/trace.go:171","msg":"trace[1197606431] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"176.96414ms","start":"2026-08-28T04:10:27.75836Z","end":"2026-08-28T04:10:27.935324Z","steps":["trace[1197606431] 'process raft request'  (duration: 175.531223ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:10:27.935735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.880909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:10:27.935859Z","caller":"traceutil/trace.go:171","msg":"trace[871309598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2176; }","duration":"123.214087ms","start":"2026-08-28T04:10:27.812618Z","end":"2026-08-28T04:10:27.935833Z","steps":["trace[871309598] 'agreement among raft nodes before linearized reading'  (duration: 122.835638ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:11:23.104414Z","caller":"traceutil/trace.go:171","msg":"trace[1830188267] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"106.809233ms","start":"2026-08-28T04:11:22.997547Z","end":"2026-08-28T04:11:23.104357Z","steps":["trace[1830188267] 'process raft request'  (duration: 106.555066ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:11:26.399996Z","caller":"traceutil/trace.go:171","msg":"trace[1961374308] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"104.258306ms","start":"2026-08-28T04:11:26.295706Z","end":"2026-08-28T04:11:26.399965Z","steps":["trace[1961374308] 'process raft request'  (duration: 104.106242ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:11:27.251665Z","caller":"traceutil/trace.go:171","msg":"trace[123844473] linearizableReadLoop","detail":"{readStateIndex:2774; appliedIndex:2773; }","duration":"108.472556ms","start":"2026-08-28T04:11:27.14317Z","end":"2026-08-28T04:11:27.251642Z","steps":["trace[123844473] 'read index received'  (duration: 108.162348ms)","trace[123844473] 'applied index is now lower than readState.Index'  (duration: 308.738µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:11:27.251727Z","caller":"traceutil/trace.go:171","msg":"trace[867806062] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"119.916454ms","start":"2026-08-28T04:11:27.131776Z","end":"2026-08-28T04:11:27.251693Z","steps":["trace[867806062] 'process raft request'  (duration: 119.669707ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:11:27.251979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.784015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-28T04:11:27.252051Z","caller":"traceutil/trace.go:171","msg":"trace[348723437] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2671; }","duration":"108.922539ms","start":"2026-08-28T04:11:27.143112Z","end":"2026-08-28T04:11:27.252035Z","steps":["trace[348723437] 'agreement among raft nodes before linearized reading'  (duration: 108.676713ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:11:55.664867Z","caller":"traceutil/trace.go:171","msg":"trace[862290770] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"119.774841ms","start":"2026-08-28T04:11:55.545046Z","end":"2026-08-28T04:11:55.664821Z","steps":["trace[862290770] 'process raft request'  (duration: 96.147617ms)","trace[862290770] 'compare'  (duration: 23.333165ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:11:55.685849Z","caller":"traceutil/trace.go:171","msg":"trace[184452706] linearizableReadLoop","detail":"{readStateIndex:2957; appliedIndex:2955; }","duration":"109.871382ms","start":"2026-08-28T04:11:55.575952Z","end":"2026-08-28T04:11:55.685824Z","steps":["trace[184452706] 'read index received'  (duration: 65.426339ms)","trace[184452706] 'applied index is now lower than readState.Index'  (duration: 44.443423ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:11:55.686098Z","caller":"traceutil/trace.go:171","msg":"trace[437146977] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"140.071298ms","start":"2026-08-28T04:11:55.545995Z","end":"2026-08-28T04:11:55.686067Z","steps":["trace[437146977] 'process raft request'  (duration: 139.716728ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:11:55.686342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.15068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:11:55.686399Z","caller":"traceutil/trace.go:171","msg":"trace[240282965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2847; }","duration":"110.480918ms","start":"2026-08-28T04:11:55.5759Z","end":"2026-08-28T04:11:55.686381Z","steps":["trace[240282965] 'agreement among raft nodes before linearized reading'  (duration: 110.006656ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:01.153024Z","caller":"traceutil/trace.go:171","msg":"trace[39816758] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"144.480721ms","start":"2026-08-28T04:12:01.008514Z","end":"2026-08-28T04:12:01.152995Z","steps":["trace[39816758] 'process raft request'  (duration: 144.234445ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:01.307735Z","caller":"traceutil/trace.go:171","msg":"trace[1243333526] linearizableReadLoop","detail":"{readStateIndex:2986; appliedIndex:2984; }","duration":"195.682621ms","start":"2026-08-28T04:12:01.112021Z","end":"2026-08-28T04:12:01.307703Z","steps":["trace[1243333526] 'read index received'  (duration: 40.741658ms)","trace[1243333526] 'applied index is now lower than readState.Index'  (duration: 154.939753ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:12:01.307953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.921228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-08-28T04:12:01.308006Z","caller":"traceutil/trace.go:171","msg":"trace[916656549] transaction","detail":"{read_only:false; response_revision:2875; number_of_response:1; }","duration":"294.422585ms","start":"2026-08-28T04:12:01.013433Z","end":"2026-08-28T04:12:01.307856Z","steps":["trace[916656549] 'process raft request'  (duration: 211.011689ms)","trace[916656549] 'compare'  (duration: 83.104008ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:12:01.308092Z","caller":"traceutil/trace.go:171","msg":"trace[386361898] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2875; }","duration":"196.02359ms","start":"2026-08-28T04:12:01.11196Z","end":"2026-08-28T04:12:01.307983Z","steps":["trace[386361898] 'agreement among raft nodes before linearized reading'  (duration: 195.856106ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.937056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.744504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-08-28T04:12:01.937144Z","caller":"traceutil/trace.go:171","msg":"trace[1115701285] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2875; }","duration":"430.893548ms","start":"2026-08-28T04:12:01.506227Z","end":"2026-08-28T04:12:01.937121Z","steps":["trace[1115701285] 'range keys from in-memory index tree'  (duration: 430.518498ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.937187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:01.506193Z","time spent":"430.98464ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-08-28T04:12:01.93729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.132992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18cfdcc080da2bb1\" ","response":"range_response_count:1 size:777"}
{"level":"warn","ts":"2026-08-28T04:12:01.937365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.170945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-28T04:12:01.937442Z","caller":"traceutil/trace.go:171","msg":"trace[1097856348] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18cfdcc080da2bb1; range_end:; response_count:1; response_revision:2875; }","duration":"491.379819ms","start":"2026-08-28T04:12:01.446029Z","end":"2026-08-28T04:12:01.937409Z","steps":["trace[1097856348] 'range keys from in-memory index tree'  (duration: 490.832064ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.937559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:01.446Z","time spent":"491.543483ms","remote":"127.0.0.1:45254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":801,"request content":"key:\"/registry/events/auth-system/keycloak-0.18cfdcc080da2bb1\" "}
{"level":"warn","ts":"2026-08-28T04:12:01.937602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.464662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:12:01.937636Z","caller":"traceutil/trace.go:171","msg":"trace[89369906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2875; }","duration":"362.523443ms","start":"2026-08-28T04:12:01.575104Z","end":"2026-08-28T04:12:01.937627Z","steps":["trace[89369906] 'range keys from in-memory index tree'  (duration: 362.375198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.937674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:01.575084Z","time spent":"362.579035ms","remote":"127.0.0.1:45194","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-28T04:12:01.937963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.82288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-28T04:12:01.938008Z","caller":"traceutil/trace.go:171","msg":"trace[1255275392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2875; }","duration":"248.917232ms","start":"2026-08-28T04:12:01.689078Z","end":"2026-08-28T04:12:01.937995Z","steps":["trace[1255275392] 'range keys from in-memory index tree'  (duration: 248.706367ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:01.937455Z","caller":"traceutil/trace.go:171","msg":"trace[366850796] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2875; }","duration":"426.318089ms","start":"2026-08-28T04:12:01.511111Z","end":"2026-08-28T04:12:01.937429Z","steps":["trace[366850796] 'range keys from in-memory index tree'  (duration: 425.93829ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.938225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:01.511069Z","time spent":"427.13008ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-28T04:12:01.937574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.161638ms","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-28T04:12:01.938441Z","caller":"traceutil/trace.go:171","msg":"trace[1074878039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2875; }","duration":"372.065141ms","start":"2026-08-28T04:12:01.566361Z","end":"2026-08-28T04:12:01.938426Z","steps":["trace[1074878039] 'range keys from in-memory index tree'  (duration: 370.995884ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:12:01.938514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:01.566339Z","time spent":"372.159493ms","remote":"127.0.0.1:45442","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-28T04:12:01.938999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.745087ms","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-28T04:12:01.939039Z","caller":"traceutil/trace.go:171","msg":"trace[720969620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2875; }","duration":"231.845979ms","start":"2026-08-28T04:12:01.707183Z","end":"2026-08-28T04:12:01.939029Z","steps":["trace[720969620] 'range keys from in-memory index tree'  (duration: 230.885225ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.160823Z","caller":"traceutil/trace.go:171","msg":"trace[379182969] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"220.259419ms","start":"2026-08-28T04:12:01.940527Z","end":"2026-08-28T04:12:02.160786Z","steps":["trace[379182969] 'process raft request'  (duration: 220.035063ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.2434Z","caller":"traceutil/trace.go:171","msg":"trace[521213275] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"297.712891ms","start":"2026-08-28T04:12:01.945661Z","end":"2026-08-28T04:12:02.243374Z","steps":["trace[521213275] 'process raft request'  (duration: 297.655939ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.243409Z","caller":"traceutil/trace.go:171","msg":"trace[1124812942] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"299.434705ms","start":"2026-08-28T04:12:01.943905Z","end":"2026-08-28T04:12:02.24334Z","steps":["trace[1124812942] 'process raft request'  (duration: 298.602563ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.243518Z","caller":"traceutil/trace.go:171","msg":"trace[1147325791] transaction","detail":"{read_only:false; response_revision:2879; number_of_response:1; }","duration":"299.314001ms","start":"2026-08-28T04:12:01.944193Z","end":"2026-08-28T04:12:02.243507Z","steps":["trace[1147325791] 'process raft request'  (duration: 299.042934ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.243404Z","caller":"traceutil/trace.go:171","msg":"trace[827362900] transaction","detail":"{read_only:false; response_revision:2878; number_of_response:1; }","duration":"299.339592ms","start":"2026-08-28T04:12:01.944037Z","end":"2026-08-28T04:12:02.243377Z","steps":["trace[827362900] 'process raft request'  (duration: 299.056015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:12:02.244007Z","caller":"traceutil/trace.go:171","msg":"trace[1057337938] transaction","detail":"{read_only:false; response_revision:2880; number_of_response:1; }","duration":"298.764497ms","start":"2026-08-28T04:12:01.945106Z","end":"2026-08-28T04:12:02.243871Z","steps":["trace[1057337938] 'process raft request'  (duration: 298.173351ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:15:14.450958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.69849ms","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-28T04:15:14.451486Z","caller":"traceutil/trace.go:171","msg":"trace[1268881380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4085; }","duration":"116.267825ms","start":"2026-08-28T04:15:14.335197Z","end":"2026-08-28T04:15:14.451465Z","steps":["trace[1268881380] 'range keys from in-memory index tree'  (duration: 115.505856ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:46.995689Z","caller":"traceutil/trace.go:171","msg":"trace[916470573] linearizableReadLoop","detail":"{readStateIndex:5375; appliedIndex:5374; }","duration":"189.668416ms","start":"2026-08-28T04:16:46.805996Z","end":"2026-08-28T04:16:46.995664Z","steps":["trace[916470573] 'read index received'  (duration: 179.730551ms)","trace[916470573] 'applied index is now lower than readState.Index'  (duration: 9.936905ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:16:46.995836Z","caller":"traceutil/trace.go:171","msg":"trace[478625408] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"204.67259ms","start":"2026-08-28T04:16:46.791128Z","end":"2026-08-28T04:16:46.995801Z","steps":["trace[478625408] 'process raft request'  (duration: 194.583571ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:46.996076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.430905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-08-28T04:16:46.996152Z","caller":"traceutil/trace.go:171","msg":"trace[107245768] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5178; }","duration":"206.523737ms","start":"2026-08-28T04:16:46.789613Z","end":"2026-08-28T04:16:46.996137Z","steps":["trace[107245768] 'agreement among raft nodes before linearized reading'  (duration: 206.344053ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:47.015681Z","caller":"traceutil/trace.go:171","msg":"trace[2092704317] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5178; }","duration":"189.939672ms","start":"2026-08-28T04:16:46.82571Z","end":"2026-08-28T04:16:47.015649Z","steps":["trace[2092704317] 'process raft request'  (duration: 189.631054ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:47.016123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.20648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:531300"}
{"level":"info","ts":"2026-08-28T04:16:47.016207Z","caller":"traceutil/trace.go:171","msg":"trace[1814518184] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:5178; }","duration":"153.345533ms","start":"2026-08-28T04:16:46.862843Z","end":"2026-08-28T04:16:47.016188Z","steps":["trace[1814518184] 'agreement among raft nodes before linearized reading'  (duration: 152.702306ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:47.01627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.859228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"}
{"level":"info","ts":"2026-08-28T04:16:47.016354Z","caller":"traceutil/trace.go:171","msg":"trace[715554037] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5178; }","duration":"107.996131ms","start":"2026-08-28T04:16:46.908345Z","end":"2026-08-28T04:16:47.016342Z","steps":["trace[715554037] 'agreement among raft nodes before linearized reading'  (duration: 107.16983ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.102122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.128646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677113740916565 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/namespaces/monitoring\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/monitoring\" value_size:318 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-08-28T04:16:52.102252Z","caller":"traceutil/trace.go:171","msg":"trace[1964624753] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5318; }","duration":"220.25401ms","start":"2026-08-28T04:16:51.881974Z","end":"2026-08-28T04:16:52.102228Z","steps":["trace[1964624753] 'process raft request'  (duration: 38.935478ms)","trace[1964624753] 'compare'  (duration: 181.081655ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:16:52.102249Z","caller":"traceutil/trace.go:171","msg":"trace[846726456] linearizableReadLoop","detail":"{readStateIndex:5520; appliedIndex:5519; }","duration":"203.570362ms","start":"2026-08-28T04:16:51.898655Z","end":"2026-08-28T04:16:52.102225Z","steps":["trace[846726456] 'read index received'  (duration: 22.208039ms)","trace[846726456] 'applied index is now lower than readState.Index'  (duration: 181.361073ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:16:52.102679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.001772ms","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-28T04:16:52.10277Z","caller":"traceutil/trace.go:171","msg":"trace[43725320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5318; }","duration":"204.130726ms","start":"2026-08-28T04:16:51.898603Z","end":"2026-08-28T04:16:52.102734Z","steps":["trace[43725320] 'agreement among raft nodes before linearized reading'  (duration: 203.877569ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.103054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.289589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-28T04:16:52.103107Z","caller":"traceutil/trace.go:171","msg":"trace[885294130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5318; }","duration":"202.368661ms","start":"2026-08-28T04:16:51.900722Z","end":"2026-08-28T04:16:52.103091Z","steps":["trace[885294130] 'agreement among raft nodes before linearized reading'  (duration: 202.193246ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.103192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.789316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-46be9216-e5df-426c-aa7e-ca45db5bfa2a\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-08-28T04:16:52.103245Z","caller":"traceutil/trace.go:171","msg":"trace[228910966] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-46be9216-e5df-426c-aa7e-ca45db5bfa2a; range_end:; response_count:1; response_revision:5318; }","duration":"139.876019ms","start":"2026-08-28T04:16:51.963354Z","end":"2026-08-28T04:16:52.10323Z","steps":["trace[228910966] 'agreement among raft nodes before linearized reading'  (duration: 139.5667ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.103364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.754211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-28T04:16:52.103461Z","caller":"traceutil/trace.go:171","msg":"trace[1009653850] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5318; }","duration":"193.880574ms","start":"2026-08-28T04:16:51.909556Z","end":"2026-08-28T04:16:52.103437Z","steps":["trace[1009653850] 'agreement among raft nodes before linearized reading'  (duration: 193.572436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:52.279716Z","caller":"traceutil/trace.go:171","msg":"trace[1342050343] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"172.775313ms","start":"2026-08-28T04:16:52.106907Z","end":"2026-08-28T04:16:52.279682Z","steps":["trace[1342050343] 'process raft request'  (duration: 172.266579ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:52.279738Z","caller":"traceutil/trace.go:171","msg":"trace[1575947461] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"153.683263ms","start":"2026-08-28T04:16:52.126021Z","end":"2026-08-28T04:16:52.279705Z","steps":["trace[1575947461] 'process raft request'  (duration: 153.56151ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:52.280115Z","caller":"traceutil/trace.go:171","msg":"trace[599245443] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"158.818895ms","start":"2026-08-28T04:16:52.120909Z","end":"2026-08-28T04:16:52.279728Z","steps":["trace[599245443] 'process raft request'  (duration: 158.575718ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:52.569617Z","caller":"traceutil/trace.go:171","msg":"trace[1203980087] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"170.210066ms","start":"2026-08-28T04:16:52.399377Z","end":"2026-08-28T04:16:52.569587Z","steps":["trace[1203980087] 'process raft request'  (duration: 144.564699ms)","trace[1203980087] 'compare'  (duration: 25.517444ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:16:52.727849Z","caller":"traceutil/trace.go:171","msg":"trace[438705753] linearizableReadLoop","detail":"{readStateIndex:5534; appliedIndex:5532; }","duration":"290.183445ms","start":"2026-08-28T04:16:52.437642Z","end":"2026-08-28T04:16:52.727826Z","steps":["trace[438705753] 'read index received'  (duration: 106.363039ms)","trace[438705753] 'applied index is now lower than readState.Index'  (duration: 183.819566ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:16:52.727945Z","caller":"traceutil/trace.go:171","msg":"trace[2018036218] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"312.566829ms","start":"2026-08-28T04:16:52.415333Z","end":"2026-08-28T04:16:52.7279Z","steps":["trace[2018036218] 'process raft request'  (duration: 276.129734ms)","trace[2018036218] 'compare'  (duration: 36.2324ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:16:52.728126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.478732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k9klh\" ","response":"range_response_count:1 size:6522"}
{"level":"warn","ts":"2026-08-28T04:16:52.728142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:16:52.415311Z","time spent":"312.727722ms","remote":"127.0.0.1:45272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58177,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" mod_revision:5322 > success:<request_put:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" value_size:58110 >> failure:<request_range:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" > >"}
{"level":"info","ts":"2026-08-28T04:16:52.728194Z","caller":"traceutil/trace.go:171","msg":"trace[1359742163] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k9klh; range_end:; response_count:1; response_revision:5332; }","duration":"290.590725ms","start":"2026-08-28T04:16:52.437588Z","end":"2026-08-28T04:16:52.728179Z","steps":["trace[1359742163] 'agreement among raft nodes before linearized reading'  (duration: 290.360549ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.740146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.744017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:16:52.740215Z","caller":"traceutil/trace.go:171","msg":"trace[1712043459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5333; }","duration":"164.86531ms","start":"2026-08-28T04:16:52.575333Z","end":"2026-08-28T04:16:52.740198Z","steps":["trace[1712043459] 'agreement among raft nodes before linearized reading'  (duration: 164.673996ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:16:52.740291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.14382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-28T04:16:52.740414Z","caller":"traceutil/trace.go:171","msg":"trace[1905749921] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5333; }","duration":"270.323325ms","start":"2026-08-28T04:16:52.470062Z","end":"2026-08-28T04:16:52.740385Z","steps":["trace[1905749921] 'agreement among raft nodes before linearized reading'  (duration: 270.028118ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:16:52.740426Z","caller":"traceutil/trace.go:171","msg":"trace[2094899752] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"163.811602ms","start":"2026-08-28T04:16:52.576589Z","end":"2026-08-28T04:16:52.740401Z","steps":["trace[2094899752] 'process raft request'  (duration: 163.222998ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:06.684892Z","caller":"traceutil/trace.go:171","msg":"trace[1480804285] transaction","detail":"{read_only:false; response_revision:5592; number_of_response:1; }","duration":"100.904299ms","start":"2026-08-28T04:17:06.583965Z","end":"2026-08-28T04:17:06.684869Z","steps":["trace[1480804285] 'process raft request'  (duration: 27.330912ms)","trace[1480804285] 'compare'  (duration: 73.450073ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:17:07.081975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.29281ms","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-28T04:17:07.082056Z","caller":"traceutil/trace.go:171","msg":"trace[1486699816] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5594; }","duration":"248.425823ms","start":"2026-08-28T04:17:06.833612Z","end":"2026-08-28T04:17:07.082038Z","steps":["trace[1486699816] 'range keys from in-memory index tree'  (duration: 248.149117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:17:07.082075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.922737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-pmsnw\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-08-28T04:17:07.082157Z","caller":"traceutil/trace.go:171","msg":"trace[973527659] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-pmsnw; range_end:; response_count:1; response_revision:5594; }","duration":"274.040279ms","start":"2026-08-28T04:17:06.808095Z","end":"2026-08-28T04:17:07.082136Z","steps":["trace[973527659] 'range keys from in-memory index tree'  (duration: 273.745252ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:17:07.082817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.267823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k9klh\" ","response":"range_response_count:1 size:6522"}
{"level":"info","ts":"2026-08-28T04:17:07.082938Z","caller":"traceutil/trace.go:171","msg":"trace[492172265] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k9klh; range_end:; response_count:1; response_revision:5594; }","duration":"261.93534ms","start":"2026-08-28T04:17:06.820984Z","end":"2026-08-28T04:17:07.082919Z","steps":["trace[492172265] 'range keys from in-memory index tree'  (duration: 260.893683ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:07.38717Z","caller":"traceutil/trace.go:171","msg":"trace[738034546] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"296.395494ms","start":"2026-08-28T04:17:07.090755Z","end":"2026-08-28T04:17:07.387151Z","steps":["trace[738034546] 'process raft request'  (duration: 296.289121ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:07.38718Z","caller":"traceutil/trace.go:171","msg":"trace[1307793738] linearizableReadLoop","detail":"{readStateIndex:5806; appliedIndex:5806; }","duration":"293.695525ms","start":"2026-08-28T04:17:07.093461Z","end":"2026-08-28T04:17:07.387157Z","steps":["trace[1307793738] 'read index received'  (duration: 293.687025ms)","trace[1307793738] 'applied index is now lower than readState.Index'  (duration: 6.78µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:17:07.38772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.248758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:70681"}
{"level":"info","ts":"2026-08-28T04:17:07.387827Z","caller":"traceutil/trace.go:171","msg":"trace[1164195835] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5595; }","duration":"294.391303ms","start":"2026-08-28T04:17:07.09342Z","end":"2026-08-28T04:17:07.387812Z","steps":["trace[1164195835] 'agreement among raft nodes before linearized reading'  (duration: 293.778297ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:07.545349Z","caller":"traceutil/trace.go:171","msg":"trace[96944237] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"440.49138ms","start":"2026-08-28T04:17:07.104824Z","end":"2026-08-28T04:17:07.545316Z","steps":["trace[96944237] 'process raft request'  (duration: 440.150481ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:17:07.545509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:17:07.104795Z","time spent":"440.634044ms","remote":"127.0.0.1:45348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8038,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-6479589586-pmsnw\" mod_revision:5577 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-pmsnw\" value_size:7969 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-6479589586-pmsnw\" > >"}
{"level":"info","ts":"2026-08-28T04:17:07.545639Z","caller":"traceutil/trace.go:171","msg":"trace[1049564843] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"202.018113ms","start":"2026-08-28T04:17:07.343567Z","end":"2026-08-28T04:17:07.545586Z","steps":["trace[1049564843] 'process raft request'  (duration: 201.585851ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:17:07.545844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.70304ms","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-28T04:17:07.545929Z","caller":"traceutil/trace.go:171","msg":"trace[992016192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5597; }","duration":"409.834704ms","start":"2026-08-28T04:17:07.136074Z","end":"2026-08-28T04:17:07.545909Z","steps":["trace[992016192] 'agreement among raft nodes before linearized reading'  (duration: 409.599678ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:17:07.545979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:17:07.136053Z","time spent":"409.914566ms","remote":"127.0.0.1:45442","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":"info","ts":"2026-08-28T04:17:07.545622Z","caller":"traceutil/trace.go:171","msg":"trace[661971539] linearizableReadLoop","detail":"{readStateIndex:5808; appliedIndex:5806; }","duration":"158.248449ms","start":"2026-08-28T04:17:07.38731Z","end":"2026-08-28T04:17:07.545559Z","steps":["trace[661971539] 'read index received'  (duration: 157.595463ms)","trace[661971539] 'applied index is now lower than readState.Index'  (duration: 651.986µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:17:07.560424Z","caller":"traceutil/trace.go:171","msg":"trace[781287742] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"104.045649ms","start":"2026-08-28T04:17:07.456355Z","end":"2026-08-28T04:17:07.560401Z","steps":["trace[781287742] 'process raft request'  (duration: 103.903845ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:15.984545Z","caller":"traceutil/trace.go:171","msg":"trace[1771119304] transaction","detail":"{read_only:false; response_revision:5799; number_of_response:1; }","duration":"119.428604ms","start":"2026-08-28T04:17:15.865094Z","end":"2026-08-28T04:17:15.984523Z","steps":["trace[1771119304] 'process raft request'  (duration: 119.239219ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:17:21.763896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989}
{"level":"info","ts":"2026-08-28T04:17:21.840844Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"75.521648ms","hash":3093678445,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":32268288,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-28T04:17:21.840913Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3093678445,"revision":2989,"compact-revision":-1}
{"level":"info","ts":"2026-08-28T04:22:21.775632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5880}
{"level":"info","ts":"2026-08-28T04:22:21.898546Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5880,"took":"120.902375ms","hash":2882617328,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":26316800,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-28T04:22:21.898616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2882617328,"revision":5880,"compact-revision":2989}
{"level":"info","ts":"2026-08-28T04:23:20.234173Z","caller":"traceutil/trace.go:171","msg":"trace[922768385] linearizableReadLoop","detail":"{readStateIndex:8889; appliedIndex:8888; }","duration":"378.789186ms","start":"2026-08-28T04:23:19.855341Z","end":"2026-08-28T04:23:20.23413Z","steps":["trace[922768385] 'read index received'  (duration: 378.540668ms)","trace[922768385] 'applied index is now lower than readState.Index'  (duration: 247.468µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:23:20.23428Z","caller":"traceutil/trace.go:171","msg":"trace[1106018632] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"389.029377ms","start":"2026-08-28T04:23:19.845219Z","end":"2026-08-28T04:23:20.234248Z","steps":["trace[1106018632] 'process raft request'  (duration: 388.728499ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:20.234362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.478076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:23:20.234418Z","caller":"traceutil/trace.go:171","msg":"trace[978368423] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:8583; }","duration":"317.596379ms","start":"2026-08-28T04:23:19.916808Z","end":"2026-08-28T04:23:20.234404Z","steps":["trace[978368423] 'agreement among raft nodes before linearized reading'  (duration: 317.476676ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:20.234441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.078853ms","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-28T04:23:20.234448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:19.845192Z","time spent":"389.171651ms","remote":"127.0.0.1:45254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1117,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/barbican-api-8449d8bbf-stg2l.18cfdd61f298ba11\" mod_revision:8395 > success:<request_put:<key:\"/registry/events/openstack/barbican-api-8449d8bbf-stg2l.18cfdd61f298ba11\" value_size:1027 lease:6925305076886147950 >> failure:<request_range:<key:\"/registry/events/openstack/barbican-api-8449d8bbf-stg2l.18cfdd61f298ba11\" > >"}
{"level":"warn","ts":"2026-08-28T04:23:20.234478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:19.916787Z","time spent":"317.676791ms","remote":"127.0.0.1:45498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"info","ts":"2026-08-28T04:23:20.234522Z","caller":"traceutil/trace.go:171","msg":"trace[1468074249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8583; }","duration":"379.185616ms","start":"2026-08-28T04:23:19.855316Z","end":"2026-08-28T04:23:20.234502Z","steps":["trace[1468074249] 'agreement among raft nodes before linearized reading'  (duration: 378.97278ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:20.23454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.428011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"}
{"level":"warn","ts":"2026-08-28T04:23:20.234575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:19.855305Z","time spent":"379.257577ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-28T04:23:20.234615Z","caller":"traceutil/trace.go:171","msg":"trace[1735505716] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8583; }","duration":"134.522493ms","start":"2026-08-28T04:23:20.100074Z","end":"2026-08-28T04:23:20.234596Z","steps":["trace[1735505716] 'agreement among raft nodes before linearized reading'  (duration: 134.308378ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:20.234595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.759917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:23:20.234698Z","caller":"traceutil/trace.go:171","msg":"trace[802357148] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:8583; }","duration":"180.90237ms","start":"2026-08-28T04:23:20.05377Z","end":"2026-08-28T04:23:20.234672Z","steps":["trace[802357148] 'agreement among raft nodes before linearized reading'  (duration: 180.730616ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:23:30.554182Z","caller":"traceutil/trace.go:171","msg":"trace[1441214467] linearizableReadLoop","detail":"{readStateIndex:8947; appliedIndex:8946; }","duration":"170.207558ms","start":"2026-08-28T04:23:30.383947Z","end":"2026-08-28T04:23:30.554155Z","steps":["trace[1441214467] 'read index received'  (duration: 170.008813ms)","trace[1441214467] 'applied index is now lower than readState.Index'  (duration: 197.735µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:23:30.554246Z","caller":"traceutil/trace.go:171","msg":"trace[278692774] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"171.130591ms","start":"2026-08-28T04:23:30.38309Z","end":"2026-08-28T04:23:30.554221Z","steps":["trace[278692774] 'process raft request'  (duration: 170.851933ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:30.554441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.468954ms","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-28T04:23:30.554496Z","caller":"traceutil/trace.go:171","msg":"trace[1319455551] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8638; }","duration":"170.557236ms","start":"2026-08-28T04:23:30.383925Z","end":"2026-08-28T04:23:30.554482Z","steps":["trace[1319455551] 'agreement among raft nodes before linearized reading'  (duration: 170.362111ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:23:30.692648Z","caller":"traceutil/trace.go:171","msg":"trace[1787162879] linearizableReadLoop","detail":"{readStateIndex:8948; appliedIndex:8947; }","duration":"138.352642ms","start":"2026-08-28T04:23:30.554261Z","end":"2026-08-28T04:23:30.692614Z","steps":["trace[1787162879] 'read index received'  (duration: 116.82029ms)","trace[1787162879] 'applied index is now lower than readState.Index'  (duration: 21.528812ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:23:30.692668Z","caller":"traceutil/trace.go:171","msg":"trace[82931988] transaction","detail":"{read_only:false; response_revision:8639; number_of_response:1; }","duration":"134.174075ms","start":"2026-08-28T04:23:30.558463Z","end":"2026-08-28T04:23:30.692637Z","steps":["trace[82931988] 'process raft request'  (duration: 134.020561ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:30.692942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.461833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-28T04:23:30.693035Z","caller":"traceutil/trace.go:171","msg":"trace[398261243] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8639; }","duration":"304.588577ms","start":"2026-08-28T04:23:30.388429Z","end":"2026-08-28T04:23:30.693018Z","steps":["trace[398261243] 'agreement among raft nodes before linearized reading'  (duration: 304.345101ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:30.693076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:30.388419Z","time spent":"304.646779ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-28T04:23:30.693394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.311717ms","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-28T04:23:30.693479Z","caller":"traceutil/trace.go:171","msg":"trace[1924848290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8639; }","duration":"309.471242ms","start":"2026-08-28T04:23:30.383987Z","end":"2026-08-28T04:23:30.693458Z","steps":["trace[1924848290] 'agreement among raft nodes before linearized reading'  (duration: 309.193635ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:30.693524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:30.383969Z","time spent":"309.544904ms","remote":"127.0.0.1:45442","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-28T04:23:31.464464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.072499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:23:31.464551Z","caller":"traceutil/trace.go:171","msg":"trace[1580011460] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8643; }","duration":"330.207753ms","start":"2026-08-28T04:23:31.134322Z","end":"2026-08-28T04:23:31.464529Z","steps":["trace[1580011460] 'count revisions from in-memory index tree'  (duration: 329.981087ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:31.46453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.322283ms","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-28T04:23:31.464596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:23:31.134304Z","time spent":"330.280864ms","remote":"127.0.0.1:45574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "}
{"level":"info","ts":"2026-08-28T04:23:31.464617Z","caller":"traceutil/trace.go:171","msg":"trace[470333778] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8643; }","duration":"158.469627ms","start":"2026-08-28T04:23:31.306127Z","end":"2026-08-28T04:23:31.464597Z","steps":["trace[470333778] 'range keys from in-memory index tree'  (duration: 158.100748ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:23:31.500981Z","caller":"traceutil/trace.go:171","msg":"trace[32562155] linearizableReadLoop","detail":"{readStateIndex:8954; appliedIndex:8953; }","duration":"113.583717ms","start":"2026-08-28T04:23:31.387375Z","end":"2026-08-28T04:23:31.500958Z","steps":["trace[32562155] 'read index received'  (duration: 113.517796ms)","trace[32562155] 'applied index is now lower than readState.Index'  (duration: 64.801µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:23:31.501112Z","caller":"traceutil/trace.go:171","msg":"trace[1613539509] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"115.982159ms","start":"2026-08-28T04:23:31.385103Z","end":"2026-08-28T04:23:31.501085Z","steps":["trace[1613539509] 'process raft request'  (duration: 115.704742ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:23:31.501148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.766172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:23:31.501262Z","caller":"traceutil/trace.go:171","msg":"trace[971569011] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:8644; }","duration":"113.932786ms","start":"2026-08-28T04:23:31.387314Z","end":"2026-08-28T04:23:31.501247Z","steps":["trace[971569011] 'agreement among raft nodes before linearized reading'  (duration: 113.752812ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:23:59.912583Z","caller":"traceutil/trace.go:171","msg":"trace[888685177] linearizableReadLoop","detail":"{readStateIndex:9167; appliedIndex:9166; }","duration":"116.662375ms","start":"2026-08-28T04:23:59.795895Z","end":"2026-08-28T04:23:59.912557Z","steps":["trace[888685177] 'read index received'  (duration: 29.463994ms)","trace[888685177] 'applied index is now lower than readState.Index'  (duration: 87.197571ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:23:59.912882Z","caller":"traceutil/trace.go:171","msg":"trace[1264332333] transaction","detail":"{read_only:false; response_revision:8850; number_of_response:1; }","duration":"119.938361ms","start":"2026-08-28T04:23:59.792925Z","end":"2026-08-28T04:23:59.912864Z","steps":["trace[1264332333] 'process raft request'  (duration: 32.478432ms)","trace[1264332333] 'compare'  (duration: 87.059898ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:23:59.913218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.299082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k9klh\" ","response":"range_response_count:1 size:6522"}
{"level":"info","ts":"2026-08-28T04:23:59.913265Z","caller":"traceutil/trace.go:171","msg":"trace[801808793] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k9klh; range_end:; response_count:1; response_revision:8850; }","duration":"117.385276ms","start":"2026-08-28T04:23:59.795865Z","end":"2026-08-28T04:23:59.913251Z","steps":["trace[801808793] 'agreement among raft nodes before linearized reading'  (duration: 117.235272ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:24:01.031887Z","caller":"traceutil/trace.go:171","msg":"trace[1893981502] transaction","detail":"{read_only:false; response_revision:8855; number_of_response:1; }","duration":"132.696367ms","start":"2026-08-28T04:24:00.899155Z","end":"2026-08-28T04:24:01.031852Z","steps":["trace[1893981502] 'process raft request'  (duration: 132.621595ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:24:01.032035Z","caller":"traceutil/trace.go:171","msg":"trace[1159529246] transaction","detail":"{read_only:false; response_revision:8854; number_of_response:1; }","duration":"134.077972ms","start":"2026-08-28T04:24:00.897916Z","end":"2026-08-28T04:24:01.031994Z","steps":["trace[1159529246] 'process raft request'  (duration: 50.557244ms)","trace[1159529246] 'compare'  (duration: 83.109277ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:24:05.858181Z","caller":"traceutil/trace.go:171","msg":"trace[1228787375] transaction","detail":"{read_only:false; response_revision:8882; number_of_response:1; }","duration":"147.814933ms","start":"2026-08-28T04:24:05.710332Z","end":"2026-08-28T04:24:05.858146Z","steps":["trace[1228787375] 'process raft request'  (duration: 147.525996ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:24:13.761875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.982938ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16148677113740926257 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-vxtqm\" mod_revision:8961 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-vxtqm\" value_size:4572 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-vxtqm\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-28T04:24:13.762115Z","caller":"traceutil/trace.go:171","msg":"trace[627485536] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"111.150256ms","start":"2026-08-28T04:24:13.650945Z","end":"2026-08-28T04:24:13.762095Z","steps":["trace[627485536] 'process raft request'  (duration: 111.066144ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:24:13.762174Z","caller":"traceutil/trace.go:171","msg":"trace[1016470779] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"167.912458ms","start":"2026-08-28T04:24:13.594207Z","end":"2026-08-28T04:24:13.76212Z","steps":["trace[1016470779] 'process raft request'  (duration: 62.598612ms)","trace[1016470779] 'compare'  (duration: 104.871195ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:24:14.542517Z","caller":"traceutil/trace.go:171","msg":"trace[1021405313] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"108.073316ms","start":"2026-08-28T04:24:14.434424Z","end":"2026-08-28T04:24:14.542497Z","steps":["trace[1021405313] 'process raft request'  (duration: 107.949393ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:24:21.756017Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002490.wal"}
{"level":"info","ts":"2026-08-28T04:25:31.331431Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-28T04:25:31.338476Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-28T04:25:31.3387Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-28T04:27:21.782384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8046}
{"level":"info","ts":"2026-08-28T04:27:21.854786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8046,"took":"70.14556ms","hash":283884460,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":28700672,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-28T04:27:21.854875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":283884460,"revision":8046,"compact-revision":5880}
{"level":"info","ts":"2026-08-28T04:29:45.096875Z","caller":"traceutil/trace.go:171","msg":"trace[1459072715] transaction","detail":"{read_only:false; response_revision:11752; number_of_response:1; }","duration":"141.596387ms","start":"2026-08-28T04:29:44.955247Z","end":"2026-08-28T04:29:45.096843Z","steps":["trace[1459072715] 'process raft request'  (duration: 141.257728ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:29:45.402395Z","caller":"traceutil/trace.go:171","msg":"trace[1759661207] transaction","detail":"{read_only:false; response_revision:11754; number_of_response:1; }","duration":"144.150272ms","start":"2026-08-28T04:29:45.258205Z","end":"2026-08-28T04:29:45.402355Z","steps":["trace[1759661207] 'process raft request'  (duration: 95.494325ms)","trace[1759661207] 'compare'  (duration: 48.340799ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:32:21.791603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10544}
{"level":"info","ts":"2026-08-28T04:32:21.883254Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10544,"took":"89.018253ms","hash":2558890424,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":27709440,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-28T04:32:21.88332Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2558890424,"revision":10544,"compact-revision":8046}
{"level":"info","ts":"2026-08-28T04:35:37.067497Z","caller":"traceutil/trace.go:171","msg":"trace[1757262428] transaction","detail":"{read_only:false; response_revision:14154; number_of_response:1; }","duration":"112.299733ms","start":"2026-08-28T04:35:36.955165Z","end":"2026-08-28T04:35:37.067464Z","steps":["trace[1757262428] 'process raft request'  (duration: 111.965005ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:35:56.968222Z","caller":"traceutil/trace.go:171","msg":"trace[1522516474] linearizableReadLoop","detail":"{readStateIndex:14756; appliedIndex:14755; }","duration":"160.694096ms","start":"2026-08-28T04:35:56.807501Z","end":"2026-08-28T04:35:56.968195Z","steps":["trace[1522516474] 'read index received'  (duration: 160.48118ms)","trace[1522516474] 'applied index is now lower than readState.Index'  (duration: 209.106µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:35:56.968274Z","caller":"traceutil/trace.go:171","msg":"trace[1614949464] transaction","detail":"{read_only:false; response_revision:14262; number_of_response:1; }","duration":"175.537706ms","start":"2026-08-28T04:35:56.792703Z","end":"2026-08-28T04:35:56.968241Z","steps":["trace[1614949464] 'process raft request'  (duration: 175.33054ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:35:56.968421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.89451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-28T04:35:56.968535Z","caller":"traceutil/trace.go:171","msg":"trace[1267268720] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:14262; }","duration":"161.063155ms","start":"2026-08-28T04:35:56.807449Z","end":"2026-08-28T04:35:56.968512Z","steps":["trace[1267268720] 'agreement among raft nodes before linearized reading'  (duration: 160.89677ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:36:22.870642Z","caller":"traceutil/trace.go:171","msg":"trace[402164778] transaction","detail":"{read_only:false; response_revision:14522; number_of_response:1; }","duration":"143.698849ms","start":"2026-08-28T04:36:22.726915Z","end":"2026-08-28T04:36:22.870614Z","steps":["trace[402164778] 'process raft request'  (duration: 143.551225ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:36:22.870911Z","caller":"traceutil/trace.go:171","msg":"trace[1199350080] linearizableReadLoop","detail":"{readStateIndex:15023; appliedIndex:15022; }","duration":"132.562923ms","start":"2026-08-28T04:36:22.738326Z","end":"2026-08-28T04:36:22.870889Z","steps":["trace[1199350080] 'read index received'  (duration: 132.05956ms)","trace[1199350080] 'applied index is now lower than readState.Index'  (duration: 501.463µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:36:22.871208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.687737ms","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-28T04:36:22.871315Z","caller":"traceutil/trace.go:171","msg":"trace[1312657671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14522; }","duration":"104.81047ms","start":"2026-08-28T04:36:22.766459Z","end":"2026-08-28T04:36:22.871269Z","steps":["trace[1312657671] 'agreement among raft nodes before linearized reading'  (duration: 104.606285ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:36:22.871752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.413445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-28T04:36:22.871827Z","caller":"traceutil/trace.go:171","msg":"trace[1589383719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14522; }","duration":"133.553959ms","start":"2026-08-28T04:36:22.738256Z","end":"2026-08-28T04:36:22.87181Z","steps":["trace[1589383719] 'agreement among raft nodes before linearized reading'  (duration: 132.740368ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:36:22.991721Z","caller":"traceutil/trace.go:171","msg":"trace[1924887337] transaction","detail":"{read_only:false; response_revision:14523; number_of_response:1; }","duration":"118.279216ms","start":"2026-08-28T04:36:22.873409Z","end":"2026-08-28T04:36:22.991688Z","steps":["trace[1924887337] 'process raft request'  (duration: 64.6668ms)","trace[1924887337] 'compare'  (duration: 53.444442ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:36:22.994025Z","caller":"traceutil/trace.go:171","msg":"trace[462573548] transaction","detail":"{read_only:false; response_revision:14524; number_of_response:1; }","duration":"118.991736ms","start":"2026-08-28T04:36:22.87501Z","end":"2026-08-28T04:36:22.994001Z","steps":["trace[462573548] 'process raft request'  (duration: 118.811811ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:36:22.994196Z","caller":"traceutil/trace.go:171","msg":"trace[378975378] transaction","detail":"{read_only:false; response_revision:14525; number_of_response:1; }","duration":"119.092768ms","start":"2026-08-28T04:36:22.875076Z","end":"2026-08-28T04:36:22.994169Z","steps":["trace[378975378] 'process raft request'  (duration: 118.884803ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:37:21.798026Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12826}
{"level":"info","ts":"2026-08-28T04:37:21.884499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12826,"took":"83.805042ms","hash":2810801939,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":31260672,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-28T04:37:21.884647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2810801939,"revision":12826,"compact-revision":10544}
{"level":"info","ts":"2026-08-28T04:38:09.584323Z","caller":"traceutil/trace.go:171","msg":"trace[613767320] transaction","detail":"{read_only:false; response_revision:15645; number_of_response:1; }","duration":"113.104923ms","start":"2026-08-28T04:38:09.471186Z","end":"2026-08-28T04:38:09.584291Z","steps":["trace[613767320] 'process raft request'  (duration: 112.829576ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:42:21.80406Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15359}
{"level":"info","ts":"2026-08-28T04:42:21.909287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15359,"took":"102.364938ms","hash":394515799,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":31576064,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-28T04:42:21.909352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":394515799,"revision":15359,"compact-revision":12826}
{"level":"info","ts":"2026-08-28T04:43:46.3869Z","caller":"traceutil/trace.go:171","msg":"trace[463244278] transaction","detail":"{read_only:false; response_revision:18180; number_of_response:1; }","duration":"126.570862ms","start":"2026-08-28T04:43:46.260293Z","end":"2026-08-28T04:43:46.386863Z","steps":["trace[463244278] 'process raft request'  (duration: 126.184643ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:43:46.504917Z","caller":"traceutil/trace.go:171","msg":"trace[979481859] transaction","detail":"{read_only:false; response_revision:18182; number_of_response:1; }","duration":"105.796079ms","start":"2026-08-28T04:43:46.399095Z","end":"2026-08-28T04:43:46.504891Z","steps":["trace[979481859] 'process raft request'  (duration: 105.653995ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:43:47.167473Z","caller":"traceutil/trace.go:171","msg":"trace[116672934] transaction","detail":"{read_only:false; response_revision:18183; number_of_response:1; }","duration":"168.849349ms","start":"2026-08-28T04:43:46.998574Z","end":"2026-08-28T04:43:47.167423Z","steps":["trace[116672934] 'process raft request'  (duration: 168.542581ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:43:47.385407Z","caller":"traceutil/trace.go:171","msg":"trace[1921393821] linearizableReadLoop","detail":"{readStateIndex:18803; appliedIndex:18802; }","duration":"179.300048ms","start":"2026-08-28T04:43:47.206075Z","end":"2026-08-28T04:43:47.385375Z","steps":["trace[1921393821] 'read index received'  (duration: 179.068112ms)","trace[1921393821] 'applied index is now lower than readState.Index'  (duration: 230.896µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:43:47.385883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.780429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7913"}
{"level":"warn","ts":"2026-08-28T04:43:47.385981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.11921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3227"}
{"level":"info","ts":"2026-08-28T04:43:47.386028Z","caller":"traceutil/trace.go:171","msg":"trace[450165536] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18184; }","duration":"168.177671ms","start":"2026-08-28T04:43:47.217836Z","end":"2026-08-28T04:43:47.386013Z","steps":["trace[450165536] 'agreement among raft nodes before linearized reading'  (duration: 168.012606ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:43:47.386077Z","caller":"traceutil/trace.go:171","msg":"trace[2058618071] transaction","detail":"{read_only:false; response_revision:18184; number_of_response:1; }","duration":"189.402068ms","start":"2026-08-28T04:43:47.196661Z","end":"2026-08-28T04:43:47.386063Z","steps":["trace[2058618071] 'process raft request'  (duration: 188.556616ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:43:47.386814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.459505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19625"}
{"level":"info","ts":"2026-08-28T04:43:47.386863Z","caller":"traceutil/trace.go:171","msg":"trace[1692802096] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18184; }","duration":"162.536918ms","start":"2026-08-28T04:43:47.224315Z","end":"2026-08-28T04:43:47.386852Z","steps":["trace[1692802096] 'agreement among raft nodes before linearized reading'  (duration: 162.437245ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:43:47.386017Z","caller":"traceutil/trace.go:171","msg":"trace[125234605] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:18184; }","duration":"179.962635ms","start":"2026-08-28T04:43:47.20603Z","end":"2026-08-28T04:43:47.385992Z","steps":["trace[125234605] 'agreement among raft nodes before linearized reading'  (duration: 179.633406ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:45:58.290507Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-28T04:45:58.297776Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-28T04:45:58.297895Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-28T04:47:21.811479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17530}
{"level":"info","ts":"2026-08-28T04:47:21.91141Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17530,"took":"96.504429ms","hash":2807798425,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":34758656,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-28T04:47:21.911508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2807798425,"revision":17530,"compact-revision":15359}
{"level":"info","ts":"2026-08-28T04:48:34.434548Z","caller":"traceutil/trace.go:171","msg":"trace[925759839] transaction","detail":"{read_only:false; response_revision:20472; number_of_response:1; }","duration":"107.724319ms","start":"2026-08-28T04:48:34.326796Z","end":"2026-08-28T04:48:34.434521Z","steps":["trace[925759839] 'process raft request'  (duration: 107.594416ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:34.790648Z","caller":"traceutil/trace.go:171","msg":"trace[668629187] transaction","detail":"{read_only:false; response_revision:20473; number_of_response:1; }","duration":"135.688726ms","start":"2026-08-28T04:48:34.654929Z","end":"2026-08-28T04:48:34.790618Z","steps":["trace[668629187] 'process raft request'  (duration: 135.492472ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:48:45.254648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.305559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.148\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-08-28T04:48:45.254741Z","caller":"traceutil/trace.go:171","msg":"trace[1934459327] range","detail":"{range_begin:/registry/masterleases/162.253.55.148; range_end:; response_count:1; response_revision:20527; }","duration":"109.451343ms","start":"2026-08-28T04:48:45.145268Z","end":"2026-08-28T04:48:45.254719Z","steps":["trace[1934459327] 'range keys from in-memory index tree'  (duration: 109.112594ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:50.635324Z","caller":"traceutil/trace.go:171","msg":"trace[118562109] transaction","detail":"{read_only:false; response_revision:20555; number_of_response:1; }","duration":"143.97525ms","start":"2026-08-28T04:48:50.491323Z","end":"2026-08-28T04:48:50.635298Z","steps":["trace[118562109] 'process raft request'  (duration: 143.805636ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:51.177054Z","caller":"traceutil/trace.go:171","msg":"trace[100329935] transaction","detail":"{read_only:false; response_revision:20556; number_of_response:1; }","duration":"230.897484ms","start":"2026-08-28T04:48:50.945947Z","end":"2026-08-28T04:48:51.176844Z","steps":["trace[100329935] 'process raft request'  (duration: 230.72384ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:51.388973Z","caller":"traceutil/trace.go:171","msg":"trace[1909401369] linearizableReadLoop","detail":"{readStateIndex:21255; appliedIndex:21253; }","duration":"428.820839ms","start":"2026-08-28T04:48:50.96013Z","end":"2026-08-28T04:48:51.388951Z","steps":["trace[1909401369] 'read index received'  (duration: 216.622307ms)","trace[1909401369] 'applied index is now lower than readState.Index'  (duration: 212.197342ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:48:51.389079Z","caller":"traceutil/trace.go:171","msg":"trace[580850323] transaction","detail":"{read_only:false; response_revision:20557; number_of_response:1; }","duration":"436.444915ms","start":"2026-08-28T04:48:50.952591Z","end":"2026-08-28T04:48:51.389036Z","steps":["trace[580850323] 'process raft request'  (duration: 406.750863ms)","trace[580850323] 'compare'  (duration: 29.394965ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-28T04:48:51.389201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.561854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-28T04:48:51.389237Z","caller":"traceutil/trace.go:171","msg":"trace[1786383482] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20557; }","duration":"363.611955ms","start":"2026-08-28T04:48:51.025614Z","end":"2026-08-28T04:48:51.389226Z","steps":["trace[1786383482] 'agreement among raft nodes before linearized reading'  (duration: 363.46135ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:48:51.389245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:48:50.952563Z","time spent":"436.59282ms","remote":"127.0.0.1:45442","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:20546 > 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-28T04:48:51.389266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:48:51.025545Z","time spent":"363.713907ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-28T04:48:51.389273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.119288ms","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-28T04:48:51.389364Z","caller":"traceutil/trace.go:171","msg":"trace[1546430308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20557; }","duration":"429.260191ms","start":"2026-08-28T04:48:50.96008Z","end":"2026-08-28T04:48:51.38934Z","steps":["trace[1546430308] 'agreement among raft nodes before linearized reading'  (duration: 428.943422ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:48:51.389413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:48:50.960057Z","time spent":"429.347394ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-28T04:48:51.38942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.112462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-28T04:48:51.389446Z","caller":"traceutil/trace.go:171","msg":"trace[362651513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20557; }","duration":"363.137582ms","start":"2026-08-28T04:48:51.0263Z","end":"2026-08-28T04:48:51.389438Z","steps":["trace[362651513] 'agreement among raft nodes before linearized reading'  (duration: 363.05908ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:48:51.389491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:48:51.026251Z","time spent":"363.233745ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-28T04:48:51.612827Z","caller":"traceutil/trace.go:171","msg":"trace[1215300745] transaction","detail":"{read_only:false; response_revision:20558; number_of_response:1; }","duration":"219.015478ms","start":"2026-08-28T04:48:51.393784Z","end":"2026-08-28T04:48:51.612799Z","steps":["trace[1215300745] 'process raft request'  (duration: 162.175267ms)","trace[1215300745] 'compare'  (duration: 56.39431ms)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:48:51.613725Z","caller":"traceutil/trace.go:171","msg":"trace[880716382] transaction","detail":"{read_only:false; response_revision:20559; number_of_response:1; }","duration":"219.665975ms","start":"2026-08-28T04:48:51.394038Z","end":"2026-08-28T04:48:51.613704Z","steps":["trace[880716382] 'process raft request'  (duration: 218.68763ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:51.613728Z","caller":"traceutil/trace.go:171","msg":"trace[1187345575] transaction","detail":"{read_only:false; response_revision:20561; number_of_response:1; }","duration":"218.509345ms","start":"2026-08-28T04:48:51.39519Z","end":"2026-08-28T04:48:51.6137Z","steps":["trace[1187345575] 'process raft request'  (duration: 218.150517ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:48:51.614005Z","caller":"traceutil/trace.go:171","msg":"trace[923489186] transaction","detail":"{read_only:false; response_revision:20560; number_of_response:1; }","duration":"219.843759ms","start":"2026-08-28T04:48:51.394106Z","end":"2026-08-28T04:48:51.61395Z","steps":["trace[923489186] 'process raft request'  (duration: 219.186652ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T04:52:21.819125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20044}
{"level":"info","ts":"2026-08-28T04:52:21.935217Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20044,"took":"113.278391ms","hash":769571053,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":30486528,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-28T04:52:21.935404Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":769571053,"revision":20044,"compact-revision":17530}
{"level":"info","ts":"2026-08-28T04:52:41.201763Z","caller":"traceutil/trace.go:171","msg":"trace[58326917] linearizableReadLoop","detail":"{readStateIndex:23761; appliedIndex:23760; }","duration":"346.439665ms","start":"2026-08-28T04:52:40.855295Z","end":"2026-08-28T04:52:41.201734Z","steps":["trace[58326917] 'read index received'  (duration: 346.25248ms)","trace[58326917] 'applied index is now lower than readState.Index'  (duration: 185.835µs)"],"step_count":2}
{"level":"info","ts":"2026-08-28T04:52:41.201891Z","caller":"traceutil/trace.go:171","msg":"trace[846610802] transaction","detail":"{read_only:false; response_revision:22988; number_of_response:1; }","duration":"350.349806ms","start":"2026-08-28T04:52:40.851528Z","end":"2026-08-28T04:52:41.201877Z","steps":["trace[846610802] 'process raft request'  (duration: 350.024027ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:52:41.202018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:52:40.85151Z","time spent":"350.419699ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:22943 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-28T04:52:41.202047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.733824ms","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-28T04:52:41.202125Z","caller":"traceutil/trace.go:171","msg":"trace[1768354349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22988; }","duration":"346.853806ms","start":"2026-08-28T04:52:40.855253Z","end":"2026-08-28T04:52:41.202106Z","steps":["trace[1768354349] 'agreement among raft nodes before linearized reading'  (duration: 346.661421ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:52:41.202166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:52:40.855233Z","time spent":"346.924508ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-28T04:52:41.20277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.07303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-28T04:52:41.202811Z","caller":"traceutil/trace.go:171","msg":"trace[571796492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22989; }","duration":"345.158192ms","start":"2026-08-28T04:52:40.857642Z","end":"2026-08-28T04:52:41.2028Z","steps":["trace[571796492] 'agreement among raft nodes before linearized reading'  (duration: 345.016578ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:52:41.202841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:52:40.857635Z","time spent":"345.199184ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-28T04:52:41.203058Z","caller":"traceutil/trace.go:171","msg":"trace[1170281161] transaction","detail":"{read_only:false; response_revision:22989; number_of_response:1; }","duration":"178.097088ms","start":"2026-08-28T04:52:41.024947Z","end":"2026-08-28T04:52:41.203044Z","steps":["trace[1170281161] 'process raft request'  (duration: 177.608805ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:52:41.203267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.887943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-28T04:52:41.203303Z","caller":"traceutil/trace.go:171","msg":"trace[924763850] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22989; }","duration":"340.940434ms","start":"2026-08-28T04:52:40.862351Z","end":"2026-08-28T04:52:41.203292Z","steps":["trace[924763850] 'agreement among raft nodes before linearized reading'  (duration: 340.851662ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T04:52:41.203351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:52:40.862342Z","time spent":"341.000266ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-28T04:57:21.826005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22261}
{"level":"info","ts":"2026-08-28T04:57:21.992199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22261,"took":"163.126433ms","hash":3984472213,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":41660416,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-28T04:57:21.992268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3984472213,"revision":22261,"compact-revision":20044}
{"level":"warn","ts":"2026-08-28T05:00:30.491378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.977108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:921"}
{"level":"info","ts":"2026-08-28T05:00:30.49149Z","caller":"traceutil/trace.go:171","msg":"trace[1928220078] range","detail":"{range_begin:/registry/services/endpoints/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:26869; }","duration":"105.128102ms","start":"2026-08-28T05:00:30.386342Z","end":"2026-08-28T05:00:30.49147Z","steps":["trace[1928220078] 'range keys from in-memory index tree'  (duration: 104.775693ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-28T05:00:30.491809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.928181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/rook-ceph/\" range_end:\"/registry/serviceaccounts/rook-ceph0\" limit:500 ","response":"range_response_count:13 size:8444"}
{"level":"info","ts":"2026-08-28T05:00:30.491838Z","caller":"traceutil/trace.go:171","msg":"trace[17280487] range","detail":"{range_begin:/registry/serviceaccounts/rook-ceph/; range_end:/registry/serviceaccounts/rook-ceph0; response_count:13; response_revision:26869; }","duration":"101.999982ms","start":"2026-08-28T05:00:30.389829Z","end":"2026-08-28T05:00:30.491829Z","steps":["trace[17280487] 'range keys from in-memory index tree'  (duration: 101.785736ms)"],"step_count":1}
{"level":"info","ts":"2026-08-28T05:02:21.832992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25393}
{"level":"info","ts":"2026-08-28T05:02:21.982877Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25393,"took":"145.527509ms","hash":2105137279,"current-db-size-bytes":57090048,"current-db-size":"57 MB","current-db-size-in-use-bytes":29667328,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-28T05:02:21.982969Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2105137279,"revision":25393,"compact-revision":22261}