{"level":"warn","ts":"2026-05-05T11:20:18.880351Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T11:20:18.880516Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.184:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.184:2380","--initial-cluster=instance=https://199.19.213.184:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.184:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.184: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-05-05T11:20:18.880592Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T11:20:18.880602Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.184:2380"]}
{"level":"info","ts":"2026-05-05T11:20:18.880626Z","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-05-05T11:20:18.881292Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"]}
{"level":"info","ts":"2026-05-05T11:20:18.881367Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.184:2380"],"listen-peer-urls":["https://199.19.213.184:2380"],"advertise-client-urls":["https://199.19.213.184:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.184: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-05-05T11:20:18.884804Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.223602ms"}
{"level":"info","ts":"2026-05-05T11:20:18.892233Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a98e0cfc7e94da4e","cluster-id":"6159be5634512a47"}
{"level":"info","ts":"2026-05-05T11:20:18.892322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T11:20:18.892344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became follower at term 0"}
{"level":"info","ts":"2026-05-05T11:20:18.892361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a98e0cfc7e94da4e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T11:20:18.892376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became follower at term 1"}
{"level":"info","ts":"2026-05-05T11:20:18.892462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=(12217717117697710670)"}
{"level":"warn","ts":"2026-05-05T11:20:18.899583Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T11:20:18.901774Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T11:20:18.904048Z","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-05-05T11:20:18.907569Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a98e0cfc7e94da4e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T11:20:18.907779Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a98e0cfc7e94da4e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T11:20:18.9079Z","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-05-05T11:20:18.908056Z","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-05-05T11:20:18.908076Z","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-05-05T11:20:18.909385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e switched to configuration voters=(12217717117697710670)"}
{"level":"info","ts":"2026-05-05T11:20:18.909742Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6159be5634512a47","local-member-id":"a98e0cfc7e94da4e","added-peer-id":"a98e0cfc7e94da4e","added-peer-peer-urls":["https://199.19.213.184:2380"]}
{"level":"info","ts":"2026-05-05T11:20:18.913339Z","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-05-05T11:20:18.913601Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a98e0cfc7e94da4e","initial-advertise-peer-urls":["https://199.19.213.184:2380"],"listen-peer-urls":["https://199.19.213.184:2380"],"advertise-client-urls":["https://199.19.213.184:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.184:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T11:20:18.913647Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T11:20:18.913844Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.184:2380"}
{"level":"info","ts":"2026-05-05T11:20:18.913888Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.184:2380"}
{"level":"info","ts":"2026-05-05T11:20:19.696775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T11:20:19.69695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T11:20:19.697042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e received MsgPreVoteResp from a98e0cfc7e94da4e at term 1"}
{"level":"info","ts":"2026-05-05T11:20:19.697109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became candidate at term 2"}
{"level":"info","ts":"2026-05-05T11:20:19.697166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e received MsgVoteResp from a98e0cfc7e94da4e at term 2"}
{"level":"info","ts":"2026-05-05T11:20:19.697229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a98e0cfc7e94da4e became leader at term 2"}
{"level":"info","ts":"2026-05-05T11:20:19.697361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a98e0cfc7e94da4e elected leader a98e0cfc7e94da4e at term 2"}
{"level":"info","ts":"2026-05-05T11:20:19.704944Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a98e0cfc7e94da4e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.184:2379]}","request-path":"/0/members/a98e0cfc7e94da4e/attributes","cluster-id":"6159be5634512a47","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T11:20:19.704995Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T11:20:19.704992Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:19.705393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T11:20:19.706196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6159be5634512a47","local-member-id":"a98e0cfc7e94da4e","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:19.706354Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:19.706393Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T11:20:19.706477Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T11:20:19.706511Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T11:20:19.708853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T11:20:19.709104Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.184:2379"}
{"level":"info","ts":"2026-05-05T11:20:50.681861Z","caller":"traceutil/trace.go:171","msg":"trace[1156196166] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"123.292496ms","start":"2026-05-05T11:20:50.558539Z","end":"2026-05-05T11:20:50.681831Z","steps":["trace[1156196166] 'process raft request'  (duration: 123.154082ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.692361Z","caller":"traceutil/trace.go:171","msg":"trace[1473961053] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"128.615529ms","start":"2026-05-05T11:20:50.563723Z","end":"2026-05-05T11:20:50.692339Z","steps":["trace[1473961053] 'process raft request'  (duration: 128.341241ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.69259Z","caller":"traceutil/trace.go:171","msg":"trace[1452242095] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"118.974503ms","start":"2026-05-05T11:20:50.573609Z","end":"2026-05-05T11:20:50.692584Z","steps":["trace[1452242095] 'process raft request'  (duration: 118.716026ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.6927Z","caller":"traceutil/trace.go:171","msg":"trace[30685704] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"128.622549ms","start":"2026-05-05T11:20:50.564069Z","end":"2026-05-05T11:20:50.692692Z","steps":["trace[30685704] 'process raft request'  (duration: 128.132915ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.692948Z","caller":"traceutil/trace.go:171","msg":"trace[1236595516] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"115.632167ms","start":"2026-05-05T11:20:50.57731Z","end":"2026-05-05T11:20:50.692943Z","steps":["trace[1236595516] 'process raft request'  (duration: 115.163574ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.693023Z","caller":"traceutil/trace.go:171","msg":"trace[1358714486] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"118.084147ms","start":"2026-05-05T11:20:50.574933Z","end":"2026-05-05T11:20:50.693017Z","steps":["trace[1358714486] 'process raft request'  (duration: 117.439739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.693007Z","caller":"traceutil/trace.go:171","msg":"trace[855665611] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"115.535864ms","start":"2026-05-05T11:20:50.577455Z","end":"2026-05-05T11:20:50.69299Z","steps":["trace[855665611] 'process raft request'  (duration: 115.061051ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.693086Z","caller":"traceutil/trace.go:171","msg":"trace[2009220350] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"117.938123ms","start":"2026-05-05T11:20:50.575143Z","end":"2026-05-05T11:20:50.693081Z","steps":["trace[2009220350] 'process raft request'  (duration: 117.288725ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:50.693193Z","caller":"traceutil/trace.go:171","msg":"trace[2014307566] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"105.670272ms","start":"2026-05-05T11:20:50.587452Z","end":"2026-05-05T11:20:50.693122Z","steps":["trace[2014307566] 'process raft request'  (duration: 105.107176ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:57.052232Z","caller":"traceutil/trace.go:171","msg":"trace[1604638201] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"156.955699ms","start":"2026-05-05T11:20:56.895237Z","end":"2026-05-05T11:20:57.052193Z","steps":["trace[1604638201] 'process raft request'  (duration: 156.402954ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:57.211126Z","caller":"traceutil/trace.go:171","msg":"trace[2025333150] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"100.32771ms","start":"2026-05-05T11:20:57.110758Z","end":"2026-05-05T11:20:57.211085Z","steps":["trace[2025333150] 'process raft request'  (duration: 100.107453ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:20:58.022171Z","caller":"traceutil/trace.go:171","msg":"trace[883315236] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"344.072631ms","start":"2026-05-05T11:20:57.678063Z","end":"2026-05-05T11:20:58.022136Z","steps":["trace[883315236] 'read index received'  (duration: 342.855116ms)","trace[883315236] 'applied index is now lower than readState.Index'  (duration: 1.216005ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:20:58.022226Z","caller":"traceutil/trace.go:171","msg":"trace[711872152] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"392.230527ms","start":"2026-05-05T11:20:57.629953Z","end":"2026-05-05T11:20:58.022183Z","steps":["trace[711872152] 'process raft request'  (duration: 391.316891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:20:58.022496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.392179ms","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-05-05T11:20:58.022597Z","caller":"traceutil/trace.go:171","msg":"trace[708439129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"344.534083ms","start":"2026-05-05T11:20:57.678046Z","end":"2026-05-05T11:20:58.02258Z","steps":["trace[708439129] 'agreement among raft nodes before linearized reading'  (duration: 344.257805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:20:58.022639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:57.677962Z","time spent":"344.665667ms","remote":"127.0.0.1:52992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-05T11:20:58.022917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:20:57.629911Z","time spent":"392.394823ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:621 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-05T11:20:58.043948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.149438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-05T11:20:58.044043Z","caller":"traceutil/trace.go:171","msg":"trace[92667611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"283.384045ms","start":"2026-05-05T11:20:57.760637Z","end":"2026-05-05T11:20:58.044021Z","steps":["trace[92667611] 'agreement among raft nodes before linearized reading'  (duration: 283.185629ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:21:14.303835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.419766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-05T11:21:14.303972Z","caller":"traceutil/trace.go:171","msg":"trace[576272905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"183.5912ms","start":"2026-05-05T11:21:14.12035Z","end":"2026-05-05T11:21:14.303941Z","steps":["trace[576272905] 'range keys from in-memory index tree'  (duration: 183.22546ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:21:14.304198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.24974ms","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-05-05T11:21:14.304271Z","caller":"traceutil/trace.go:171","msg":"trace[1771147853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:787; }","duration":"184.369874ms","start":"2026-05-05T11:21:14.119888Z","end":"2026-05-05T11:21:14.304258Z","steps":["trace[1771147853] 'range keys from in-memory index tree'  (duration: 184.070224ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:22:34.875181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.961297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:22:34.875371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.117082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-da9196df-2dad-414e-815d-eb18049b2411\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-05T11:22:34.875439Z","caller":"traceutil/trace.go:171","msg":"trace[1757317689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"302.284527ms","start":"2026-05-05T11:22:34.573129Z","end":"2026-05-05T11:22:34.875413Z","steps":["trace[1757317689] 'range keys from in-memory index tree'  (duration: 301.873805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:22:34.875563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:22:34.57311Z","time spent":"302.430352ms","remote":"127.0.0.1:52692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-05T11:22:34.875728Z","caller":"traceutil/trace.go:171","msg":"trace[1556158071] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-da9196df-2dad-414e-815d-eb18049b2411; range_end:; response_count:1; response_revision:1882; }","duration":"328.336947ms","start":"2026-05-05T11:22:34.547143Z","end":"2026-05-05T11:22:34.87548Z","steps":["trace[1556158071] 'range keys from in-memory index tree'  (duration: 327.840843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:22:34.875838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:22:34.547119Z","time spent":"328.704259ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-da9196df-2dad-414e-815d-eb18049b2411\" "}
{"level":"warn","ts":"2026-05-05T11:22:35.258465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.258076ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730684236359850752 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1863 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:22:35.258676Z","caller":"traceutil/trace.go:171","msg":"trace[1984274228] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"184.953724ms","start":"2026-05-05T11:22:35.073684Z","end":"2026-05-05T11:22:35.258637Z","steps":["trace[1984274228] 'process raft request'  (duration: 70.162103ms)","trace[1984274228] 'compare'  (duration: 114.102192ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:22:48.028574Z","caller":"traceutil/trace.go:171","msg":"trace[2048500773] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"135.017456ms","start":"2026-05-05T11:22:47.893531Z","end":"2026-05-05T11:22:48.028549Z","steps":["trace[2048500773] 'process raft request'  (duration: 134.823381ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:22:48.028591Z","caller":"traceutil/trace.go:171","msg":"trace[354908825] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"135.986993ms","start":"2026-05-05T11:22:47.892562Z","end":"2026-05-05T11:22:48.028549Z","steps":["trace[354908825] 'process raft request'  (duration: 124.427194ms)","trace[354908825] 'compare'  (duration: 11.262801ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:23:19.385549Z","caller":"traceutil/trace.go:171","msg":"trace[1565643982] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"200.136474ms","start":"2026-05-05T11:23:19.185377Z","end":"2026-05-05T11:23:19.385513Z","steps":["trace[1565643982] 'process raft request'  (duration: 199.99104ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:23:19.415253Z","caller":"traceutil/trace.go:171","msg":"trace[1725321054] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2250; }","duration":"226.915495ms","start":"2026-05-05T11:23:19.188308Z","end":"2026-05-05T11:23:19.415223Z","steps":["trace[1725321054] 'read index received'  (duration: 197.134238ms)","trace[1725321054] 'applied index is now lower than readState.Index'  (duration: 29.779737ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:23:19.415406Z","caller":"traceutil/trace.go:171","msg":"trace[613395048] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"228.533092ms","start":"2026-05-05T11:23:19.186861Z","end":"2026-05-05T11:23:19.415394Z","steps":["trace[613395048] 'process raft request'  (duration: 228.206853ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:19.41555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.488328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:23:19.415619Z","caller":"traceutil/trace.go:171","msg":"trace[1814956378] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2173; }","duration":"185.621422ms","start":"2026-05-05T11:23:19.229982Z","end":"2026-05-05T11:23:19.415603Z","steps":["trace[1814956378] 'agreement among raft nodes before linearized reading'  (duration: 185.499859ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:19.415928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.622316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-05T11:23:19.415973Z","caller":"traceutil/trace.go:171","msg":"trace[969027175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2173; }","duration":"227.691757ms","start":"2026-05-05T11:23:19.188272Z","end":"2026-05-05T11:23:19.415963Z","steps":["trace[969027175] 'agreement among raft nodes before linearized reading'  (duration: 227.580664ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:19.415998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.961297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-05T11:23:19.416129Z","caller":"traceutil/trace.go:171","msg":"trace[641352745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2173; }","duration":"104.128342ms","start":"2026-05-05T11:23:19.311972Z","end":"2026-05-05T11:23:19.4161Z","steps":["trace[641352745] 'agreement among raft nodes before linearized reading'  (duration: 103.789142ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:23:25.690326Z","caller":"traceutil/trace.go:171","msg":"trace[1074477270] linearizableReadLoop","detail":"{readStateIndex:2284; appliedIndex:2283; }","duration":"251.269209ms","start":"2026-05-05T11:23:25.439033Z","end":"2026-05-05T11:23:25.690302Z","steps":["trace[1074477270] 'read index received'  (duration: 251.136605ms)","trace[1074477270] 'applied index is now lower than readState.Index'  (duration: 131.284µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:23:25.690405Z","caller":"traceutil/trace.go:171","msg":"trace[114547496] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"258.627899ms","start":"2026-05-05T11:23:25.431732Z","end":"2026-05-05T11:23:25.690359Z","steps":["trace[114547496] 'process raft request'  (duration: 258.399893ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:25.690563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.865542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-05T11:23:25.690605Z","caller":"traceutil/trace.go:171","msg":"trace[1277310307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2204; }","duration":"228.981845ms","start":"2026-05-05T11:23:25.46161Z","end":"2026-05-05T11:23:25.690592Z","steps":["trace[1277310307] 'agreement among raft nodes before linearized reading'  (duration: 228.834671ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:25.690598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.540356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-05T11:23:25.690675Z","caller":"traceutil/trace.go:171","msg":"trace[951586006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2204; }","duration":"251.668951ms","start":"2026-05-05T11:23:25.438987Z","end":"2026-05-05T11:23:25.690656Z","steps":["trace[951586006] 'agreement among raft nodes before linearized reading'  (duration: 251.443634ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:25.690812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.576972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-05T11:23:25.690802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.743793ms","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-05-05T11:23:25.690857Z","caller":"traceutil/trace.go:171","msg":"trace[1337204685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2204; }","duration":"216.693056ms","start":"2026-05-05T11:23:25.47415Z","end":"2026-05-05T11:23:25.690843Z","steps":["trace[1337204685] 'agreement among raft nodes before linearized reading'  (duration: 216.510581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:23:25.690881Z","caller":"traceutil/trace.go:171","msg":"trace[1168626046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2204; }","duration":"109.898286ms","start":"2026-05-05T11:23:25.580967Z","end":"2026-05-05T11:23:25.690865Z","steps":["trace[1168626046] 'agreement among raft nodes before linearized reading'  (duration: 109.634749ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:23:25.690915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.571144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-05T11:23:25.691034Z","caller":"traceutil/trace.go:171","msg":"trace[609602337] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2204; }","duration":"227.734649ms","start":"2026-05-05T11:23:25.46326Z","end":"2026-05-05T11:23:25.690994Z","steps":["trace[609602337] 'agreement among raft nodes before linearized reading'  (duration: 227.449411ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:24:54.185821Z","caller":"traceutil/trace.go:171","msg":"trace[709344579] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"126.502766ms","start":"2026-05-05T11:24:54.059281Z","end":"2026-05-05T11:24:54.185784Z","steps":["trace[709344579] 'process raft request'  (duration: 126.27302ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:24:54.31774Z","caller":"traceutil/trace.go:171","msg":"trace[797388574] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"257.981454ms","start":"2026-05-05T11:24:54.059716Z","end":"2026-05-05T11:24:54.317698Z","steps":["trace[797388574] 'process raft request'  (duration: 226.448062ms)","trace[797388574] 'compare'  (duration: 31.317755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:24:54.674208Z","caller":"traceutil/trace.go:171","msg":"trace[407989792] linearizableReadLoop","detail":"{readStateIndex:2989; appliedIndex:2988; }","duration":"102.981072ms","start":"2026-05-05T11:24:54.571197Z","end":"2026-05-05T11:24:54.674178Z","steps":["trace[407989792] 'read index received'  (duration: 102.607611ms)","trace[407989792] 'applied index is now lower than readState.Index'  (duration: 372.251µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:24:54.674312Z","caller":"traceutil/trace.go:171","msg":"trace[829880683] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"144.352721ms","start":"2026-05-05T11:24:54.529908Z","end":"2026-05-05T11:24:54.674261Z","steps":["trace[829880683] 'process raft request'  (duration: 144.015432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:24:54.674355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.136776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:24:54.674483Z","caller":"traceutil/trace.go:171","msg":"trace[578599304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2882; }","duration":"103.341652ms","start":"2026-05-05T11:24:54.571129Z","end":"2026-05-05T11:24:54.674471Z","steps":["trace[578599304] 'agreement among raft nodes before linearized reading'  (duration: 103.161807ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:27:06.190747Z","caller":"traceutil/trace.go:171","msg":"trace[124631390] transaction","detail":"{read_only:false; response_revision:3699; number_of_response:1; }","duration":"112.115591ms","start":"2026-05-05T11:27:06.078586Z","end":"2026-05-05T11:27:06.190702Z","steps":["trace[124631390] 'process raft request'  (duration: 51.603427ms)","trace[124631390] 'compare'  (duration: 60.315888ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:27:41.185862Z","caller":"traceutil/trace.go:171","msg":"trace[1449029090] linearizableReadLoop","detail":"{readStateIndex:4101; appliedIndex:4100; }","duration":"245.773553ms","start":"2026-05-05T11:27:40.94005Z","end":"2026-05-05T11:27:41.185824Z","steps":["trace[1449029090] 'read index received'  (duration: 245.546467ms)","trace[1449029090] 'applied index is now lower than readState.Index'  (duration: 225.636µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:27:41.18606Z","caller":"traceutil/trace.go:171","msg":"trace[1135029789] transaction","detail":"{read_only:false; response_revision:3955; number_of_response:1; }","duration":"250.184598ms","start":"2026-05-05T11:27:40.935858Z","end":"2026-05-05T11:27:41.186042Z","steps":["trace[1135029789] 'process raft request'  (duration: 249.727885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:27:41.186304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.279815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:27:41.186426Z","caller":"traceutil/trace.go:171","msg":"trace[1665508318] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:3955; }","duration":"183.46633ms","start":"2026-05-05T11:27:41.00293Z","end":"2026-05-05T11:27:41.186396Z","steps":["trace[1665508318] 'agreement among raft nodes before linearized reading'  (duration: 183.245834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:27:41.186498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.428661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-p6mf6\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-05-05T11:27:41.186612Z","caller":"traceutil/trace.go:171","msg":"trace[550345178] range","detail":"{range_begin:/registry/pods/openstack/keepalived-p6mf6; range_end:; response_count:1; response_revision:3955; }","duration":"246.595646ms","start":"2026-05-05T11:27:40.939978Z","end":"2026-05-05T11:27:41.186574Z","steps":["trace[550345178] 'agreement among raft nodes before linearized reading'  (duration: 246.335499ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:11.947122Z","caller":"traceutil/trace.go:171","msg":"trace[295112643] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"162.146134ms","start":"2026-05-05T11:29:11.784952Z","end":"2026-05-05T11:29:11.947098Z","steps":["trace[295112643] 'process raft request'  (duration: 151.15963ms)","trace[295112643] 'compare'  (duration: 10.156321ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:29:12.174537Z","caller":"traceutil/trace.go:171","msg":"trace[592139722] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"143.532004ms","start":"2026-05-05T11:29:12.030946Z","end":"2026-05-05T11:29:12.174478Z","steps":["trace[592139722] 'process raft request'  (duration: 49.606749ms)","trace[592139722] 'compare'  (duration: 93.675237ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:29:32.096538Z","caller":"traceutil/trace.go:171","msg":"trace[2067097206] linearizableReadLoop","detail":"{readStateIndex:5776; appliedIndex:5774; }","duration":"159.262149ms","start":"2026-05-05T11:29:31.937243Z","end":"2026-05-05T11:29:32.096505Z","steps":["trace[2067097206] 'read index received'  (duration: 29.555365ms)","trace[2067097206] 'applied index is now lower than readState.Index'  (duration: 129.705894ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:29:32.096577Z","caller":"traceutil/trace.go:171","msg":"trace[1664923401] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"159.561167ms","start":"2026-05-05T11:29:31.936967Z","end":"2026-05-05T11:29:32.096528Z","steps":["trace[1664923401] 'process raft request'  (duration: 159.487185ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:29:32.096553Z","caller":"traceutil/trace.go:171","msg":"trace[956939489] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"159.852015ms","start":"2026-05-05T11:29:31.936652Z","end":"2026-05-05T11:29:32.096504Z","steps":["trace[956939489] 'process raft request'  (duration: 103.919498ms)","trace[956939489] 'compare'  (duration: 55.709781ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:29:32.096991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.696861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80208"}
{"level":"info","ts":"2026-05-05T11:29:32.097049Z","caller":"traceutil/trace.go:171","msg":"trace[182655788] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5570; }","duration":"159.821204ms","start":"2026-05-05T11:29:31.937216Z","end":"2026-05-05T11:29:32.097037Z","steps":["trace[182655788] 'agreement among raft nodes before linearized reading'  (duration: 159.423113ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:29:32.37685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.468933ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730684236359859495 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5499 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:29:32.376981Z","caller":"traceutil/trace.go:171","msg":"trace[708795457] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"232.895332ms","start":"2026-05-05T11:29:32.144061Z","end":"2026-05-05T11:29:32.376956Z","steps":["trace[708795457] 'process raft request'  (duration: 85.205484ms)","trace[708795457] 'compare'  (duration: 147.114592ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:30:19.744446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3019}
{"level":"info","ts":"2026-05-05T11:30:19.834776Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3019,"took":"88.5775ms","hash":2299378367,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":31129600,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-05T11:30:19.834891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2299378367,"revision":3019,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T11:35:19.752588Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6037}
{"level":"info","ts":"2026-05-05T11:35:19.849644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6037,"took":"94.147654ms","hash":3394850317,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21581824,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-05T11:35:19.849735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3394850317,"revision":6037,"compact-revision":3019}
{"level":"info","ts":"2026-05-05T11:35:45.404944Z","caller":"traceutil/trace.go:171","msg":"trace[1190559008] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"115.820708ms","start":"2026-05-05T11:35:45.289089Z","end":"2026-05-05T11:35:45.40491Z","steps":["trace[1190559008] 'process raft request'  (duration: 115.627813ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:45.751952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.237434ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730684236359866696 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8294 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:35:45.752087Z","caller":"traceutil/trace.go:171","msg":"trace[650241603] linearizableReadLoop","detail":"{readStateIndex:8601; appliedIndex:8600; }","duration":"276.547442ms","start":"2026-05-05T11:35:45.475522Z","end":"2026-05-05T11:35:45.752069Z","steps":["trace[650241603] 'read index received'  (duration: 43.00406ms)","trace[650241603] 'applied index is now lower than readState.Index'  (duration: 233.542082ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:35:45.752195Z","caller":"traceutil/trace.go:171","msg":"trace[1548311268] transaction","detail":"{read_only:false; response_revision:8303; number_of_response:1; }","duration":"368.615607ms","start":"2026-05-05T11:35:45.383559Z","end":"2026-05-05T11:35:45.752175Z","steps":["trace[1548311268] 'process raft request'  (duration: 135.040294ms)","trace[1548311268] 'compare'  (duration: 233.10785ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:35:45.752267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:35:45.383527Z","time spent":"368.70614ms","remote":"127.0.0.1:52992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8294 > 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-05-05T11:35:45.752324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.983067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:35:45.752393Z","caller":"traceutil/trace.go:171","msg":"trace[2044130411] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8303; }","duration":"195.10401ms","start":"2026-05-05T11:35:45.557274Z","end":"2026-05-05T11:35:45.752378Z","steps":["trace[2044130411] 'agreement among raft nodes before linearized reading'  (duration: 194.980317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:45.752449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.37879ms","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-05-05T11:35:45.752588Z","caller":"traceutil/trace.go:171","msg":"trace[1381303148] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:8303; }","duration":"181.573645ms","start":"2026-05-05T11:35:45.570983Z","end":"2026-05-05T11:35:45.752557Z","steps":["trace[1381303148] 'agreement among raft nodes before linearized reading'  (duration: 181.312058ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:45.753145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.136071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T11:35:45.753327Z","caller":"traceutil/trace.go:171","msg":"trace[729786353] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8303; }","duration":"277.783579ms","start":"2026-05-05T11:35:45.475511Z","end":"2026-05-05T11:35:45.753294Z","steps":["trace[729786353] 'agreement among raft nodes before linearized reading'  (duration: 277.020476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:35:46.421192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.444773ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15730684236359866704 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8296 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T11:35:46.42146Z","caller":"traceutil/trace.go:171","msg":"trace[789231212] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"164.729299ms","start":"2026-05-05T11:35:46.256672Z","end":"2026-05-05T11:35:46.421401Z","steps":["trace[789231212] 'process raft request'  (duration: 32.925736ms)","trace[789231212] 'compare'  (duration: 130.960939ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:35:46.421584Z","caller":"traceutil/trace.go:171","msg":"trace[1346337440] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"149.923517ms","start":"2026-05-05T11:35:46.271632Z","end":"2026-05-05T11:35:46.421556Z","steps":["trace[1346337440] 'process raft request'  (duration: 149.747832ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:35:46.421543Z","caller":"traceutil/trace.go:171","msg":"trace[2126536444] linearizableReadLoop","detail":"{readStateIndex:8603; appliedIndex:8602; }","duration":"157.243975ms","start":"2026-05-05T11:35:46.264232Z","end":"2026-05-05T11:35:46.421475Z","steps":["trace[2126536444] 'read index received'  (duration: 25.458572ms)","trace[2126536444] 'applied index is now lower than readState.Index'  (duration: 131.779853ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:35:46.421836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.588855ms","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-05-05T11:35:46.421933Z","caller":"traceutil/trace.go:171","msg":"trace[1430665025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8306; }","duration":"157.752099ms","start":"2026-05-05T11:35:46.264161Z","end":"2026-05-05T11:35:46.421913Z","steps":["trace[1430665025] 'agreement among raft nodes before linearized reading'  (duration: 157.43027ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:35:47.526136Z","caller":"traceutil/trace.go:171","msg":"trace[659052995] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"114.255945ms","start":"2026-05-05T11:35:47.411806Z","end":"2026-05-05T11:35:47.526062Z","steps":["trace[659052995] 'process raft request'  (duration: 114.050038ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:35:55.242233Z","caller":"traceutil/trace.go:171","msg":"trace[924264540] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"234.26937ms","start":"2026-05-05T11:35:55.007929Z","end":"2026-05-05T11:35:55.242198Z","steps":["trace[924264540] 'process raft request'  (duration: 234.012413ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:06.681538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.416008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-05T11:36:06.681668Z","caller":"traceutil/trace.go:171","msg":"trace[1911883520] linearizableReadLoop","detail":"{readStateIndex:8844; appliedIndex:8843; }","duration":"169.31151ms","start":"2026-05-05T11:36:06.512321Z","end":"2026-05-05T11:36:06.681632Z","steps":["trace[1911883520] 'read index received'  (duration: 154.749786ms)","trace[1911883520] 'applied index is now lower than readState.Index'  (duration: 14.560404ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:06.681744Z","caller":"traceutil/trace.go:171","msg":"trace[888028824] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8540; }","duration":"198.666335ms","start":"2026-05-05T11:36:06.483049Z","end":"2026-05-05T11:36:06.681715Z","steps":["trace[888028824] 'range keys from in-memory index tree'  (duration: 198.233623ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:06.681757Z","caller":"traceutil/trace.go:171","msg":"trace[1583301093] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"176.537496ms","start":"2026-05-05T11:36:06.505166Z","end":"2026-05-05T11:36:06.681704Z","steps":["trace[1583301093] 'process raft request'  (duration: 161.808387ms)","trace[1583301093] 'compare'  (duration: 14.470372ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:36:06.681913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.784004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:36:06.682004Z","caller":"traceutil/trace.go:171","msg":"trace[1500828183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8541; }","duration":"110.910698ms","start":"2026-05-05T11:36:06.571075Z","end":"2026-05-05T11:36:06.681986Z","steps":["trace[1500828183] 'agreement among raft nodes before linearized reading'  (duration: 110.781034ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:06.682498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.133114ms","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-05-05T11:36:06.682562Z","caller":"traceutil/trace.go:171","msg":"trace[1653028612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8541; }","duration":"170.271309ms","start":"2026-05-05T11:36:06.512274Z","end":"2026-05-05T11:36:06.682545Z","steps":["trace[1653028612] 'agreement among raft nodes before linearized reading'  (duration: 169.526077ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:08.337178Z","caller":"traceutil/trace.go:171","msg":"trace[253669742] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"115.877639ms","start":"2026-05-05T11:36:08.221269Z","end":"2026-05-05T11:36:08.337146Z","steps":["trace[253669742] 'process raft request'  (duration: 115.470758ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:08.745221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.088517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:36:08.745347Z","caller":"traceutil/trace.go:171","msg":"trace[793931580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8552; }","duration":"174.296602ms","start":"2026-05-05T11:36:08.571027Z","end":"2026-05-05T11:36:08.745323Z","steps":["trace[793931580] 'range keys from in-memory index tree'  (duration: 173.968933ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:09.098205Z","caller":"traceutil/trace.go:171","msg":"trace[1465896044] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"149.526067ms","start":"2026-05-05T11:36:08.948626Z","end":"2026-05-05T11:36:09.098152Z","steps":["trace[1465896044] 'process raft request'  (duration: 91.957949ms)","trace[1465896044] 'compare'  (duration: 57.187897ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:41.074444Z","caller":"traceutil/trace.go:171","msg":"trace[1235745335] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"127.975734ms","start":"2026-05-05T11:36:40.946429Z","end":"2026-05-05T11:36:41.074405Z","steps":["trace[1235745335] 'process raft request'  (duration: 109.57633ms)","trace[1235745335] 'compare'  (duration: 18.064934ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:50.808894Z","caller":"traceutil/trace.go:171","msg":"trace[1132415919] transaction","detail":"{read_only:false; response_revision:8872; number_of_response:1; }","duration":"113.093009ms","start":"2026-05-05T11:36:50.695779Z","end":"2026-05-05T11:36:50.808872Z","steps":["trace[1132415919] 'process raft request'  (duration: 112.877523ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:50.855541Z","caller":"traceutil/trace.go:171","msg":"trace[350735531] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9189; }","duration":"139.928454ms","start":"2026-05-05T11:36:50.715579Z","end":"2026-05-05T11:36:50.855507Z","steps":["trace[350735531] 'read index received'  (duration: 93.268056ms)","trace[350735531] 'applied index is now lower than readState.Index'  (duration: 46.659068ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:50.855643Z","caller":"traceutil/trace.go:171","msg":"trace[1176747926] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"153.8452ms","start":"2026-05-05T11:36:50.701767Z","end":"2026-05-05T11:36:50.855612Z","steps":["trace[1176747926] 'process raft request'  (duration: 153.592443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:50.855822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.219502ms","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-05-05T11:36:50.855889Z","caller":"traceutil/trace.go:171","msg":"trace[552436709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8873; }","duration":"140.332755ms","start":"2026-05-05T11:36:50.715533Z","end":"2026-05-05T11:36:50.855865Z","steps":["trace[552436709] 'agreement among raft nodes before linearized reading'  (duration: 140.110359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:51.435579Z","caller":"traceutil/trace.go:171","msg":"trace[1363588768] transaction","detail":"{read_only:false; response_revision:8880; number_of_response:1; }","duration":"176.588908ms","start":"2026-05-05T11:36:51.258939Z","end":"2026-05-05T11:36:51.435528Z","steps":["trace[1363588768] 'process raft request'  (duration: 176.208007ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:36:51.866932Z","caller":"traceutil/trace.go:171","msg":"trace[603037002] linearizableReadLoop","detail":"{readStateIndex:9201; appliedIndex:9200; }","duration":"287.171926ms","start":"2026-05-05T11:36:51.57973Z","end":"2026-05-05T11:36:51.866901Z","steps":["trace[603037002] 'read index received'  (duration: 286.97422ms)","trace[603037002] 'applied index is now lower than readState.Index'  (duration: 196.786µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:36:51.867019Z","caller":"traceutil/trace.go:171","msg":"trace[1422790713] transaction","detail":"{read_only:false; response_revision:8883; number_of_response:1; }","duration":"288.490483ms","start":"2026-05-05T11:36:51.578506Z","end":"2026-05-05T11:36:51.866997Z","steps":["trace[1422790713] 'process raft request'  (duration: 288.135263ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:36:51.867426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.658279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4726"}
{"level":"info","ts":"2026-05-05T11:36:51.867555Z","caller":"traceutil/trace.go:171","msg":"trace[1698116617] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:8883; }","duration":"287.824524ms","start":"2026-05-05T11:36:51.5797Z","end":"2026-05-05T11:36:51.867524Z","steps":["trace[1698116617] 'agreement among raft nodes before linearized reading'  (duration: 287.32856ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:37:09.858572Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000249f.wal"}
{"level":"info","ts":"2026-05-05T11:37:57.668419Z","caller":"traceutil/trace.go:171","msg":"trace[836647863] transaction","detail":"{read_only:false; response_revision:9568; number_of_response:1; }","duration":"100.592781ms","start":"2026-05-05T11:37:57.567782Z","end":"2026-05-05T11:37:57.668375Z","steps":["trace[836647863] 'process raft request'  (duration: 100.356634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:38:11.44311Z","caller":"traceutil/trace.go:171","msg":"trace[1777183027] transaction","detail":"{read_only:false; response_revision:9646; number_of_response:1; }","duration":"102.983911ms","start":"2026-05-05T11:38:11.340085Z","end":"2026-05-05T11:38:11.443068Z","steps":["trace[1777183027] 'process raft request'  (duration: 96.383512ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:38:13.563261Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a98e0cfc7e94da4e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T11:38:13.570665Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-05T11:38:13.570812Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-05T11:40:19.759366Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8118}
{"level":"info","ts":"2026-05-05T11:40:19.825262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8118,"took":"63.078542ms","hash":3885133406,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":28106752,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-05T11:40:19.825346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3885133406,"revision":8118,"compact-revision":6037}
{"level":"info","ts":"2026-05-05T11:43:47.75679Z","caller":"traceutil/trace.go:171","msg":"trace[1527060211] transaction","detail":"{read_only:false; response_revision:12068; number_of_response:1; }","duration":"143.838883ms","start":"2026-05-05T11:43:47.612886Z","end":"2026-05-05T11:43:47.756725Z","steps":["trace[1527060211] 'process raft request'  (duration: 128.997886ms)","trace[1527060211] 'compare'  (duration: 14.511358ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:43:47.757143Z","caller":"traceutil/trace.go:171","msg":"trace[1491470342] transaction","detail":"{read_only:false; response_revision:12069; number_of_response:1; }","duration":"139.277363ms","start":"2026-05-05T11:43:47.61785Z","end":"2026-05-05T11:43:47.757127Z","steps":["trace[1491470342] 'process raft request'  (duration: 138.788158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:43:47.757238Z","caller":"traceutil/trace.go:171","msg":"trace[390431174] linearizableReadLoop","detail":"{readStateIndex:12488; appliedIndex:12486; }","duration":"112.764931ms","start":"2026-05-05T11:43:47.64442Z","end":"2026-05-05T11:43:47.757185Z","steps":["trace[390431174] 'read index received'  (duration: 97.488641ms)","trace[390431174] 'applied index is now lower than readState.Index'  (duration: 15.27109ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T11:43:47.757469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.972637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:43:47.757612Z","caller":"traceutil/trace.go:171","msg":"trace[1386514245] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12070; }","duration":"113.250175ms","start":"2026-05-05T11:43:47.644328Z","end":"2026-05-05T11:43:47.757578Z","steps":["trace[1386514245] 'agreement among raft nodes before linearized reading'  (duration: 113.016729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:43:47.757694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.873864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:43:47.757827Z","caller":"traceutil/trace.go:171","msg":"trace[880760250] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12070; }","duration":"113.07676ms","start":"2026-05-05T11:43:47.644723Z","end":"2026-05-05T11:43:47.7578Z","steps":["trace[880760250] 'agreement among raft nodes before linearized reading'  (duration: 112.897105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:43:47.757829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.908194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T11:43:47.757862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.620686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:666"}
{"level":"info","ts":"2026-05-05T11:43:47.757928Z","caller":"traceutil/trace.go:171","msg":"trace[261825265] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12070; }","duration":"113.07678ms","start":"2026-05-05T11:43:47.64483Z","end":"2026-05-05T11:43:47.757906Z","steps":["trace[261825265] 'agreement among raft nodes before linearized reading'  (duration: 112.894195ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:43:47.757958Z","caller":"traceutil/trace.go:171","msg":"trace[2142796054] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12070; }","duration":"112.74733ms","start":"2026-05-05T11:43:47.645182Z","end":"2026-05-05T11:43:47.757929Z","steps":["trace[2142796054] 'agreement among raft nodes before linearized reading'  (duration: 112.507993ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:43:47.7579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.921305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T11:43:47.75811Z","caller":"traceutil/trace.go:171","msg":"trace[1733660108] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12070; }","duration":"113.224464ms","start":"2026-05-05T11:43:47.644862Z","end":"2026-05-05T11:43:47.758086Z","steps":["trace[1733660108] 'agreement among raft nodes before linearized reading'  (duration: 112.895594ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T11:43:47.758157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.832642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"}
{"level":"info","ts":"2026-05-05T11:43:47.758326Z","caller":"traceutil/trace.go:171","msg":"trace[1374560178] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12070; }","duration":"113.034558ms","start":"2026-05-05T11:43:47.64523Z","end":"2026-05-05T11:43:47.758264Z","steps":["trace[1374560178] 'agreement among raft nodes before linearized reading'  (duration: 112.475372ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T11:43:47.919791Z","caller":"traceutil/trace.go:171","msg":"trace[742618293] transaction","detail":"{read_only:false; response_revision:12071; number_of_response:1; }","duration":"106.583192ms","start":"2026-05-05T11:43:47.813168Z","end":"2026-05-05T11:43:47.919751Z","steps":["trace[742618293] 'process raft request'  (duration: 77.806135ms)","trace[742618293] 'compare'  (duration: 28.574272ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T11:45:19.766998Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10526}
{"level":"info","ts":"2026-05-05T11:45:19.850364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10526,"took":"80.372015ms","hash":2196266511,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":26222592,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-05T11:45:19.850462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2196266511,"revision":10526,"compact-revision":8118}
{"level":"info","ts":"2026-05-05T11:50:19.77682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12675}
{"level":"info","ts":"2026-05-05T11:50:19.854392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12675,"took":"74.58383ms","hash":3251018863,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":26976256,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-05T11:50:19.854468Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3251018863,"revision":12675,"compact-revision":10526}
{"level":"info","ts":"2026-05-05T11:55:19.783438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14681}
{"level":"info","ts":"2026-05-05T11:55:19.861333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14681,"took":"74.332902ms","hash":2709749454,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":22990848,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-05T11:55:19.861425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2709749454,"revision":14681,"compact-revision":12675}
{"level":"info","ts":"2026-05-05T12:00:19.792149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16205}
{"level":"info","ts":"2026-05-05T12:00:19.858837Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16205,"took":"64.157462ms","hash":160814128,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":20955136,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-05T12:00:19.858909Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":160814128,"revision":16205,"compact-revision":14681}
{"level":"info","ts":"2026-05-05T12:05:16.641795Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a98e0cfc7e94da4e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-05T12:05:16.649229Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-05T12:05:16.649393Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-05T12:05:19.80528Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17762}
{"level":"info","ts":"2026-05-05T12:05:19.877288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17762,"took":"69.191378ms","hash":2783902824,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21999616,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-05T12:05:19.877406Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2783902824,"revision":17762,"compact-revision":16205}
{"level":"info","ts":"2026-05-05T12:10:19.811718Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19317}
{"level":"info","ts":"2026-05-05T12:10:19.888338Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19317,"took":"72.162455ms","hash":3098586313,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21512192,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-05-05T12:10:19.888448Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3098586313,"revision":19317,"compact-revision":17762}
{"level":"info","ts":"2026-05-05T12:15:19.819491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20860}
{"level":"info","ts":"2026-05-05T12:15:19.898677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20860,"took":"75.493288ms","hash":3517019727,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":20889600,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-05T12:15:19.898776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3517019727,"revision":20860,"compact-revision":19317}
{"level":"info","ts":"2026-05-05T12:20:19.829185Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22382}
{"level":"info","ts":"2026-05-05T12:20:19.898631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22382,"took":"66.052558ms","hash":1872520052,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":20840448,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-05T12:20:19.898721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1872520052,"revision":22382,"compact-revision":20860}
{"level":"info","ts":"2026-05-05T12:25:19.837973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23903}
{"level":"info","ts":"2026-05-05T12:25:19.908849Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23903,"took":"66.598446ms","hash":2599896594,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":20967424,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-05T12:25:19.908935Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2599896594,"revision":23903,"compact-revision":22382}