{"level":"warn","ts":"2026-04-22T20:45:10.57373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T20:45:10.573814Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-04-22T20:45:10.573914Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T20:45:10.573953Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-22T20:45:10.573972Z","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-04-22T20:45:10.574677Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-04-22T20:45:10.574773Z","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.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-04-22T20:45:10.578728Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.654905ms"} {"level":"info","ts":"2026-04-22T20:45:10.583879Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-04-22T20:45:10.583965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T20:45:10.584001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-04-22T20:45:10.584016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T20:45:10.584039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-04-22T20:45:10.584095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-04-22T20:45:10.589125Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T20:45:10.590705Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T20:45:10.591899Z","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-04-22T20:45:10.594197Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T20:45:10.594412Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T20:45:10.594525Z","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-04-22T20:45:10.594752Z","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-04-22T20:45:10.594805Z","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-04-22T20:45:10.596227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-04-22T20:45:10.596414Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-22T20:45:10.598397Z","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-04-22T20:45:10.598504Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-22T20:45:10.598528Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-22T20:45:10.598762Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T20:45:10.598872Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T20:45:11.28485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T20:45:11.28491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T20:45:11.28494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-04-22T20:45:11.28496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-04-22T20:45:11.284976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-22T20:45:11.285001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-04-22T20:45:11.285016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-22T20:45:11.286304Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T20:45:11.286478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T20:45:11.286522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T20:45:11.286534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T20:45:11.286862Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T20:45:11.286946Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T20:45:11.287298Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T20:45:11.287499Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T20:45:11.28755Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T20:45:11.28949Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-04-22T20:45:11.289592Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T20:45:27.956466Z","caller":"traceutil/trace.go:171","msg":"trace[1724381011] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"160.388015ms","start":"2026-04-22T20:45:27.79605Z","end":"2026-04-22T20:45:27.956438Z","steps":["trace[1724381011] 'process raft request' (duration: 160.251112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:45:47.052911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.498177ms","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-04-22T20:45:47.053065Z","caller":"traceutil/trace.go:171","msg":"trace[20393369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"113.706051ms","start":"2026-04-22T20:45:46.939331Z","end":"2026-04-22T20:45:47.053037Z","steps":["trace[20393369] 'range keys from in-memory index tree' (duration: 113.286093ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:45:47.360285Z","caller":"traceutil/trace.go:171","msg":"trace[662905302] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"160.908946ms","start":"2026-04-22T20:45:47.199341Z","end":"2026-04-22T20:45:47.36025Z","steps":["trace[662905302] 'process raft request' (duration: 160.736643ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:45:47.689906Z","caller":"traceutil/trace.go:171","msg":"trace[931397707] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"123.395306ms","start":"2026-04-22T20:45:47.566491Z","end":"2026-04-22T20:45:47.689886Z","steps":["trace[931397707] 'read index received' (duration: 95.342765ms)","trace[931397707] 'applied index is now lower than readState.Index' (duration: 28.051661ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:45:47.69Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.499057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T20:45:47.690022Z","caller":"traceutil/trace.go:171","msg":"trace[857145916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"123.563859ms","start":"2026-04-22T20:45:47.566449Z","end":"2026-04-22T20:45:47.690013Z","steps":["trace[857145916] 'agreement among raft nodes before linearized reading' (duration: 123.507498ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:45:47.690101Z","caller":"traceutil/trace.go:171","msg":"trace[1209300212] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"433.34571ms","start":"2026-04-22T20:45:47.256718Z","end":"2026-04-22T20:45:47.690064Z","steps":["trace[1209300212] 'process raft request' (duration: 405.275059ms)","trace[1209300212] 'compare' (duration: 27.605571ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:45:47.690874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:45:47.256682Z","time spent":"433.549193ms","remote":"127.0.0.1:43222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T20:45:47.879771Z","caller":"traceutil/trace.go:171","msg":"trace[502811096] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"126.818023ms","start":"2026-04-22T20:45:47.752926Z","end":"2026-04-22T20:45:47.879744Z","steps":["trace[502811096] 'process raft request' (duration: 95.944467ms)","trace[502811096] 'compare' (duration: 30.719513ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:47:15.993706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.730185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T20:47:15.993912Z","caller":"traceutil/trace.go:171","msg":"trace[1745776939] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1913; }","duration":"425.1078ms","start":"2026-04-22T20:47:15.568772Z","end":"2026-04-22T20:47:15.99388Z","steps":["trace[1745776939] 'read index received' (duration: 19.615349ms)","trace[1745776939] 'applied index is now lower than readState.Index' (duration: 405.490751ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:47:15.993948Z","caller":"traceutil/trace.go:171","msg":"trace[795297246] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"429.200971ms","start":"2026-04-22T20:47:15.564709Z","end":"2026-04-22T20:47:15.99391Z","steps":["trace[795297246] 'process raft request' (duration: 72.760423ms)","trace[795297246] 'compare' (duration: 355.484029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:47:15.994071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.292793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T20:47:15.994146Z","caller":"traceutil/trace.go:171","msg":"trace[744357771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1844; }","duration":"425.379945ms","start":"2026-04-22T20:47:15.568746Z","end":"2026-04-22T20:47:15.994126Z","steps":["trace[744357771] 'agreement among raft nodes before linearized reading' (duration: 425.267413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:47:15.994145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:47:15.564635Z","time spent":"429.404086ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T20:47:15.994209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:47:15.568736Z","time spent":"425.459157ms","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T20:47:15.997936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.567325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T20:47:15.998009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.156518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cdb5634d-5965-46cc-baa0-457e266d5c31\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-22T20:47:15.998019Z","caller":"traceutil/trace.go:171","msg":"trace[554424356] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1845; }","duration":"333.703708ms","start":"2026-04-22T20:47:15.664297Z","end":"2026-04-22T20:47:15.998001Z","steps":["trace[554424356] 'agreement among raft nodes before linearized reading' (duration: 333.550335ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:47:15.998048Z","caller":"traceutil/trace.go:171","msg":"trace[934770041] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cdb5634d-5965-46cc-baa0-457e266d5c31; range_end:; response_count:1; response_revision:1845; }","duration":"155.197418ms","start":"2026-04-22T20:47:15.842839Z","end":"2026-04-22T20:47:15.998036Z","steps":["trace[934770041] 'agreement among raft nodes before linearized reading' (duration: 155.000305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:47:15.998067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:47:15.664278Z","time spent":"333.778189ms","remote":"127.0.0.1:57834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":16,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-22T20:47:15.998075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.247574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T20:47:15.998137Z","caller":"traceutil/trace.go:171","msg":"trace[1599398245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1845; }","duration":"126.364576ms","start":"2026-04-22T20:47:15.871758Z","end":"2026-04-22T20:47:15.998122Z","steps":["trace[1599398245] 'agreement among raft nodes before linearized reading' (duration: 126.258784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:47:15.998145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.694396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-04-22T20:47:15.998216Z","caller":"traceutil/trace.go:171","msg":"trace[1121909019] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1845; }","duration":"339.803229ms","start":"2026-04-22T20:47:15.658395Z","end":"2026-04-22T20:47:15.998198Z","steps":["trace[1121909019] 'agreement among raft nodes before linearized reading' (duration: 339.603135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:47:15.998259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:47:15.658377Z","time spent":"339.87312ms","remote":"127.0.0.1:43328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10690,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"info","ts":"2026-04-22T20:47:15.998691Z","caller":"traceutil/trace.go:171","msg":"trace[65566408] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"231.514921ms","start":"2026-04-22T20:47:15.766987Z","end":"2026-04-22T20:47:15.998502Z","steps":["trace[65566408] 'process raft request' (duration: 230.647855ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:47:16.400574Z","caller":"traceutil/trace.go:171","msg":"trace[1447381712] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"193.460508ms","start":"2026-04-22T20:47:16.207078Z","end":"2026-04-22T20:47:16.400539Z","steps":["trace[1447381712] 'process raft request' (duration: 160.748269ms)","trace[1447381712] 'compare' (duration: 32.378022ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:48:00.514143Z","caller":"traceutil/trace.go:171","msg":"trace[384302624] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"125.130344ms","start":"2026-04-22T20:48:00.38894Z","end":"2026-04-22T20:48:00.514071Z","steps":["trace[384302624] 'process raft request' (duration: 74.638938ms)","trace[384302624] 'compare' (duration: 50.092359ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:48:06.475788Z","caller":"traceutil/trace.go:171","msg":"trace[1275056801] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"160.927208ms","start":"2026-04-22T20:48:06.314807Z","end":"2026-04-22T20:48:06.475734Z","steps":["trace[1275056801] 'process raft request' (duration: 160.651762ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:48:06.47576Z","caller":"traceutil/trace.go:171","msg":"trace[1645136999] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"160.847926ms","start":"2026-04-22T20:48:06.314845Z","end":"2026-04-22T20:48:06.475693Z","steps":["trace[1645136999] 'process raft request' (duration: 160.784824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:06.870796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.466912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T20:48:06.87137Z","caller":"traceutil/trace.go:171","msg":"trace[1230683037] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"553.371758ms","start":"2026-04-22T20:48:06.317963Z","end":"2026-04-22T20:48:06.871334Z","steps":["trace[1230683037] 'process raft request' (duration: 303.249373ms)","trace[1230683037] 'compare' (duration: 249.294819ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:48:06.871475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:48:06.317939Z","time spent":"553.496702ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T20:48:06.871983Z","caller":"traceutil/trace.go:171","msg":"trace[1742709085] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2254; }","duration":"316.676862ms","start":"2026-04-22T20:48:06.555278Z","end":"2026-04-22T20:48:06.871955Z","steps":["trace[1742709085] 'read index received' (duration: 65.960056ms)","trace[1742709085] 'applied index is now lower than readState.Index' (duration: 250.715716ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:48:06.872098Z","caller":"traceutil/trace.go:171","msg":"trace[740904146] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"339.038117ms","start":"2026-04-22T20:48:06.533042Z","end":"2026-04-22T20:48:06.872081Z","steps":["trace[740904146] 'process raft request' (duration: 338.825643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:06.87216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:48:06.533007Z","time spent":"339.112879ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T20:48:06.872202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.276334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T20:48:06.872758Z","caller":"traceutil/trace.go:171","msg":"trace[185125189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"305.876377ms","start":"2026-04-22T20:48:06.566869Z","end":"2026-04-22T20:48:06.872745Z","steps":["trace[185125189] 'agreement among raft nodes before linearized reading' (duration: 305.270364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:06.872798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:48:06.566849Z","time spent":"305.937618ms","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T20:48:06.872295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.275082ms","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:5"} {"level":"info","ts":"2026-04-22T20:48:06.873004Z","caller":"traceutil/trace.go:171","msg":"trace[1616180546] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2174; }","duration":"185.983187ms","start":"2026-04-22T20:48:06.687003Z","end":"2026-04-22T20:48:06.872986Z","steps":["trace[1616180546] 'agreement among raft nodes before linearized reading' (duration: 185.256822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:06.872446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.160441ms","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-04-22T20:48:06.873108Z","caller":"traceutil/trace.go:171","msg":"trace[1920885916] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2174; }","duration":"317.853055ms","start":"2026-04-22T20:48:06.55523Z","end":"2026-04-22T20:48:06.873083Z","steps":["trace[1920885916] 'agreement among raft nodes before linearized reading' (duration: 317.060088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:06.873189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T20:48:06.555204Z","time spent":"317.968758ms","remote":"127.0.0.1:35932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-22T20:48:07.076775Z","caller":"traceutil/trace.go:171","msg":"trace[493168018] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"199.600808ms","start":"2026-04-22T20:48:06.877146Z","end":"2026-04-22T20:48:07.076747Z","steps":["trace[493168018] 'process raft request' (duration: 180.400927ms)","trace[493168018] 'compare' (duration: 19.035648ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:48:07.076931Z","caller":"traceutil/trace.go:171","msg":"trace[1634833509] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2256; }","duration":"115.92394ms","start":"2026-04-22T20:48:06.96098Z","end":"2026-04-22T20:48:07.076904Z","steps":["trace[1634833509] 'read index received' (duration: 96.712018ms)","trace[1634833509] 'applied index is now lower than readState.Index' (duration: 19.210362ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:48:07.078039Z","caller":"traceutil/trace.go:171","msg":"trace[1659207930] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"139.172754ms","start":"2026-04-22T20:48:06.938784Z","end":"2026-04-22T20:48:07.077956Z","steps":["trace[1659207930] 'process raft request' (duration: 137.923858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:48:07.07848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.868609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T20:48:07.078568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.572553ms","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-04-22T20:48:07.078658Z","caller":"traceutil/trace.go:171","msg":"trace[822168479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2176; }","duration":"117.703866ms","start":"2026-04-22T20:48:06.960921Z","end":"2026-04-22T20:48:07.078625Z","steps":["trace[822168479] 'agreement among raft nodes before linearized reading' (duration: 116.128944ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:48:07.078663Z","caller":"traceutil/trace.go:171","msg":"trace[1904711052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2176; }","duration":"117.075434ms","start":"2026-04-22T20:48:06.961527Z","end":"2026-04-22T20:48:07.078603Z","steps":["trace[1904711052] 'agreement among raft nodes before linearized reading' (duration: 115.547113ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:49:00.79915Z","caller":"traceutil/trace.go:171","msg":"trace[323593550] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"133.99205ms","start":"2026-04-22T20:49:00.66512Z","end":"2026-04-22T20:49:00.799112Z","steps":["trace[323593550] 'process raft request' (duration: 133.726394ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:49:00.803414Z","caller":"traceutil/trace.go:171","msg":"trace[1560894010] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"136.584361ms","start":"2026-04-22T20:49:00.66679Z","end":"2026-04-22T20:49:00.803375Z","steps":["trace[1560894010] 'process raft request' (duration: 136.376887ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:21.79349Z","caller":"traceutil/trace.go:171","msg":"trace[638880933] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"143.21377ms","start":"2026-04-22T20:53:21.650255Z","end":"2026-04-22T20:53:21.793468Z","steps":["trace[638880933] 'process raft request' (duration: 143.042997ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:21.818469Z","caller":"traceutil/trace.go:171","msg":"trace[1291089758] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"124.780681ms","start":"2026-04-22T20:53:21.693663Z","end":"2026-04-22T20:53:21.818443Z","steps":["trace[1291089758] 'process raft request' (duration: 124.443044ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:25.613251Z","caller":"traceutil/trace.go:171","msg":"trace[126790963] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"145.044217ms","start":"2026-04-22T20:53:25.468175Z","end":"2026-04-22T20:53:25.613219Z","steps":["trace[126790963] 'process raft request' (duration: 144.846153ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:36.89959Z","caller":"traceutil/trace.go:171","msg":"trace[1053946633] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"115.729181ms","start":"2026-04-22T20:53:36.783836Z","end":"2026-04-22T20:53:36.899566Z","steps":["trace[1053946633] 'process raft request' (duration: 115.605808ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:36.901396Z","caller":"traceutil/trace.go:171","msg":"trace[1100217577] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"116.648699ms","start":"2026-04-22T20:53:36.784722Z","end":"2026-04-22T20:53:36.901371Z","steps":["trace[1100217577] 'process raft request' (duration: 116.381714ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:37.924766Z","caller":"traceutil/trace.go:171","msg":"trace[1777329314] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"267.234357ms","start":"2026-04-22T20:53:37.657494Z","end":"2026-04-22T20:53:37.924729Z","steps":["trace[1777329314] 'process raft request' (duration: 267.000272ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:37.932078Z","caller":"traceutil/trace.go:171","msg":"trace[880974345] linearizableReadLoop","detail":"{readStateIndex:5415; appliedIndex:5413; }","duration":"246.101912ms","start":"2026-04-22T20:53:37.685958Z","end":"2026-04-22T20:53:37.93206Z","steps":["trace[880974345] 'read index received' (duration: 238.481571ms)","trace[880974345] 'applied index is now lower than readState.Index' (duration: 7.619541ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:53:37.932241Z","caller":"traceutil/trace.go:171","msg":"trace[943523612] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"261.509201ms","start":"2026-04-22T20:53:37.670711Z","end":"2026-04-22T20:53:37.93222Z","steps":["trace[943523612] 'process raft request' (duration: 261.199565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:53:37.932413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.43456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-22T20:53:37.932563Z","caller":"traceutil/trace.go:171","msg":"trace[1999003696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5220; }","duration":"246.619704ms","start":"2026-04-22T20:53:37.685932Z","end":"2026-04-22T20:53:37.932552Z","steps":["trace[1999003696] 'agreement among raft nodes before linearized reading' (duration: 246.373268ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:53:45.31388Z","caller":"traceutil/trace.go:171","msg":"trace[940258853] linearizableReadLoop","detail":"{readStateIndex:5592; appliedIndex:5591; }","duration":"192.699027ms","start":"2026-04-22T20:53:45.121146Z","end":"2026-04-22T20:53:45.313845Z","steps":["trace[940258853] 'read index received' (duration: 95.566338ms)","trace[940258853] 'applied index is now lower than readState.Index' (duration: 97.131379ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T20:53:45.314064Z","caller":"traceutil/trace.go:171","msg":"trace[371269941] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"275.95238ms","start":"2026-04-22T20:53:45.037946Z","end":"2026-04-22T20:53:45.313898Z","steps":["trace[371269941] 'process raft request' (duration: 178.805891ms)","trace[371269941] 'compare' (duration: 96.929844ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T20:53:45.314329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.168246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d2a9bfb6-6c10-4696-9c5d-ced99327cb53\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-22T20:53:45.314384Z","caller":"traceutil/trace.go:171","msg":"trace[787619906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d2a9bfb6-6c10-4696-9c5d-ced99327cb53; range_end:; response_count:1; response_revision:5392; }","duration":"193.277479ms","start":"2026-04-22T20:53:45.121095Z","end":"2026-04-22T20:53:45.314373Z","steps":["trace[787619906] 'agreement among raft nodes before linearized reading' (duration: 192.915462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T20:53:45.314328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.184769ms","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-04-22T20:53:45.314456Z","caller":"traceutil/trace.go:171","msg":"trace[647782199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5392; }","duration":"126.342842ms","start":"2026-04-22T20:53:45.188088Z","end":"2026-04-22T20:53:45.314431Z","steps":["trace[647782199] 'agreement among raft nodes before linearized reading' (duration: 126.025366ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T20:55:11.312365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3044} {"level":"info","ts":"2026-04-22T20:55:11.404561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3044,"took":"89.583866ms","hash":2338708240,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":31903744,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T20:55:11.404664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2338708240,"revision":3044,"compact-revision":-1} {"level":"info","ts":"2026-04-22T21:00:07.542986Z","caller":"traceutil/trace.go:171","msg":"trace[673850221] linearizableReadLoop","detail":"{readStateIndex:8589; appliedIndex:8588; }","duration":"118.527562ms","start":"2026-04-22T21:00:07.424419Z","end":"2026-04-22T21:00:07.542946Z","steps":["trace[673850221] 'read index received' (duration: 118.202925ms)","trace[673850221] 'applied index is now lower than readState.Index' (duration: 322.367µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:00:07.543121Z","caller":"traceutil/trace.go:171","msg":"trace[302773422] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"286.579883ms","start":"2026-04-22T21:00:07.256501Z","end":"2026-04-22T21:00:07.543081Z","steps":["trace[302773422] 'process raft request' (duration: 286.182996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:00:07.543273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.834407ms","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-04-22T21:00:07.543346Z","caller":"traceutil/trace.go:171","msg":"trace[1044114737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8299; }","duration":"118.98007ms","start":"2026-04-22T21:00:07.424349Z","end":"2026-04-22T21:00:07.543329Z","steps":["trace[1044114737] 'agreement among raft nodes before linearized reading' (duration: 118.734225ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:00:07.680761Z","caller":"traceutil/trace.go:171","msg":"trace[1991571410] linearizableReadLoop","detail":"{readStateIndex:8591; appliedIndex:8589; }","duration":"137.625184ms","start":"2026-04-22T21:00:07.543108Z","end":"2026-04-22T21:00:07.680733Z","steps":["trace[1991571410] 'read index received' (duration: 137.44313ms)","trace[1991571410] 'applied index is now lower than readState.Index' (duration: 180.264µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:00:07.680793Z","caller":"traceutil/trace.go:171","msg":"trace[980885875] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"256.306069ms","start":"2026-04-22T21:00:07.42446Z","end":"2026-04-22T21:00:07.680766Z","steps":["trace[980885875] 'process raft request' (duration: 256.041223ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:00:07.680915Z","caller":"traceutil/trace.go:171","msg":"trace[101170500] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"163.728396ms","start":"2026-04-22T21:00:07.517142Z","end":"2026-04-22T21:00:07.68087Z","steps":["trace[101170500] 'process raft request' (duration: 163.534462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:00:07.680981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.406691ms","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-04-22T21:00:07.681021Z","caller":"traceutil/trace.go:171","msg":"trace[1957278047] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8301; }","duration":"255.518363ms","start":"2026-04-22T21:00:07.425495Z","end":"2026-04-22T21:00:07.681013Z","steps":["trace[1957278047] 'agreement among raft nodes before linearized reading' (duration: 255.353599ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:00:07.681147Z","caller":"traceutil/trace.go:171","msg":"trace[1416006783] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"133.300707ms","start":"2026-04-22T21:00:07.547839Z","end":"2026-04-22T21:00:07.68114Z","steps":["trace[1416006783] 'process raft request' (duration: 133.230686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:00:07.681222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.359148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T21:00:07.681273Z","caller":"traceutil/trace.go:171","msg":"trace[633133816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8302; }","duration":"114.474881ms","start":"2026-04-22T21:00:07.566786Z","end":"2026-04-22T21:00:07.681261Z","steps":["trace[633133816] 'agreement among raft nodes before linearized reading' (duration: 114.345638ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:00:11.320096Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6158} {"level":"info","ts":"2026-04-22T21:00:11.421124Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6158,"took":"98.535331ms","hash":3730797510,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":23162880,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T21:00:11.421228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3730797510,"revision":6158,"compact-revision":3044} {"level":"warn","ts":"2026-04-22T21:00:45.889536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.361058ms","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-04-22T21:00:45.889643Z","caller":"traceutil/trace.go:171","msg":"trace[2012545178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8558; }","duration":"123.515911ms","start":"2026-04-22T21:00:45.766109Z","end":"2026-04-22T21:00:45.889625Z","steps":["trace[2012545178] 'range keys from in-memory index tree' (duration: 123.187875ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:01:00.067859Z","caller":"traceutil/trace.go:171","msg":"trace[1731222527] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"108.739686ms","start":"2026-04-22T21:00:59.959081Z","end":"2026-04-22T21:01:00.067821Z","steps":["trace[1731222527] 'process raft request' (duration: 108.281257ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:01:00.273029Z","caller":"traceutil/trace.go:171","msg":"trace[1541706189] transaction","detail":"{read_only:false; response_revision:8685; number_of_response:1; }","duration":"198.95662ms","start":"2026-04-22T21:01:00.074034Z","end":"2026-04-22T21:01:00.27299Z","steps":["trace[1541706189] 'process raft request' (duration: 198.874019ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:01:00.273056Z","caller":"traceutil/trace.go:171","msg":"trace[751691690] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"199.076593ms","start":"2026-04-22T21:01:00.073937Z","end":"2026-04-22T21:01:00.273013Z","steps":["trace[751691690] 'process raft request' (duration: 164.185545ms)","trace[751691690] 'compare' (duration: 34.595052ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:01:30.808199Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245e.wal"} {"level":"info","ts":"2026-04-22T21:02:50.509132Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T21:02:50.514829Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T21:02:50.514942Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T21:05:11.328328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8320} {"level":"info","ts":"2026-04-22T21:05:11.405356Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8320,"took":"74.746399ms","hash":2420249401,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":24096768,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-22T21:05:11.405429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2420249401,"revision":8320,"compact-revision":6158} {"level":"info","ts":"2026-04-22T21:07:52.631504Z","caller":"traceutil/trace.go:171","msg":"trace[1344825269] transaction","detail":"{read_only:false; response_revision:11844; number_of_response:1; }","duration":"130.717383ms","start":"2026-04-22T21:07:52.50075Z","end":"2026-04-22T21:07:52.631467Z","steps":["trace[1344825269] 'process raft request' (duration: 130.487168ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:52.703102Z","caller":"traceutil/trace.go:171","msg":"trace[471612610] transaction","detail":"{read_only:false; response_revision:11846; number_of_response:1; }","duration":"200.637842ms","start":"2026-04-22T21:07:52.502432Z","end":"2026-04-22T21:07:52.70307Z","steps":["trace[471612610] 'process raft request' (duration: 200.478399ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:52.703155Z","caller":"traceutil/trace.go:171","msg":"trace[96024400] transaction","detail":"{read_only:false; response_revision:11845; number_of_response:1; }","duration":"201.727424ms","start":"2026-04-22T21:07:52.501372Z","end":"2026-04-22T21:07:52.703099Z","steps":["trace[96024400] 'process raft request' (duration: 177.783134ms)","trace[96024400] 'compare' (duration: 23.414569ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:07:52.881764Z","caller":"traceutil/trace.go:171","msg":"trace[461871668] transaction","detail":"{read_only:false; response_revision:11847; number_of_response:1; }","duration":"115.777936ms","start":"2026-04-22T21:07:52.765964Z","end":"2026-04-22T21:07:52.881742Z","steps":["trace[461871668] 'process raft request' (duration: 106.812987ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:53.847879Z","caller":"traceutil/trace.go:171","msg":"trace[1169493268] linearizableReadLoop","detail":"{readStateIndex:12256; appliedIndex:12255; }","duration":"230.54692ms","start":"2026-04-22T21:07:53.617308Z","end":"2026-04-22T21:07:53.847855Z","steps":["trace[1169493268] 'read index received' (duration: 230.283335ms)","trace[1169493268] 'applied index is now lower than readState.Index' (duration: 262.585µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:07:53.847909Z","caller":"traceutil/trace.go:171","msg":"trace[363091417] transaction","detail":"{read_only:false; response_revision:11851; number_of_response:1; }","duration":"240.735204ms","start":"2026-04-22T21:07:53.607152Z","end":"2026-04-22T21:07:53.847887Z","steps":["trace[363091417] 'process raft request' (duration: 240.498689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:07:53.848134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.771245ms","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-04-22T21:07:53.848243Z","caller":"traceutil/trace.go:171","msg":"trace[2111469123] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:11851; }","duration":"230.925318ms","start":"2026-04-22T21:07:53.617273Z","end":"2026-04-22T21:07:53.848199Z","steps":["trace[2111469123] 'agreement among raft nodes before linearized reading' (duration: 230.701303ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:53.882497Z","caller":"traceutil/trace.go:171","msg":"trace[623984259] transaction","detail":"{read_only:false; response_revision:11853; number_of_response:1; }","duration":"209.55946ms","start":"2026-04-22T21:07:53.672918Z","end":"2026-04-22T21:07:53.882478Z","steps":["trace[623984259] 'process raft request' (duration: 209.475408ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:53.882497Z","caller":"traceutil/trace.go:171","msg":"trace[1413316193] transaction","detail":"{read_only:false; response_revision:11852; number_of_response:1; }","duration":"218.02199ms","start":"2026-04-22T21:07:53.664449Z","end":"2026-04-22T21:07:53.882471Z","steps":["trace[1413316193] 'process raft request' (duration: 217.831826ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:53.882767Z","caller":"traceutil/trace.go:171","msg":"trace[1068458477] transaction","detail":"{read_only:false; response_revision:11854; number_of_response:1; }","duration":"209.785124ms","start":"2026-04-22T21:07:53.672967Z","end":"2026-04-22T21:07:53.882752Z","steps":["trace[1068458477] 'process raft request' (duration: 209.468158ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:07:53.882953Z","caller":"traceutil/trace.go:171","msg":"trace[1494045026] transaction","detail":"{read_only:false; response_revision:11855; number_of_response:1; }","duration":"209.945038ms","start":"2026-04-22T21:07:53.672994Z","end":"2026-04-22T21:07:53.882939Z","steps":["trace[1494045026] 'process raft request' (duration: 209.692003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:07:53.88301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.54241ms","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":"info","ts":"2026-04-22T21:07:53.883155Z","caller":"traceutil/trace.go:171","msg":"trace[211688504] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:11855; }","duration":"196.725813ms","start":"2026-04-22T21:07:53.686408Z","end":"2026-04-22T21:07:53.883134Z","steps":["trace[211688504] 'agreement among raft nodes before linearized reading' (duration: 196.461057ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:10:11.335125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10551} {"level":"info","ts":"2026-04-22T21:10:11.413684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10551,"took":"76.140422ms","hash":3211109399,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":26152960,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-22T21:10:11.413765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3211109399,"revision":10551,"compact-revision":8320} {"level":"info","ts":"2026-04-22T21:14:22.987667Z","caller":"traceutil/trace.go:171","msg":"trace[1261906983] transaction","detail":"{read_only:false; response_revision:14450; number_of_response:1; }","duration":"133.073441ms","start":"2026-04-22T21:14:22.854567Z","end":"2026-04-22T21:14:22.987641Z","steps":["trace[1261906983] 'process raft request' (duration: 132.914828ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:14:51.058072Z","caller":"traceutil/trace.go:171","msg":"trace[1430446143] transaction","detail":"{read_only:false; response_revision:14802; number_of_response:1; }","duration":"138.064563ms","start":"2026-04-22T21:14:50.919981Z","end":"2026-04-22T21:14:51.058046Z","steps":["trace[1430446143] 'process raft request' (duration: 137.773747ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:14:51.231862Z","caller":"traceutil/trace.go:171","msg":"trace[340662713] linearizableReadLoop","detail":"{readStateIndex:15319; appliedIndex:15317; }","duration":"135.94225ms","start":"2026-04-22T21:14:51.09589Z","end":"2026-04-22T21:14:51.231832Z","steps":["trace[340662713] 'read index received' (duration: 51.600293ms)","trace[340662713] 'applied index is now lower than readState.Index' (duration: 84.340977ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:14:51.231936Z","caller":"traceutil/trace.go:171","msg":"trace[1830639503] transaction","detail":"{read_only:false; response_revision:14804; number_of_response:1; }","duration":"169.600593ms","start":"2026-04-22T21:14:51.062298Z","end":"2026-04-22T21:14:51.231899Z","steps":["trace[1830639503] 'process raft request' (duration: 136.844368ms)","trace[1830639503] 'compare' (duration: 32.293186ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:14:51.231971Z","caller":"traceutil/trace.go:171","msg":"trace[552919271] transaction","detail":"{read_only:false; response_revision:14805; number_of_response:1; }","duration":"169.200375ms","start":"2026-04-22T21:14:51.062727Z","end":"2026-04-22T21:14:51.231928Z","steps":["trace[552919271] 'process raft request' (duration: 169.048112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:14:51.232111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.202245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-04-22T21:14:51.23216Z","caller":"traceutil/trace.go:171","msg":"trace[1727969892] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:14805; }","duration":"136.297796ms","start":"2026-04-22T21:14:51.095848Z","end":"2026-04-22T21:14:51.232146Z","steps":["trace[1727969892] 'agreement among raft nodes before linearized reading' (duration: 136.130423ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:15:11.342997Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12799} {"level":"info","ts":"2026-04-22T21:15:11.422655Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12799,"took":"76.00965ms","hash":1546210312,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":28237824,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-22T21:15:11.42271Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1546210312,"revision":12799,"compact-revision":10551} {"level":"info","ts":"2026-04-22T21:15:43.64825Z","caller":"traceutil/trace.go:171","msg":"trace[1577611546] transaction","detail":"{read_only:false; response_revision:15440; number_of_response:1; }","duration":"103.280336ms","start":"2026-04-22T21:15:43.544944Z","end":"2026-04-22T21:15:43.648224Z","steps":["trace[1577611546] 'process raft request' (duration: 103.129083ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:15:43.656806Z","caller":"traceutil/trace.go:171","msg":"trace[2136167440] transaction","detail":"{read_only:false; response_revision:15441; number_of_response:1; }","duration":"108.624623ms","start":"2026-04-22T21:15:43.548167Z","end":"2026-04-22T21:15:43.656792Z","steps":["trace[2136167440] 'process raft request' (duration: 108.130573ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:16:17.67738Z","caller":"traceutil/trace.go:171","msg":"trace[997484136] linearizableReadLoop","detail":"{readStateIndex:16153; appliedIndex:16152; }","duration":"182.414069ms","start":"2026-04-22T21:16:17.494943Z","end":"2026-04-22T21:16:17.677357Z","steps":["trace[997484136] 'read index received' (duration: 182.200125ms)","trace[997484136] 'applied index is now lower than readState.Index' (duration: 213.034µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:16:17.677652Z","caller":"traceutil/trace.go:171","msg":"trace[1272178025] transaction","detail":"{read_only:false; response_revision:15615; number_of_response:1; }","duration":"209.95264ms","start":"2026-04-22T21:16:17.467664Z","end":"2026-04-22T21:16:17.677616Z","steps":["trace[1272178025] 'process raft request' (duration: 209.528542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:16:17.677685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.112413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T21:16:17.677847Z","caller":"traceutil/trace.go:171","msg":"trace[477788228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15615; }","duration":"111.301966ms","start":"2026-04-22T21:16:17.566525Z","end":"2026-04-22T21:16:17.677827Z","steps":["trace[477788228] 'agreement among raft nodes before linearized reading' (duration: 111.099392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:16:17.678104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.139193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-04-22T21:16:17.678158Z","caller":"traceutil/trace.go:171","msg":"trace[1732244675] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:15615; }","duration":"183.252746ms","start":"2026-04-22T21:16:17.494893Z","end":"2026-04-22T21:16:17.678146Z","steps":["trace[1732244675] 'agreement among raft nodes before linearized reading' (duration: 182.601063ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:20:11.351396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14942} {"level":"info","ts":"2026-04-22T21:20:11.435319Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14942,"took":"81.442904ms","hash":443067713,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":30908416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T21:20:11.435379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":443067713,"revision":14942,"compact-revision":12799} {"level":"info","ts":"2026-04-22T21:21:55.647981Z","caller":"traceutil/trace.go:171","msg":"trace[1298585462] transaction","detail":"{read_only:false; response_revision:18156; number_of_response:1; }","duration":"182.428087ms","start":"2026-04-22T21:21:55.465513Z","end":"2026-04-22T21:21:55.647941Z","steps":["trace[1298585462] 'process raft request' (duration: 182.141692ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:21:55.795478Z","caller":"traceutil/trace.go:171","msg":"trace[2007671014] transaction","detail":"{read_only:false; response_revision:18157; number_of_response:1; }","duration":"141.443701ms","start":"2026-04-22T21:21:55.653998Z","end":"2026-04-22T21:21:55.795442Z","steps":["trace[2007671014] 'process raft request' (duration: 66.347323ms)","trace[2007671014] 'compare' (duration: 74.931464ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:21:55.895277Z","caller":"traceutil/trace.go:171","msg":"trace[1992835836] transaction","detail":"{read_only:false; response_revision:18158; number_of_response:1; }","duration":"241.164928ms","start":"2026-04-22T21:21:55.654081Z","end":"2026-04-22T21:21:55.895246Z","steps":["trace[1992835836] 'process raft request' (duration: 240.908203ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:21:55.895307Z","caller":"traceutil/trace.go:171","msg":"trace[1222705467] transaction","detail":"{read_only:false; response_revision:18159; number_of_response:1; }","duration":"240.751301ms","start":"2026-04-22T21:21:55.654523Z","end":"2026-04-22T21:21:55.895274Z","steps":["trace[1222705467] 'process raft request' (duration: 240.632668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:21:55.89595Z","caller":"traceutil/trace.go:171","msg":"trace[31866775] transaction","detail":"{read_only:false; response_revision:18160; number_of_response:1; }","duration":"239.666479ms","start":"2026-04-22T21:21:55.656244Z","end":"2026-04-22T21:21:55.895911Z","steps":["trace[31866775] 'process raft request' (duration: 238.972754ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:24:04.383953Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T21:24:04.389406Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-04-22T21:24:04.389483Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-04-22T21:25:11.356705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17448} {"level":"info","ts":"2026-04-22T21:25:11.450219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17448,"took":"90.456883ms","hash":1543140262,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":34365440,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-22T21:25:11.450311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1543140262,"revision":17448,"compact-revision":14942} {"level":"info","ts":"2026-04-22T21:27:55.912525Z","caller":"traceutil/trace.go:171","msg":"trace[75019731] transaction","detail":"{read_only:false; response_revision:20910; number_of_response:1; }","duration":"109.674417ms","start":"2026-04-22T21:27:55.802822Z","end":"2026-04-22T21:27:55.912497Z","steps":["trace[75019731] 'process raft request' (duration: 109.519534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:27:56.205574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.310949ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:27:56.205784Z","caller":"traceutil/trace.go:171","msg":"trace[2133776411] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:20910; }","duration":"135.573984ms","start":"2026-04-22T21:27:56.070177Z","end":"2026-04-22T21:27:56.205751Z","steps":["trace[2133776411] 'range keys from in-memory index tree' (duration: 135.278458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:27:56.2065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.83209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:27:56.206726Z","caller":"traceutil/trace.go:171","msg":"trace[803310770] linearizableReadLoop","detail":"{readStateIndex:21627; appliedIndex:21625; }","duration":"112.576645ms","start":"2026-04-22T21:27:56.094129Z","end":"2026-04-22T21:27:56.206706Z","steps":["trace[803310770] 'read index received' (duration: 6.344696ms)","trace[803310770] 'applied index is now lower than readState.Index' (duration: 106.230819ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:27:56.20674Z","caller":"traceutil/trace.go:171","msg":"trace[30501708] transaction","detail":"{read_only:false; response_revision:20911; number_of_response:1; }","duration":"403.730271ms","start":"2026-04-22T21:27:55.802977Z","end":"2026-04-22T21:27:56.206707Z","steps":["trace[30501708] 'process raft request' (duration: 297.597584ms)","trace[30501708] 'compare' (duration: 104.852052ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:27:56.206949Z","caller":"traceutil/trace.go:171","msg":"trace[728612657] transaction","detail":"{read_only:false; response_revision:20912; number_of_response:1; }","duration":"403.568557ms","start":"2026-04-22T21:27:55.803211Z","end":"2026-04-22T21:27:56.206779Z","steps":["trace[728612657] 'process raft request' (duration: 403.423284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:27:56.207322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:27:55.803158Z","time spent":"404.068987ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:27:56.207048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:27:55.80297Z","time spent":"404.046167ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:27:56.20694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.805859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-04-22T21:27:56.207678Z","caller":"traceutil/trace.go:171","msg":"trace[199930759] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:20912; }","duration":"113.573545ms","start":"2026-04-22T21:27:56.094081Z","end":"2026-04-22T21:27:56.207655Z","steps":["trace[199930759] 'agreement among raft nodes before linearized reading' (duration: 112.713517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:27:56.744987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.950089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:27:56.745485Z","caller":"traceutil/trace.go:171","msg":"trace[993287836] linearizableReadLoop","detail":"{readStateIndex:21629; appliedIndex:21628; }","duration":"178.922488ms","start":"2026-04-22T21:27:56.566542Z","end":"2026-04-22T21:27:56.745464Z","steps":["trace[993287836] 'read index received' (duration: 39.433807ms)","trace[993287836] 'applied index is now lower than readState.Index' (duration: 139.487131ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:27:56.745559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.0138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:27:56.74559Z","caller":"traceutil/trace.go:171","msg":"trace[192358804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20914; }","duration":"179.106701ms","start":"2026-04-22T21:27:56.566475Z","end":"2026-04-22T21:27:56.745581Z","steps":["trace[192358804] 'agreement among raft nodes before linearized reading' (duration: 179.04439ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:27:56.745821Z","caller":"traceutil/trace.go:171","msg":"trace[99223557] transaction","detail":"{read_only:false; response_revision:20914; number_of_response:1; }","duration":"224.312973ms","start":"2026-04-22T21:27:56.521491Z","end":"2026-04-22T21:27:56.745804Z","steps":["trace[99223557] 'process raft request' (duration: 84.464604ms)","trace[99223557] 'compare' (duration: 138.695825ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:27:56.754877Z","caller":"traceutil/trace.go:171","msg":"trace[15097656] transaction","detail":"{read_only:false; response_revision:20915; number_of_response:1; }","duration":"186.318276ms","start":"2026-04-22T21:27:56.568537Z","end":"2026-04-22T21:27:56.754855Z","steps":["trace[15097656] 'process raft request' (duration: 185.759965ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:27:56.754927Z","caller":"traceutil/trace.go:171","msg":"trace[1185402681] transaction","detail":"{read_only:false; response_revision:20917; number_of_response:1; }","duration":"183.670693ms","start":"2026-04-22T21:27:56.571234Z","end":"2026-04-22T21:27:56.754905Z","steps":["trace[1185402681] 'process raft request' (duration: 183.283315ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:27:56.754877Z","caller":"traceutil/trace.go:171","msg":"trace[60251799] transaction","detail":"{read_only:false; response_revision:20916; number_of_response:1; }","duration":"185.632131ms","start":"2026-04-22T21:27:56.5692Z","end":"2026-04-22T21:27:56.754832Z","steps":["trace[60251799] 'process raft request' (duration: 185.271574ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:30:11.365364Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19781} {"level":"info","ts":"2026-04-22T21:30:11.479842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19781,"took":"110.866771ms","hash":1026373437,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":29523968,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T21:30:11.479999Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1026373437,"revision":19781,"compact-revision":17448} {"level":"warn","ts":"2026-04-22T21:31:43.163425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.240967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:31:43.16353Z","caller":"traceutil/trace.go:171","msg":"trace[1550921847] linearizableReadLoop","detail":"{readStateIndex:24108; appliedIndex:24107; }","duration":"139.865619ms","start":"2026-04-22T21:31:43.023646Z","end":"2026-04-22T21:31:43.163511Z","steps":["trace[1550921847] 'read index received' (duration: 13.390497ms)","trace[1550921847] 'applied index is now lower than readState.Index' (duration: 126.474012ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:31:43.163668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.030152ms","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-04-22T21:31:43.163684Z","caller":"traceutil/trace.go:171","msg":"trace[2145738206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23324; }","duration":"140.086283ms","start":"2026-04-22T21:31:43.023592Z","end":"2026-04-22T21:31:43.163678Z","steps":["trace[2145738206] 'agreement among raft nodes before linearized reading' (duration: 139.957291ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:31:43.163671Z","caller":"traceutil/trace.go:171","msg":"trace[1045265907] transaction","detail":"{read_only:false; response_revision:23324; number_of_response:1; }","duration":"266.137636ms","start":"2026-04-22T21:31:42.897492Z","end":"2026-04-22T21:31:43.16363Z","steps":["trace[1045265907] 'process raft request' (duration: 139.634674ms)","trace[1045265907] 'compare' (duration: 125.839869ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:42.047365Z","caller":"traceutil/trace.go:171","msg":"trace[2081926964] transaction","detail":"{read_only:false; response_revision:25179; number_of_response:1; }","duration":"140.693068ms","start":"2026-04-22T21:34:41.906647Z","end":"2026-04-22T21:34:42.04734Z","steps":["trace[2081926964] 'process raft request' (duration: 140.531095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.291921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.43063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:42.29236Z","caller":"traceutil/trace.go:171","msg":"trace[19632441] transaction","detail":"{read_only:false; response_revision:25180; number_of_response:1; }","duration":"383.203115ms","start":"2026-04-22T21:34:41.909129Z","end":"2026-04-22T21:34:42.292333Z","steps":["trace[19632441] 'process raft request' (duration: 196.278065ms)","trace[19632441] 'compare' (duration: 185.932121ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:42.292395Z","caller":"traceutil/trace.go:171","msg":"trace[1144254309] transaction","detail":"{read_only:false; response_revision:25181; number_of_response:1; }","duration":"187.653744ms","start":"2026-04-22T21:34:42.104712Z","end":"2026-04-22T21:34:42.292366Z","steps":["trace[1144254309] 'process raft request' (duration: 187.334408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.29245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:41.909104Z","time spent":"383.312368ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:42.292578Z","caller":"traceutil/trace.go:171","msg":"trace[910643500] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"162.252217ms","start":"2026-04-22T21:34:42.130312Z","end":"2026-04-22T21:34:42.292564Z","steps":["trace[910643500] 'process raft request' (duration: 161.838539ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:42.292629Z","caller":"traceutil/trace.go:171","msg":"trace[1643975935] linearizableReadLoop","detail":"{readStateIndex:26013; appliedIndex:26012; }","duration":"237.297464ms","start":"2026-04-22T21:34:42.055316Z","end":"2026-04-22T21:34:42.292614Z","steps":["trace[1643975935] 'read index received' (duration: 50.106899ms)","trace[1643975935] 'applied index is now lower than readState.Index' (duration: 187.189125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:42.292751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.411576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:42.292784Z","caller":"traceutil/trace.go:171","msg":"trace[1195378562] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:25182; }","duration":"237.500268ms","start":"2026-04-22T21:34:42.055274Z","end":"2026-04-22T21:34:42.292775Z","steps":["trace[1195378562] 'agreement among raft nodes before linearized reading' (duration: 237.419646ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:42.537851Z","caller":"traceutil/trace.go:171","msg":"trace[431560741] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"315.524045ms","start":"2026-04-22T21:34:42.222295Z","end":"2026-04-22T21:34:42.537819Z","steps":["trace[431560741] 'process raft request' (duration: 315.26631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.53803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:42.222264Z","time spent":"315.666528ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:42.538299Z","caller":"traceutil/trace.go:171","msg":"trace[1962612512] transaction","detail":"{read_only:false; response_revision:25184; number_of_response:1; }","duration":"280.780032ms","start":"2026-04-22T21:34:42.257493Z","end":"2026-04-22T21:34:42.538273Z","steps":["trace[1962612512] 'process raft request' (duration: 280.237651ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:42.538528Z","caller":"traceutil/trace.go:171","msg":"trace[2063497155] linearizableReadLoop","detail":"{readStateIndex:26018; appliedIndex:26015; }","duration":"245.861616ms","start":"2026-04-22T21:34:42.292654Z","end":"2026-04-22T21:34:42.538515Z","steps":["trace[2063497155] 'read index received' (duration: 244.884477ms)","trace[2063497155] 'applied index is now lower than readState.Index' (duration: 975.929µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:42.538714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.452823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-04-22T21:34:42.538762Z","caller":"traceutil/trace.go:171","msg":"trace[1943056092] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25185; }","duration":"327.560845ms","start":"2026-04-22T21:34:42.211194Z","end":"2026-04-22T21:34:42.538755Z","steps":["trace[1943056092] 'agreement among raft nodes before linearized reading' (duration: 327.433483ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:42.538746Z","caller":"traceutil/trace.go:171","msg":"trace[945694746] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"278.963075ms","start":"2026-04-22T21:34:42.259765Z","end":"2026-04-22T21:34:42.538729Z","steps":["trace[945694746] 'process raft request' (duration: 278.433575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.538779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.731254ms","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-04-22T21:34:42.538806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:42.21117Z","time spent":"327.618456ms","remote":"127.0.0.1:43328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-22T21:34:42.53883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.75556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-22T21:34:42.538881Z","caller":"traceutil/trace.go:171","msg":"trace[898054405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25185; }","duration":"313.852262ms","start":"2026-04-22T21:34:42.225017Z","end":"2026-04-22T21:34:42.53887Z","steps":["trace[898054405] 'agreement among raft nodes before linearized reading' (duration: 313.735579ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:42.538825Z","caller":"traceutil/trace.go:171","msg":"trace[1584033660] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25185; }","duration":"428.776455ms","start":"2026-04-22T21:34:42.110037Z","end":"2026-04-22T21:34:42.538813Z","steps":["trace[1584033660] 'agreement among raft nodes before linearized reading' (duration: 428.643652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.538916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:42.225001Z","time spent":"313.906772ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T21:34:42.538929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:42.109948Z","time spent":"428.971918ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T21:34:42.538903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.111887ms","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-04-22T21:34:42.538997Z","caller":"traceutil/trace.go:171","msg":"trace[1561352337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25185; }","duration":"311.23633ms","start":"2026-04-22T21:34:42.227737Z","end":"2026-04-22T21:34:42.538974Z","steps":["trace[1561352337] 'agreement among raft nodes before linearized reading' (duration: 310.947574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.53905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:42.227728Z","time spent":"311.312811ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T21:34:42.714989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.144738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:42.715185Z","caller":"traceutil/trace.go:171","msg":"trace[253388850] linearizableReadLoop","detail":"{readStateIndex:26021; appliedIndex:26019; }","duration":"148.111885ms","start":"2026-04-22T21:34:42.567053Z","end":"2026-04-22T21:34:42.715165Z","steps":["trace[253388850] 'read index received' (duration: 44.764743ms)","trace[253388850] 'applied index is now lower than readState.Index' (duration: 103.346162ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:42.715247Z","caller":"traceutil/trace.go:171","msg":"trace[905810843] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"171.802197ms","start":"2026-04-22T21:34:42.543418Z","end":"2026-04-22T21:34:42.715221Z","steps":["trace[905810843] 'process raft request' (duration: 68.344353ms)","trace[905810843] 'compare' (duration: 102.807251ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:42.715282Z","caller":"traceutil/trace.go:171","msg":"trace[2130140744] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"171.824558ms","start":"2026-04-22T21:34:42.543446Z","end":"2026-04-22T21:34:42.715271Z","steps":["trace[2130140744] 'process raft request' (duration: 171.636684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.71549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.442432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:42.715521Z","caller":"traceutil/trace.go:171","msg":"trace[304239642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25188; }","duration":"148.522484ms","start":"2026-04-22T21:34:42.566989Z","end":"2026-04-22T21:34:42.715512Z","steps":["trace[304239642] 'agreement among raft nodes before linearized reading' (duration: 148.462652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:42.715651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.774498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:42.715735Z","caller":"traceutil/trace.go:171","msg":"trace[1202460010] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25188; }","duration":"146.917181ms","start":"2026-04-22T21:34:42.568793Z","end":"2026-04-22T21:34:42.71571Z","steps":["trace[1202460010] 'agreement among raft nodes before linearized reading' (duration: 146.753167ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:43.293699Z","caller":"traceutil/trace.go:171","msg":"trace[698262383] linearizableReadLoop","detail":"{readStateIndex:26022; appliedIndex:26021; }","duration":"170.88611ms","start":"2026-04-22T21:34:43.122774Z","end":"2026-04-22T21:34:43.29366Z","steps":["trace[698262383] 'read index received' (duration: 170.565532ms)","trace[698262383] 'applied index is now lower than readState.Index' (duration: 318.978µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:43.293985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.183635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-22T21:34:43.29404Z","caller":"traceutil/trace.go:171","msg":"trace[1867601818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25189; }","duration":"171.303718ms","start":"2026-04-22T21:34:43.122721Z","end":"2026-04-22T21:34:43.294025Z","steps":["trace[1867601818] 'agreement among raft nodes before linearized reading' (duration: 171.072553ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:43.294515Z","caller":"traceutil/trace.go:171","msg":"trace[1207571408] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"192.327957ms","start":"2026-04-22T21:34:43.102167Z","end":"2026-04-22T21:34:43.294495Z","steps":["trace[1207571408] 'process raft request' (duration: 191.272686ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:43.75838Z","caller":"traceutil/trace.go:171","msg":"trace[185576047] linearizableReadLoop","detail":"{readStateIndex:26023; appliedIndex:26022; }","duration":"215.460608ms","start":"2026-04-22T21:34:43.542896Z","end":"2026-04-22T21:34:43.758356Z","steps":["trace[185576047] 'read index received' (duration: 215.344916ms)","trace[185576047] 'applied index is now lower than readState.Index' (duration: 114.672µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:43.758471Z","caller":"traceutil/trace.go:171","msg":"trace[1275266714] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"451.752982ms","start":"2026-04-22T21:34:43.306676Z","end":"2026-04-22T21:34:43.758429Z","steps":["trace[1275266714] 'process raft request' (duration: 451.520848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:43.758532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.621672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:43.758563Z","caller":"traceutil/trace.go:171","msg":"trace[1470582196] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25190; }","duration":"215.711414ms","start":"2026-04-22T21:34:43.542836Z","end":"2026-04-22T21:34:43.758548Z","steps":["trace[1470582196] 'agreement among raft nodes before linearized reading' (duration: 215.621892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:43.758628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:43.306644Z","time spent":"451.907337ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:43.760502Z","caller":"traceutil/trace.go:171","msg":"trace[2070139705] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"104.546695ms","start":"2026-04-22T21:34:43.655911Z","end":"2026-04-22T21:34:43.760457Z","steps":["trace[2070139705] 'process raft request' (duration: 104.342111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:43.76056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.518963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-22T21:34:43.760757Z","caller":"traceutil/trace.go:171","msg":"trace[164276891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25191; }","duration":"143.762638ms","start":"2026-04-22T21:34:43.616979Z","end":"2026-04-22T21:34:43.760742Z","steps":["trace[164276891] 'agreement among raft nodes before linearized reading' (duration: 143.420861ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:50.193102Z","caller":"traceutil/trace.go:171","msg":"trace[1278177878] transaction","detail":"{read_only:false; response_revision:25245; number_of_response:1; }","duration":"115.285149ms","start":"2026-04-22T21:34:50.077789Z","end":"2026-04-22T21:34:50.193074Z","steps":["trace[1278177878] 'process raft request' (duration: 115.096876ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:50.620095Z","caller":"traceutil/trace.go:171","msg":"trace[656755516] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"295.065606ms","start":"2026-04-22T21:34:50.325001Z","end":"2026-04-22T21:34:50.620066Z","steps":["trace[656755516] 'process raft request' (duration: 294.899763ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:50.822666Z","caller":"traceutil/trace.go:171","msg":"trace[1567869100] transaction","detail":"{read_only:false; response_revision:25247; number_of_response:1; }","duration":"495.563877ms","start":"2026-04-22T21:34:50.327072Z","end":"2026-04-22T21:34:50.822636Z","steps":["trace[1567869100] 'process raft request' (duration: 495.369233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:50.822845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:50.327036Z","time spent":"495.69708ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:50.823017Z","caller":"traceutil/trace.go:171","msg":"trace[742782731] transaction","detail":"{read_only:false; response_revision:25248; number_of_response:1; }","duration":"254.145329ms","start":"2026-04-22T21:34:50.568829Z","end":"2026-04-22T21:34:50.822974Z","steps":["trace[742782731] 'process raft request' (duration: 253.770412ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:50.823081Z","caller":"traceutil/trace.go:171","msg":"trace[1532076254] transaction","detail":"{read_only:false; response_revision:25249; number_of_response:1; }","duration":"252.61052ms","start":"2026-04-22T21:34:50.570433Z","end":"2026-04-22T21:34:50.823044Z","steps":["trace[1532076254] 'process raft request' (duration: 252.457337ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:50.823159Z","caller":"traceutil/trace.go:171","msg":"trace[1235158205] linearizableReadLoop","detail":"{readStateIndex:26083; appliedIndex:26081; }","duration":"256.360904ms","start":"2026-04-22T21:34:50.566764Z","end":"2026-04-22T21:34:50.823125Z","steps":["trace[1235158205] 'read index received' (duration: 53.224642ms)","trace[1235158205] 'applied index is now lower than readState.Index' (duration: 203.135302ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:50.823294Z","caller":"traceutil/trace.go:171","msg":"trace[475158686] transaction","detail":"{read_only:false; response_revision:25250; number_of_response:1; }","duration":"247.67109ms","start":"2026-04-22T21:34:50.575611Z","end":"2026-04-22T21:34:50.823282Z","steps":["trace[475158686] 'process raft request' (duration: 247.391735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:50.823447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.67011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:50.82347Z","caller":"traceutil/trace.go:171","msg":"trace[1688464904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25250; }","duration":"256.759032ms","start":"2026-04-22T21:34:50.566703Z","end":"2026-04-22T21:34:50.823462Z","steps":["trace[1688464904] 'agreement among raft nodes before linearized reading' (duration: 256.697271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:50.823491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.257993ms","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-04-22T21:34:50.823989Z","caller":"traceutil/trace.go:171","msg":"trace[1721403007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25250; }","duration":"218.786555ms","start":"2026-04-22T21:34:50.605165Z","end":"2026-04-22T21:34:50.823951Z","steps":["trace[1721403007] 'agreement among raft nodes before linearized reading' (duration: 218.160801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:51.274138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.529873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:51.274471Z","caller":"traceutil/trace.go:171","msg":"trace[1517858348] linearizableReadLoop","detail":"{readStateIndex:26089; appliedIndex:26086; }","duration":"345.140976ms","start":"2026-04-22T21:34:50.929306Z","end":"2026-04-22T21:34:51.274447Z","steps":["trace[1517858348] 'read index received' (duration: 5.143933ms)","trace[1517858348] 'applied index is now lower than readState.Index' (duration: 339.995773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:51.274609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.30216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:51.274652Z","caller":"traceutil/trace.go:171","msg":"trace[771149567] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:25253; }","duration":"345.567685ms","start":"2026-04-22T21:34:50.929069Z","end":"2026-04-22T21:34:51.274637Z","steps":["trace[771149567] 'agreement among raft nodes before linearized reading' (duration: 345.475274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:51.274693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:50.929051Z","time spent":"345.632506ms","remote":"127.0.0.1:51546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:34:51.274694Z","caller":"traceutil/trace.go:171","msg":"trace[1587334514] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"445.860786ms","start":"2026-04-22T21:34:50.828802Z","end":"2026-04-22T21:34:51.274663Z","steps":["trace[1587334514] 'process raft request' (duration: 445.465537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:51.274853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:50.828779Z","time spent":"445.995219ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:51.275421Z","caller":"traceutil/trace.go:171","msg":"trace[191941777] transaction","detail":"{read_only:false; response_revision:25251; number_of_response:1; }","duration":"447.265893ms","start":"2026-04-22T21:34:50.827937Z","end":"2026-04-22T21:34:51.275203Z","steps":["trace[191941777] 'process raft request' (duration: 106.558206ms)","trace[191941777] 'compare' (duration: 339.139886ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:51.275527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:50.827909Z","time spent":"447.57136ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:51.275873Z","caller":"traceutil/trace.go:171","msg":"trace[105187003] transaction","detail":"{read_only:false; response_revision:25253; number_of_response:1; }","duration":"446.974628ms","start":"2026-04-22T21:34:50.828882Z","end":"2026-04-22T21:34:51.275857Z","steps":["trace[105187003] 'process raft request' (duration: 445.509289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:51.275976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:50.828878Z","time spent":"447.05786ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:34:51.581725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.573074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:51.581852Z","caller":"traceutil/trace.go:171","msg":"trace[2075964015] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"261.097929ms","start":"2026-04-22T21:34:51.320727Z","end":"2026-04-22T21:34:51.581825Z","steps":["trace[2075964015] 'process raft request' (duration: 122.319111ms)","trace[2075964015] 'compare' (duration: 138.437522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:52.142421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.521514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:52.142613Z","caller":"traceutil/trace.go:171","msg":"trace[1329389790] linearizableReadLoop","detail":"{readStateIndex:26093; appliedIndex:26091; }","duration":"157.573843ms","start":"2026-04-22T21:34:51.985017Z","end":"2026-04-22T21:34:52.142591Z","steps":["trace[1329389790] 'read index received' (duration: 33.781924ms)","trace[1329389790] 'applied index is now lower than readState.Index' (duration: 123.790859ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:52.14271Z","caller":"traceutil/trace.go:171","msg":"trace[1246762757] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"297.266561ms","start":"2026-04-22T21:34:51.845429Z","end":"2026-04-22T21:34:52.142695Z","steps":["trace[1246762757] 'process raft request' (duration: 173.352209ms)","trace[1246762757] 'compare' (duration: 122.857931ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:52.14283Z","caller":"traceutil/trace.go:171","msg":"trace[434032075] transaction","detail":"{read_only:false; response_revision:25257; number_of_response:1; }","duration":"248.039058ms","start":"2026-04-22T21:34:51.894783Z","end":"2026-04-22T21:34:52.142822Z","steps":["trace[434032075] 'process raft request' (duration: 247.749672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:52.142929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.90355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:52.142991Z","caller":"traceutil/trace.go:171","msg":"trace[1787104409] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25257; }","duration":"157.984563ms","start":"2026-04-22T21:34:51.984971Z","end":"2026-04-22T21:34:52.142955Z","steps":["trace[1787104409] 'agreement among raft nodes before linearized reading' (duration: 157.92073ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:52.484682Z","caller":"traceutil/trace.go:171","msg":"trace[1470762856] linearizableReadLoop","detail":"{readStateIndex:26094; appliedIndex:26093; }","duration":"238.880476ms","start":"2026-04-22T21:34:52.245773Z","end":"2026-04-22T21:34:52.484653Z","steps":["trace[1470762856] 'read index received' (duration: 238.59306ms)","trace[1470762856] 'applied index is now lower than readState.Index' (duration: 286.116µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:52.484791Z","caller":"traceutil/trace.go:171","msg":"trace[725915723] transaction","detail":"{read_only:false; response_revision:25258; number_of_response:1; }","duration":"286.218231ms","start":"2026-04-22T21:34:52.198534Z","end":"2026-04-22T21:34:52.484752Z","steps":["trace[725915723] 'process raft request' (duration: 285.958845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:52.484855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.923687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T21:34:52.484892Z","caller":"traceutil/trace.go:171","msg":"trace[1280857561] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:25258; }","duration":"236.001259ms","start":"2026-04-22T21:34:52.24888Z","end":"2026-04-22T21:34:52.484881Z","steps":["trace[1280857561] 'agreement among raft nodes before linearized reading' (duration: 235.900507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:52.484942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.146472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx\" ","response":"range_response_count:1 size:1021"} {"level":"info","ts":"2026-04-22T21:34:52.484993Z","caller":"traceutil/trace.go:171","msg":"trace[669902978] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx; range_end:; response_count:1; response_revision:25258; }","duration":"239.250353ms","start":"2026-04-22T21:34:52.245732Z","end":"2026-04-22T21:34:52.484982Z","steps":["trace[669902978] 'agreement among raft nodes before linearized reading' (duration: 239.038439ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:52.998038Z","caller":"traceutil/trace.go:171","msg":"trace[600407625] transaction","detail":"{read_only:false; response_revision:25260; number_of_response:1; }","duration":"166.822169ms","start":"2026-04-22T21:34:52.831181Z","end":"2026-04-22T21:34:52.998004Z","steps":["trace[600407625] 'process raft request' (duration: 166.564004ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.047722Z","caller":"traceutil/trace.go:171","msg":"trace[1917062814] transaction","detail":"{read_only:false; response_revision:25262; number_of_response:1; }","duration":"215.594101ms","start":"2026-04-22T21:34:52.832093Z","end":"2026-04-22T21:34:53.047688Z","steps":["trace[1917062814] 'process raft request' (duration: 215.500709ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.047771Z","caller":"traceutil/trace.go:171","msg":"trace[1854262554] transaction","detail":"{read_only:false; response_revision:25261; number_of_response:1; }","duration":"215.823246ms","start":"2026-04-22T21:34:52.831889Z","end":"2026-04-22T21:34:53.047712Z","steps":["trace[1854262554] 'process raft request' (duration: 215.00192ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.047886Z","caller":"traceutil/trace.go:171","msg":"trace[1141918899] transaction","detail":"{read_only:false; response_revision:25263; number_of_response:1; }","duration":"215.50652ms","start":"2026-04-22T21:34:52.832331Z","end":"2026-04-22T21:34:53.047838Z","steps":["trace[1141918899] 'process raft request' (duration: 215.315435ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.047837Z","caller":"traceutil/trace.go:171","msg":"trace[220430018] linearizableReadLoop","detail":"{readStateIndex:26097; appliedIndex:26095; }","duration":"216.059961ms","start":"2026-04-22T21:34:52.831747Z","end":"2026-04-22T21:34:53.047807Z","steps":["trace[220430018] 'read index received' (duration: 166.104764ms)","trace[220430018] 'applied index is now lower than readState.Index' (duration: 49.952787ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:53.048044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.295616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-04-22T21:34:53.048077Z","caller":"traceutil/trace.go:171","msg":"trace[1228961877] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25263; }","duration":"216.390228ms","start":"2026-04-22T21:34:52.831676Z","end":"2026-04-22T21:34:53.048066Z","steps":["trace[1228961877] 'agreement among raft nodes before linearized reading' (duration: 216.208825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.898773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.189661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:34:53.898985Z","caller":"traceutil/trace.go:171","msg":"trace[1172235287] linearizableReadLoop","detail":"{readStateIndex:26102; appliedIndex:26100; }","duration":"461.422525ms","start":"2026-04-22T21:34:53.437545Z","end":"2026-04-22T21:34:53.898968Z","steps":["trace[1172235287] 'read index received' (duration: 213.965349ms)","trace[1172235287] 'applied index is now lower than readState.Index' (duration: 247.456326ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:34:53.898987Z","caller":"traceutil/trace.go:171","msg":"trace[1740381672] transaction","detail":"{read_only:false; response_revision:25266; number_of_response:1; }","duration":"534.566864ms","start":"2026-04-22T21:34:53.364383Z","end":"2026-04-22T21:34:53.89895Z","steps":["trace[1740381672] 'process raft request' (duration: 534.468582ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.899083Z","caller":"traceutil/trace.go:171","msg":"trace[250902355] transaction","detail":"{read_only:false; response_revision:25267; number_of_response:1; }","duration":"312.390281ms","start":"2026-04-22T21:34:53.586683Z","end":"2026-04-22T21:34:53.899073Z","steps":["trace[250902355] 'process raft request' (duration: 312.252809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.899132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.58666Z","time spent":"312.446323ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:34:53.899119Z","caller":"traceutil/trace.go:171","msg":"trace[175052209] transaction","detail":"{read_only:false; response_revision:25265; number_of_response:1; }","duration":"535.575424ms","start":"2026-04-22T21:34:53.363501Z","end":"2026-04-22T21:34:53.899076Z","steps":["trace[175052209] 'process raft request' (duration: 288.019596ms)","trace[175052209] 'compare' (duration: 246.987387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:34:53.899147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.364362Z","time spent":"534.696386ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:34:53.899137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.569408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:34:53.899239Z","caller":"traceutil/trace.go:171","msg":"trace[1163019042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25266; }","duration":"461.71319ms","start":"2026-04-22T21:34:53.4375Z","end":"2026-04-22T21:34:53.899213Z","steps":["trace[1163019042] 'agreement among raft nodes before linearized reading' (duration: 461.538537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.899278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.363487Z","time spent":"535.707448ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:34:53.899287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.437484Z","time spent":"461.791632ms","remote":"127.0.0.1:57614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:34:53.945402Z","caller":"traceutil/trace.go:171","msg":"trace[544783843] transaction","detail":"{read_only:false; response_revision:25268; number_of_response:1; }","duration":"172.858239ms","start":"2026-04-22T21:34:53.772502Z","end":"2026-04-22T21:34:53.94536Z","steps":["trace[544783843] 'process raft request' (duration: 172.609354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.945527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.768161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-22T21:34:53.945551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.695623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T21:34:53.94555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.506048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-04-22T21:34:53.945644Z","caller":"traceutil/trace.go:171","msg":"trace[593780022] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25268; }","duration":"424.858707ms","start":"2026-04-22T21:34:53.520759Z","end":"2026-04-22T21:34:53.945617Z","steps":["trace[593780022] 'agreement among raft nodes before linearized reading' (duration: 424.666133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.945708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.520738Z","time spent":"424.959618ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:34:53.945618Z","caller":"traceutil/trace.go:171","msg":"trace[863715878] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:25268; }","duration":"479.918994ms","start":"2026-04-22T21:34:53.465678Z","end":"2026-04-22T21:34:53.945597Z","steps":["trace[863715878] 'agreement among raft nodes before linearized reading' (duration: 479.69908ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:34:53.945729Z","caller":"traceutil/trace.go:171","msg":"trace[368459716] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:25268; }","duration":"259.782423ms","start":"2026-04-22T21:34:53.685893Z","end":"2026-04-22T21:34:53.945675Z","steps":["trace[368459716] 'agreement among raft nodes before linearized reading' (duration: 259.437316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:34:53.945771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:34:53.465662Z","time spent":"480.084268ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":14,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:35:04.052256Z","caller":"traceutil/trace.go:171","msg":"trace[1885035331] transaction","detail":"{read_only:false; response_revision:25363; number_of_response:1; }","duration":"108.476095ms","start":"2026-04-22T21:35:03.943743Z","end":"2026-04-22T21:35:04.052219Z","steps":["trace[1885035331] 'process raft request' (duration: 108.263141ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:04.3235Z","caller":"traceutil/trace.go:171","msg":"trace[76835645] linearizableReadLoop","detail":"{readStateIndex:26202; appliedIndex:26200; }","duration":"374.737376ms","start":"2026-04-22T21:35:03.948726Z","end":"2026-04-22T21:35:04.323464Z","steps":["trace[76835645] 'read index received' (duration: 103.202649ms)","trace[76835645] 'applied index is now lower than readState.Index' (duration: 271.533887ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:04.323504Z","caller":"traceutil/trace.go:171","msg":"trace[1256891392] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"375.710436ms","start":"2026-04-22T21:35:03.94773Z","end":"2026-04-22T21:35:04.32344Z","steps":["trace[1256891392] 'process raft request' (duration: 318.141877ms)","trace[1256891392] 'compare' (duration: 57.16599ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:04.323534Z","caller":"traceutil/trace.go:171","msg":"trace[631811143] transaction","detail":"{read_only:false; response_revision:25365; number_of_response:1; }","duration":"367.481523ms","start":"2026-04-22T21:35:03.956Z","end":"2026-04-22T21:35:04.323482Z","steps":["trace[631811143] 'process raft request' (duration: 367.412591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.323701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:03.947711Z","time spent":"375.88822ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:04.323719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:03.95599Z","time spent":"367.638046ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:04.323867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.112194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-22T21:35:04.323982Z","caller":"traceutil/trace.go:171","msg":"trace[939369953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25365; }","duration":"375.254187ms","start":"2026-04-22T21:35:03.948697Z","end":"2026-04-22T21:35:04.323951Z","steps":["trace[939369953] 'agreement among raft nodes before linearized reading' (duration: 374.90283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.324043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:03.94868Z","time spent":"375.352498ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T21:35:04.620579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.904231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:04.620856Z","caller":"traceutil/trace.go:171","msg":"trace[1293801254] linearizableReadLoop","detail":"{readStateIndex:26204; appliedIndex:26203; }","duration":"297.25595ms","start":"2026-04-22T21:35:04.323576Z","end":"2026-04-22T21:35:04.620832Z","steps":["trace[1293801254] 'read index received' (duration: 141.89579ms)","trace[1293801254] 'applied index is now lower than readState.Index' (duration: 155.35887ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:04.620947Z","caller":"traceutil/trace.go:171","msg":"trace[2059899495] transaction","detail":"{read_only:false; response_revision:25366; number_of_response:1; }","duration":"415.439069ms","start":"2026-04-22T21:35:04.205493Z","end":"2026-04-22T21:35:04.620932Z","steps":["trace[2059899495] 'process raft request' (duration: 260.085499ms)","trace[2059899495] 'compare' (duration: 154.729298ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:04.621013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.205474Z","time spent":"415.504951ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:04.621134Z","caller":"traceutil/trace.go:171","msg":"trace[682765777] transaction","detail":"{read_only:false; response_revision:25367; number_of_response:1; }","duration":"292.016646ms","start":"2026-04-22T21:35:04.32908Z","end":"2026-04-22T21:35:04.621097Z","steps":["trace[682765777] 'process raft request' (duration: 291.627089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.621324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.602289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"warn","ts":"2026-04-22T21:35:04.621284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.364624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:04.621372Z","caller":"traceutil/trace.go:171","msg":"trace[297979732] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25367; }","duration":"477.712761ms","start":"2026-04-22T21:35:04.143645Z","end":"2026-04-22T21:35:04.621357Z","steps":["trace[297979732] 'agreement among raft nodes before linearized reading' (duration: 477.303633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.62134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.341856ms","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-04-22T21:35:04.621484Z","caller":"traceutil/trace.go:171","msg":"trace[1431561241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25367; }","duration":"616.53695ms","start":"2026-04-22T21:35:04.004917Z","end":"2026-04-22T21:35:04.621454Z","steps":["trace[1431561241] 'agreement among raft nodes before linearized reading' (duration: 616.054961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.621542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.004896Z","time spent":"616.634662ms","remote":"127.0.0.1:43404","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-04-22T21:35:04.621336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.46539ms","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-04-22T21:35:04.621625Z","caller":"traceutil/trace.go:171","msg":"trace[1982550012] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25367; }","duration":"408.781165ms","start":"2026-04-22T21:35:04.212826Z","end":"2026-04-22T21:35:04.621608Z","steps":["trace[1982550012] 'agreement among raft nodes before linearized reading' (duration: 408.125802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.621684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.212789Z","time spent":"408.853837ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T21:35:04.621407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.143625Z","time spent":"477.774422ms","remote":"127.0.0.1:43310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1886,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" "} {"level":"info","ts":"2026-04-22T21:35:04.621398Z","caller":"traceutil/trace.go:171","msg":"trace[1424846281] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25367; }","duration":"477.487867ms","start":"2026-04-22T21:35:04.143882Z","end":"2026-04-22T21:35:04.62137Z","steps":["trace[1424846281] 'agreement among raft nodes before linearized reading' (duration: 477.056428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.621798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.143856Z","time spent":"477.906755ms","remote":"127.0.0.1:51270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:35:04.623869Z","caller":"traceutil/trace.go:171","msg":"trace[1308062776] transaction","detail":"{read_only:false; response_revision:25368; number_of_response:1; }","duration":"124.244429ms","start":"2026-04-22T21:35:04.499604Z","end":"2026-04-22T21:35:04.623848Z","steps":["trace[1308062776] 'process raft request' (duration: 123.710549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.624115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.821428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:04.624205Z","caller":"traceutil/trace.go:171","msg":"trace[399056832] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25369; }","duration":"175.937211ms","start":"2026-04-22T21:35:04.448241Z","end":"2026-04-22T21:35:04.624178Z","steps":["trace[399056832] 'agreement among raft nodes before linearized reading' (duration: 175.811578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.624644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.272205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-04-22T21:35:04.62471Z","caller":"traceutil/trace.go:171","msg":"trace[941810518] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:25369; }","duration":"211.395177ms","start":"2026-04-22T21:35:04.413303Z","end":"2026-04-22T21:35:04.624698Z","steps":["trace[941810518] 'agreement among raft nodes before linearized reading' (duration: 211.020179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.626638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.912757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-22T21:35:04.626697Z","caller":"traceutil/trace.go:171","msg":"trace[2039782139] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25369; }","duration":"243.306004ms","start":"2026-04-22T21:35:04.383378Z","end":"2026-04-22T21:35:04.626684Z","steps":["trace[2039782139] 'agreement among raft nodes before linearized reading' (duration: 240.10741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:04.921523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.563824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:04.921775Z","caller":"traceutil/trace.go:171","msg":"trace[748415517] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"293.158259ms","start":"2026-04-22T21:35:04.628591Z","end":"2026-04-22T21:35:04.921749Z","steps":["trace[748415517] 'process raft request' (duration: 293.049977ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:04.921982Z","caller":"traceutil/trace.go:171","msg":"trace[1413258011] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"293.912444ms","start":"2026-04-22T21:35:04.627823Z","end":"2026-04-22T21:35:04.921736Z","steps":["trace[1413258011] 'process raft request' (duration: 155.033624ms)","trace[1413258011] 'compare' (duration: 138.323329ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:05.10904Z","caller":"traceutil/trace.go:171","msg":"trace[1123870512] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"413.463239ms","start":"2026-04-22T21:35:04.69555Z","end":"2026-04-22T21:35:05.109014Z","steps":["trace[1123870512] 'process raft request' (duration: 352.988252ms)","trace[1123870512] 'compare' (duration: 60.050369ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:05.109157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.695527Z","time spent":"413.564751ms","remote":"127.0.0.1:43168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:05.10936Z","caller":"traceutil/trace.go:171","msg":"trace[489675339] transaction","detail":"{read_only:false; response_revision:25373; number_of_response:1; }","duration":"407.52016ms","start":"2026-04-22T21:35:04.701833Z","end":"2026-04-22T21:35:05.109353Z","steps":["trace[489675339] 'process raft request' (duration: 406.900988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:05.109397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:04.701801Z","time spent":"407.574581ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:05.109502Z","caller":"traceutil/trace.go:171","msg":"trace[1268286439] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"292.213199ms","start":"2026-04-22T21:35:04.817261Z","end":"2026-04-22T21:35:05.109474Z","steps":["trace[1268286439] 'process raft request' (duration: 291.580477ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:05.109528Z","caller":"traceutil/trace.go:171","msg":"trace[1940139727] linearizableReadLoop","detail":"{readStateIndex:26213; appliedIndex:26210; }","duration":"224.589931ms","start":"2026-04-22T21:35:04.884909Z","end":"2026-04-22T21:35:05.109499Z","steps":["trace[1940139727] 'read index received' (duration: 163.541593ms)","trace[1940139727] 'applied index is now lower than readState.Index' (duration: 61.045668ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:05.10968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.749664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T21:35:05.109716Z","caller":"traceutil/trace.go:171","msg":"trace[1215511408] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:25375; }","duration":"224.836466ms","start":"2026-04-22T21:35:04.884868Z","end":"2026-04-22T21:35:05.109704Z","steps":["trace[1215511408] 'agreement among raft nodes before linearized reading' (duration: 224.719823ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:05.309255Z","caller":"traceutil/trace.go:171","msg":"trace[1169981601] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"219.5317ms","start":"2026-04-22T21:35:05.089694Z","end":"2026-04-22T21:35:05.309226Z","steps":["trace[1169981601] 'process raft request' (duration: 171.839849ms)","trace[1169981601] 'compare' (duration: 47.456377ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:05.309399Z","caller":"traceutil/trace.go:171","msg":"trace[1794512452] linearizableReadLoop","detail":"{readStateIndex:26217; appliedIndex:26214; }","duration":"198.45069ms","start":"2026-04-22T21:35:05.110914Z","end":"2026-04-22T21:35:05.309365Z","steps":["trace[1794512452] 'read index received' (duration: 150.583044ms)","trace[1794512452] 'applied index is now lower than readState.Index' (duration: 47.866546ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:05.309246Z","caller":"traceutil/trace.go:171","msg":"trace[1163408834] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"215.727384ms","start":"2026-04-22T21:35:05.093489Z","end":"2026-04-22T21:35:05.309216Z","steps":["trace[1163408834] 'process raft request' (duration: 215.660043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:05.30971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.546753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T21:35:05.309898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.899249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-04-22T21:35:05.3099Z","caller":"traceutil/trace.go:171","msg":"trace[1136170696] transaction","detail":"{read_only:false; response_revision:25378; number_of_response:1; }","duration":"216.236055ms","start":"2026-04-22T21:35:05.093568Z","end":"2026-04-22T21:35:05.309804Z","steps":["trace[1136170696] 'process raft request' (duration: 215.631372ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:05.309958Z","caller":"traceutil/trace.go:171","msg":"trace[460108142] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:25378; }","duration":"199.031811ms","start":"2026-04-22T21:35:05.110909Z","end":"2026-04-22T21:35:05.309941Z","steps":["trace[460108142] 'agreement among raft nodes before linearized reading' (duration: 198.749216ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:05.309774Z","caller":"traceutil/trace.go:171","msg":"trace[1008192861] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25378; }","duration":"165.684867ms","start":"2026-04-22T21:35:05.144072Z","end":"2026-04-22T21:35:05.309757Z","steps":["trace[1008192861] 'agreement among raft nodes before linearized reading' (duration: 165.554034ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:05.544158Z","caller":"traceutil/trace.go:171","msg":"trace[1384706415] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"102.965734ms","start":"2026-04-22T21:35:05.441165Z","end":"2026-04-22T21:35:05.544131Z","steps":["trace[1384706415] 'process raft request' (duration: 81.348753ms)","trace[1384706415] 'compare' (duration: 21.356746ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:06.34651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.160378ms","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:6"} {"level":"info","ts":"2026-04-22T21:35:06.346586Z","caller":"traceutil/trace.go:171","msg":"trace[119442393] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25381; }","duration":"109.293011ms","start":"2026-04-22T21:35:06.237271Z","end":"2026-04-22T21:35:06.346564Z","steps":["trace[119442393] 'count revisions from in-memory index tree' (duration: 109.040406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:06.820048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.171751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:06.820196Z","caller":"traceutil/trace.go:171","msg":"trace[1004434703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25382; }","duration":"252.346634ms","start":"2026-04-22T21:35:06.567793Z","end":"2026-04-22T21:35:06.820139Z","steps":["trace[1004434703] 'range keys from in-memory index tree' (duration: 252.050759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:06.820227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.132753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-22T21:35:06.820336Z","caller":"traceutil/trace.go:171","msg":"trace[242604729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25382; }","duration":"189.285067ms","start":"2026-04-22T21:35:06.631022Z","end":"2026-04-22T21:35:06.820307Z","steps":["trace[242604729] 'range keys from in-memory index tree' (duration: 188.95067ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:06.975405Z","caller":"traceutil/trace.go:171","msg":"trace[1747032856] transaction","detail":"{read_only:false; response_revision:25383; number_of_response:1; }","duration":"344.125666ms","start":"2026-04-22T21:35:06.631244Z","end":"2026-04-22T21:35:06.97537Z","steps":["trace[1747032856] 'process raft request' (duration: 343.902312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:06.975578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:06.631197Z","time spent":"344.283639ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:07.086984Z","caller":"traceutil/trace.go:171","msg":"trace[871592448] transaction","detail":"{read_only:false; response_revision:25385; number_of_response:1; }","duration":"261.436165ms","start":"2026-04-22T21:35:06.825507Z","end":"2026-04-22T21:35:07.086943Z","steps":["trace[871592448] 'process raft request' (duration: 261.283472ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.087091Z","caller":"traceutil/trace.go:171","msg":"trace[127112867] linearizableReadLoop","detail":"{readStateIndex:26223; appliedIndex:26221; }","duration":"264.956175ms","start":"2026-04-22T21:35:06.822105Z","end":"2026-04-22T21:35:07.087061Z","steps":["trace[127112867] 'read index received' (duration: 153.023652ms)","trace[127112867] 'applied index is now lower than readState.Index' (duration: 111.930613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:07.087354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.20926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:07.087449Z","caller":"traceutil/trace.go:171","msg":"trace[1305495158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25385; }","duration":"265.418635ms","start":"2026-04-22T21:35:06.822004Z","end":"2026-04-22T21:35:07.087423Z","steps":["trace[1305495158] 'agreement among raft nodes before linearized reading' (duration: 265.220541ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.087228Z","caller":"traceutil/trace.go:171","msg":"trace[2046561144] transaction","detail":"{read_only:false; response_revision:25384; number_of_response:1; }","duration":"454.169211ms","start":"2026-04-22T21:35:06.632729Z","end":"2026-04-22T21:35:07.086899Z","steps":["trace[2046561144] 'process raft request' (duration: 387.692445ms)","trace[2046561144] 'compare' (duration: 66.091658ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:07.087557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.06591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-22T21:35:07.087592Z","caller":"traceutil/trace.go:171","msg":"trace[1892399661] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:25385; }","duration":"227.138671ms","start":"2026-04-22T21:35:06.860443Z","end":"2026-04-22T21:35:07.087582Z","steps":["trace[1892399661] 'agreement among raft nodes before linearized reading' (duration: 226.983628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:07.087622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.658775ms","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-04-22T21:35:07.08769Z","caller":"traceutil/trace.go:171","msg":"trace[281822245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25385; }","duration":"160.783837ms","start":"2026-04-22T21:35:06.926886Z","end":"2026-04-22T21:35:07.08767Z","steps":["trace[281822245] 'agreement among raft nodes before linearized reading' (duration: 160.538652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:07.088003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.92154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-04-22T21:35:07.08844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:06.632695Z","time spent":"454.898845ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:07.087362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.775894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:07.088651Z","caller":"traceutil/trace.go:171","msg":"trace[1354871481] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25385; }","duration":"161.059282ms","start":"2026-04-22T21:35:06.92703Z","end":"2026-04-22T21:35:07.088089Z","steps":["trace[1354871481] 'agreement among raft nodes before linearized reading' (duration: 160.349159ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.088519Z","caller":"traceutil/trace.go:171","msg":"trace[1341292495] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25385; }","duration":"236.985089ms","start":"2026-04-22T21:35:06.85152Z","end":"2026-04-22T21:35:07.088505Z","steps":["trace[1341292495] 'agreement among raft nodes before linearized reading' (duration: 235.784904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:07.404491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.078633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:07.404643Z","caller":"traceutil/trace.go:171","msg":"trace[1728816403] transaction","detail":"{read_only:false; response_revision:25387; number_of_response:1; }","duration":"312.154537ms","start":"2026-04-22T21:35:07.092457Z","end":"2026-04-22T21:35:07.404611Z","steps":["trace[1728816403] 'process raft request' (duration: 151.827579ms)","trace[1728816403] 'compare' (duration: 159.604024ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:07.404717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:07.09244Z","time spent":"312.244419ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:07.407112Z","caller":"traceutil/trace.go:171","msg":"trace[1408594754] transaction","detail":"{read_only:false; response_revision:25388; number_of_response:1; }","duration":"293.25451ms","start":"2026-04-22T21:35:07.113836Z","end":"2026-04-22T21:35:07.407091Z","steps":["trace[1408594754] 'process raft request' (duration: 293.042376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.407367Z","caller":"traceutil/trace.go:171","msg":"trace[1149399857] transaction","detail":"{read_only:false; response_revision:25389; number_of_response:1; }","duration":"293.115478ms","start":"2026-04-22T21:35:07.114214Z","end":"2026-04-22T21:35:07.407329Z","steps":["trace[1149399857] 'process raft request' (duration: 292.810472ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.427575Z","caller":"traceutil/trace.go:171","msg":"trace[1039990656] transaction","detail":"{read_only:false; response_revision:25390; number_of_response:1; }","duration":"111.714799ms","start":"2026-04-22T21:35:07.315799Z","end":"2026-04-22T21:35:07.427514Z","steps":["trace[1039990656] 'process raft request' (duration: 111.438404ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.427855Z","caller":"traceutil/trace.go:171","msg":"trace[1839304399] transaction","detail":"{read_only:false; response_revision:25391; number_of_response:1; }","duration":"111.214689ms","start":"2026-04-22T21:35:07.316589Z","end":"2026-04-22T21:35:07.427804Z","steps":["trace[1839304399] 'process raft request' (duration: 110.872102ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:07.427965Z","caller":"traceutil/trace.go:171","msg":"trace[1527373700] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"111.233789ms","start":"2026-04-22T21:35:07.316696Z","end":"2026-04-22T21:35:07.42793Z","steps":["trace[1527373700] 'process raft request' (duration: 111.054456ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:11.372075Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22029} {"level":"info","ts":"2026-04-22T21:35:11.641554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22029,"took":"265.209711ms","hash":2383168230,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":43999232,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-04-22T21:35:11.641637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2383168230,"revision":22029,"compact-revision":19781} {"level":"info","ts":"2026-04-22T21:35:12.331886Z","caller":"traceutil/trace.go:171","msg":"trace[1818847059] transaction","detail":"{read_only:false; response_revision:25494; number_of_response:1; }","duration":"181.447779ms","start":"2026-04-22T21:35:12.150404Z","end":"2026-04-22T21:35:12.331852Z","steps":["trace[1818847059] 'process raft request' (duration: 181.214824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:20.363745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.50588ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T21:35:20.364123Z","caller":"traceutil/trace.go:171","msg":"trace[465446309] linearizableReadLoop","detail":"{readStateIndex:26432; appliedIndex:26430; }","duration":"142.234468ms","start":"2026-04-22T21:35:20.221863Z","end":"2026-04-22T21:35:20.364097Z","steps":["trace[465446309] 'read index received' (duration: 44.503548ms)","trace[465446309] 'applied index is now lower than readState.Index' (duration: 97.7297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:20.364321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.445042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-04-22T21:35:20.36436Z","caller":"traceutil/trace.go:171","msg":"trace[1599362019] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25589; }","duration":"142.550084ms","start":"2026-04-22T21:35:20.221796Z","end":"2026-04-22T21:35:20.364346Z","steps":["trace[1599362019] 'agreement among raft nodes before linearized reading' (duration: 142.370961ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:20.364482Z","caller":"traceutil/trace.go:171","msg":"trace[167741763] transaction","detail":"{read_only:false; response_revision:25589; number_of_response:1; }","duration":"242.914167ms","start":"2026-04-22T21:35:20.121515Z","end":"2026-04-22T21:35:20.364429Z","steps":["trace[167741763] 'process raft request' (duration: 242.367435ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:20.572818Z","caller":"traceutil/trace.go:171","msg":"trace[1245941050] transaction","detail":"{read_only:false; response_revision:25590; number_of_response:1; }","duration":"204.955949ms","start":"2026-04-22T21:35:20.367821Z","end":"2026-04-22T21:35:20.572777Z","steps":["trace[1245941050] 'process raft request' (duration: 203.944229ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:35.201119Z","caller":"traceutil/trace.go:171","msg":"trace[226159836] transaction","detail":"{read_only:false; response_revision:25705; number_of_response:1; }","duration":"106.188869ms","start":"2026-04-22T21:35:35.094903Z","end":"2026-04-22T21:35:35.201092Z","steps":["trace[226159836] 'process raft request' (duration: 106.010576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.459151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.121066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:35.459287Z","caller":"traceutil/trace.go:171","msg":"trace[705191104] linearizableReadLoop","detail":"{readStateIndex:26552; appliedIndex:26551; }","duration":"215.269115ms","start":"2026-04-22T21:35:35.243992Z","end":"2026-04-22T21:35:35.459261Z","steps":["trace[705191104] 'read index received' (duration: 82.914144ms)","trace[705191104] 'applied index is now lower than readState.Index' (duration: 132.353511ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:35.459379Z","caller":"traceutil/trace.go:171","msg":"trace[1084238484] transaction","detail":"{read_only:false; response_revision:25706; number_of_response:1; }","duration":"261.091098ms","start":"2026-04-22T21:35:35.198256Z","end":"2026-04-22T21:35:35.459347Z","steps":["trace[1084238484] 'process raft request' (duration: 128.637826ms)","trace[1084238484] 'compare' (duration: 131.886331ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:35.45948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.486609ms","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-04-22T21:35:35.459509Z","caller":"traceutil/trace.go:171","msg":"trace[1342367199] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25706; }","duration":"215.54535ms","start":"2026-04-22T21:35:35.243952Z","end":"2026-04-22T21:35:35.459498Z","steps":["trace[1342367199] 'agreement among raft nodes before linearized reading' (duration: 215.389437ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:35.491845Z","caller":"traceutil/trace.go:171","msg":"trace[949964456] transaction","detail":"{read_only:false; response_revision:25707; number_of_response:1; }","duration":"138.115277ms","start":"2026-04-22T21:35:35.353705Z","end":"2026-04-22T21:35:35.491821Z","steps":["trace[949964456] 'process raft request' (duration: 137.991914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.729811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.022284ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:35.730233Z","caller":"traceutil/trace.go:171","msg":"trace[639279425] transaction","detail":"{read_only:false; response_revision:25708; number_of_response:1; }","duration":"350.614615ms","start":"2026-04-22T21:35:35.379574Z","end":"2026-04-22T21:35:35.730189Z","steps":["trace[639279425] 'process raft request' (duration: 214.002279ms)","trace[639279425] 'compare' (duration: 135.486153ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:35.73038Z","caller":"traceutil/trace.go:171","msg":"trace[127718719] transaction","detail":"{read_only:false; response_revision:25710; number_of_response:1; }","duration":"214.99085ms","start":"2026-04-22T21:35:35.515329Z","end":"2026-04-22T21:35:35.73032Z","steps":["trace[127718719] 'process raft request' (duration: 214.869927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.730455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.379554Z","time spent":"350.759548ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:35.730622Z","caller":"traceutil/trace.go:171","msg":"trace[2065621177] transaction","detail":"{read_only:false; response_revision:25709; number_of_response:1; }","duration":"264.872185ms","start":"2026-04-22T21:35:35.465738Z","end":"2026-04-22T21:35:35.73061Z","steps":["trace[2065621177] 'process raft request' (duration: 264.284584ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:35.73072Z","caller":"traceutil/trace.go:171","msg":"trace[23012743] linearizableReadLoop","detail":"{readStateIndex:26554; appliedIndex:26552; }","duration":"271.401084ms","start":"2026-04-22T21:35:35.459308Z","end":"2026-04-22T21:35:35.730709Z","steps":["trace[23012743] 'read index received' (duration: 32.340105ms)","trace[23012743] 'applied index is now lower than readState.Index' (duration: 239.059319ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:35.730689Z","caller":"traceutil/trace.go:171","msg":"trace[1774866393] transaction","detail":"{read_only:false; response_revision:25711; number_of_response:1; }","duration":"214.836426ms","start":"2026-04-22T21:35:35.515823Z","end":"2026-04-22T21:35:35.730659Z","steps":["trace[1774866393] 'process raft request' (duration: 214.437519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.73096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.790659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-04-22T21:35:35.730997Z","caller":"traceutil/trace.go:171","msg":"trace[1788112757] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25711; }","duration":"341.82699ms","start":"2026-04-22T21:35:35.389158Z","end":"2026-04-22T21:35:35.730985Z","steps":["trace[1788112757] 'agreement among raft nodes before linearized reading' (duration: 341.645436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.731029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.38908Z","time spent":"341.942093ms","remote":"127.0.0.1:35690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3331,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-04-22T21:35:35.731556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.319492ms","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-04-22T21:35:35.73159Z","caller":"traceutil/trace.go:171","msg":"trace[1797256235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25712; }","duration":"480.394683ms","start":"2026-04-22T21:35:35.251188Z","end":"2026-04-22T21:35:35.731582Z","steps":["trace[1797256235] 'agreement among raft nodes before linearized reading' (duration: 480.029616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.731615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.251177Z","time spent":"480.427994ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T21:35:35.731553Z","caller":"traceutil/trace.go:171","msg":"trace[459317007] transaction","detail":"{read_only:false; response_revision:25712; number_of_response:1; }","duration":"204.338067ms","start":"2026-04-22T21:35:35.527204Z","end":"2026-04-22T21:35:35.731542Z","steps":["trace[459317007] 'process raft request' (duration: 203.364508ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:35.731766Z","caller":"traceutil/trace.go:171","msg":"trace[1008887351] transaction","detail":"{read_only:false; response_revision:25713; number_of_response:1; }","duration":"203.777565ms","start":"2026-04-22T21:35:35.527977Z","end":"2026-04-22T21:35:35.731755Z","steps":["trace[1008887351] 'process raft request' (duration: 203.288515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.731936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.862507ms","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-04-22T21:35:35.731962Z","caller":"traceutil/trace.go:171","msg":"trace[1468263097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25714; }","duration":"189.920369ms","start":"2026-04-22T21:35:35.542036Z","end":"2026-04-22T21:35:35.731957Z","steps":["trace[1468263097] 'agreement among raft nodes before linearized reading' (duration: 189.841397ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:35.73202Z","caller":"traceutil/trace.go:171","msg":"trace[1023231135] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"202.691594ms","start":"2026-04-22T21:35:35.529323Z","end":"2026-04-22T21:35:35.732015Z","steps":["trace[1023231135] 'process raft request' (duration: 202.393778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:35.732194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.030483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:35.732237Z","caller":"traceutil/trace.go:171","msg":"trace[2013836615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25714; }","duration":"166.071124ms","start":"2026-04-22T21:35:35.566154Z","end":"2026-04-22T21:35:35.732225Z","steps":["trace[2013836615] 'agreement among raft nodes before linearized reading' (duration: 166.002012ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:36.07104Z","caller":"traceutil/trace.go:171","msg":"trace[882588760] transaction","detail":"{read_only:false; response_revision:25715; number_of_response:1; }","duration":"332.555504ms","start":"2026-04-22T21:35:35.738449Z","end":"2026-04-22T21:35:36.071004Z","steps":["trace[882588760] 'process raft request' (duration: 273.943635ms)","trace[882588760] 'compare' (duration: 58.479976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:36.071206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.738426Z","time spent":"332.693457ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T21:35:36.089339Z","caller":"traceutil/trace.go:171","msg":"trace[88858751] linearizableReadLoop","detail":"{readStateIndex:26562; appliedIndex:26560; }","duration":"333.899742ms","start":"2026-04-22T21:35:35.755407Z","end":"2026-04-22T21:35:36.089306Z","steps":["trace[88858751] 'read index received' (duration: 257.000308ms)","trace[88858751] 'applied index is now lower than readState.Index' (duration: 76.898314ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:36.089449Z","caller":"traceutil/trace.go:171","msg":"trace[717044717] transaction","detail":"{read_only:false; response_revision:25716; number_of_response:1; }","duration":"350.944881ms","start":"2026-04-22T21:35:35.738447Z","end":"2026-04-22T21:35:36.089392Z","steps":["trace[717044717] 'process raft request' (duration: 350.715447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:36.089537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.096285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:36.089575Z","caller":"traceutil/trace.go:171","msg":"trace[850255955] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25716; }","duration":"334.162567ms","start":"2026-04-22T21:35:35.755399Z","end":"2026-04-22T21:35:36.089562Z","steps":["trace[850255955] 'agreement among raft nodes before linearized reading' (duration: 334.070025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:36.089605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.755357Z","time spent":"334.240228ms","remote":"127.0.0.1:43406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"warn","ts":"2026-04-22T21:35:36.089688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:35.738423Z","time spent":"351.126695ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:36.089788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.147282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-04-22T21:35:36.089858Z","caller":"traceutil/trace.go:171","msg":"trace[713292109] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25716; }","duration":"233.258074ms","start":"2026-04-22T21:35:35.856577Z","end":"2026-04-22T21:35:36.089835Z","steps":["trace[713292109] 'agreement among raft nodes before linearized reading' (duration: 233.019349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:36.089987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.037985ms","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-04-22T21:35:36.090039Z","caller":"traceutil/trace.go:171","msg":"trace[190198644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25716; }","duration":"118.125377ms","start":"2026-04-22T21:35:35.971896Z","end":"2026-04-22T21:35:36.090022Z","steps":["trace[190198644] 'agreement among raft nodes before linearized reading' (duration: 117.976704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:36.500394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.998068ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:36.500518Z","caller":"traceutil/trace.go:171","msg":"trace[654764844] linearizableReadLoop","detail":"{readStateIndex:26564; appliedIndex:26563; }","duration":"322.606176ms","start":"2026-04-22T21:35:36.177888Z","end":"2026-04-22T21:35:36.500494Z","steps":["trace[654764844] 'read index received' (duration: 81.369013ms)","trace[654764844] 'applied index is now lower than readState.Index' (duration: 241.235763ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:36.500598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.706278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:36.500635Z","caller":"traceutil/trace.go:171","msg":"trace[827445630] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25718; }","duration":"322.763409ms","start":"2026-04-22T21:35:36.177858Z","end":"2026-04-22T21:35:36.500622Z","steps":["trace[827445630] 'agreement among raft nodes before linearized reading' (duration: 322.691517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:36.500677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:36.177846Z","time spent":"322.82137ms","remote":"127.0.0.1:57592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-22T21:35:36.500913Z","caller":"traceutil/trace.go:171","msg":"trace[1424005105] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"377.107404ms","start":"2026-04-22T21:35:36.12379Z","end":"2026-04-22T21:35:36.500897Z","steps":["trace[1424005105] 'process raft request' (duration: 135.511724ms)","trace[1424005105] 'compare' (duration: 240.819185ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:36.500977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:36.123755Z","time spent":"377.192096ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:36.951129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.243619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:36.951247Z","caller":"traceutil/trace.go:171","msg":"trace[1787680440] linearizableReadLoop","detail":"{readStateIndex:26566; appliedIndex:26565; }","duration":"224.08275ms","start":"2026-04-22T21:35:36.727144Z","end":"2026-04-22T21:35:36.951226Z","steps":["trace[1787680440] 'read index received' (duration: 93.75191ms)","trace[1787680440] 'applied index is now lower than readState.Index' (duration: 130.32976ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:36.951538Z","caller":"traceutil/trace.go:171","msg":"trace[1202050595] transaction","detail":"{read_only:false; response_revision:25720; number_of_response:1; }","duration":"263.538548ms","start":"2026-04-22T21:35:36.687952Z","end":"2026-04-22T21:35:36.951491Z","steps":["trace[1202050595] 'process raft request' (duration: 132.8462ms)","trace[1202050595] 'compare' (duration: 130.093076ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:36.951653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.440457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:36.951977Z","caller":"traceutil/trace.go:171","msg":"trace[2098270008] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25720; }","duration":"224.737594ms","start":"2026-04-22T21:35:36.727063Z","end":"2026-04-22T21:35:36.951801Z","steps":["trace[2098270008] 'agreement among raft nodes before linearized reading' (duration: 224.338676ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:37.457747Z","caller":"traceutil/trace.go:171","msg":"trace[1926163096] linearizableReadLoop","detail":"{readStateIndex:26567; appliedIndex:26566; }","duration":"175.931239ms","start":"2026-04-22T21:35:37.281787Z","end":"2026-04-22T21:35:37.457718Z","steps":["trace[1926163096] 'read index received' (duration: 175.729815ms)","trace[1926163096] 'applied index is now lower than readState.Index' (duration: 199.954µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:37.457816Z","caller":"traceutil/trace.go:171","msg":"trace[1439646417] transaction","detail":"{read_only:false; response_revision:25721; number_of_response:1; }","duration":"249.874165ms","start":"2026-04-22T21:35:37.207897Z","end":"2026-04-22T21:35:37.457771Z","steps":["trace[1439646417] 'process raft request' (duration: 249.63394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:37.457902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.088293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:37.457946Z","caller":"traceutil/trace.go:171","msg":"trace[305502502] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:25721; }","duration":"176.206206ms","start":"2026-04-22T21:35:37.281726Z","end":"2026-04-22T21:35:37.457932Z","steps":["trace[305502502] 'agreement among raft nodes before linearized reading' (duration: 176.103764ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:40.339416Z","caller":"traceutil/trace.go:171","msg":"trace[690069435] linearizableReadLoop","detail":"{readStateIndex:26606; appliedIndex:26605; }","duration":"255.555108ms","start":"2026-04-22T21:35:40.083827Z","end":"2026-04-22T21:35:40.339382Z","steps":["trace[690069435] 'read index received' (duration: 255.314353ms)","trace[690069435] 'applied index is now lower than readState.Index' (duration: 239.475µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:40.339576Z","caller":"traceutil/trace.go:171","msg":"trace[1740578574] transaction","detail":"{read_only:false; response_revision:25759; number_of_response:1; }","duration":"275.290471ms","start":"2026-04-22T21:35:40.06427Z","end":"2026-04-22T21:35:40.339561Z","steps":["trace[1740578574] 'process raft request' (duration: 274.909264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:40.339727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.379806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:40.339853Z","caller":"traceutil/trace.go:171","msg":"trace[1929750328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25759; }","duration":"246.560579ms","start":"2026-04-22T21:35:40.093264Z","end":"2026-04-22T21:35:40.339824Z","steps":["trace[1929750328] 'agreement among raft nodes before linearized reading' (duration: 246.371355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:40.339997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.527339ms","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-04-22T21:35:40.340092Z","caller":"traceutil/trace.go:171","msg":"trace[1405986137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25759; }","duration":"219.682302ms","start":"2026-04-22T21:35:40.120386Z","end":"2026-04-22T21:35:40.340068Z","steps":["trace[1405986137] 'agreement among raft nodes before linearized reading' (duration: 219.363076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:40.340097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.223111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-22T21:35:40.340237Z","caller":"traceutil/trace.go:171","msg":"trace[2028551447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25759; }","duration":"256.416285ms","start":"2026-04-22T21:35:40.083788Z","end":"2026-04-22T21:35:40.340204Z","steps":["trace[2028551447] 'agreement among raft nodes before linearized reading' (duration: 256.045928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:40.340123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.438507ms","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-04-22T21:35:40.34041Z","caller":"traceutil/trace.go:171","msg":"trace[1575179910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25759; }","duration":"238.759803ms","start":"2026-04-22T21:35:40.10162Z","end":"2026-04-22T21:35:40.340379Z","steps":["trace[1575179910] 'agreement among raft nodes before linearized reading' (duration: 238.239403ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:46.920688Z","caller":"traceutil/trace.go:171","msg":"trace[68184780] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"168.129874ms","start":"2026-04-22T21:35:46.752521Z","end":"2026-04-22T21:35:46.920651Z","steps":["trace[68184780] 'process raft request' (duration: 86.508896ms)","trace[68184780] 'compare' (duration: 81.166579ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:52.842261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.950642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:35:52.842503Z","caller":"traceutil/trace.go:171","msg":"trace[1540028031] linearizableReadLoop","detail":"{readStateIndex:26703; appliedIndex:26701; }","duration":"223.785594ms","start":"2026-04-22T21:35:52.618698Z","end":"2026-04-22T21:35:52.842484Z","steps":["trace[1540028031] 'read index received' (duration: 80.541637ms)","trace[1540028031] 'applied index is now lower than readState.Index' (duration: 143.242997ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:52.842576Z","caller":"traceutil/trace.go:171","msg":"trace[29756020] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"255.766002ms","start":"2026-04-22T21:35:52.586775Z","end":"2026-04-22T21:35:52.842541Z","steps":["trace[29756020] 'process raft request' (duration: 255.617399ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:52.842576Z","caller":"traceutil/trace.go:171","msg":"trace[313488624] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"256.303622ms","start":"2026-04-22T21:35:52.586237Z","end":"2026-04-22T21:35:52.842541Z","steps":["trace[313488624] 'process raft request' (duration: 112.983283ms)","trace[313488624] 'compare' (duration: 142.757228ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:52.842714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.02249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-22T21:35:52.842737Z","caller":"traceutil/trace.go:171","msg":"trace[1630160125] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:25853; }","duration":"224.091011ms","start":"2026-04-22T21:35:52.618638Z","end":"2026-04-22T21:35:52.842729Z","steps":["trace[1630160125] 'agreement among raft nodes before linearized reading' (duration: 223.934028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:52.842803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.97556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T21:35:52.842819Z","caller":"traceutil/trace.go:171","msg":"trace[231454584] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:25853; }","duration":"176.037701ms","start":"2026-04-22T21:35:52.666776Z","end":"2026-04-22T21:35:52.842814Z","steps":["trace[231454584] 'agreement among raft nodes before linearized reading' (duration: 176.00288ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:53.128202Z","caller":"traceutil/trace.go:171","msg":"trace[789753518] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"166.337608ms","start":"2026-04-22T21:35:52.961574Z","end":"2026-04-22T21:35:53.127911Z","steps":["trace[789753518] 'process raft request' (duration: 166.080613ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:54.585772Z","caller":"traceutil/trace.go:171","msg":"trace[881375927] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"185.316678ms","start":"2026-04-22T21:35:54.400419Z","end":"2026-04-22T21:35:54.585735Z","steps":["trace[881375927] 'process raft request' (duration: 185.125274ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:35:54.704531Z","caller":"traceutil/trace.go:171","msg":"trace[2041859579] linearizableReadLoop","detail":"{readStateIndex:26715; appliedIndex:26713; }","duration":"297.297271ms","start":"2026-04-22T21:35:54.407208Z","end":"2026-04-22T21:35:54.704505Z","steps":["trace[2041859579] 'read index received' (duration: 178.43703ms)","trace[2041859579] 'applied index is now lower than readState.Index' (duration: 118.859381ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:35:54.704658Z","caller":"traceutil/trace.go:171","msg":"trace[1247937208] transaction","detail":"{read_only:false; response_revision:25865; number_of_response:1; }","duration":"300.444704ms","start":"2026-04-22T21:35:54.404197Z","end":"2026-04-22T21:35:54.704642Z","steps":["trace[1247937208] 'process raft request' (duration: 232.04243ms)","trace[1247937208] 'compare' (duration: 68.072577ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:35:54.704908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.277379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-22T21:35:54.704971Z","caller":"traceutil/trace.go:171","msg":"trace[962222416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25865; }","duration":"119.397331ms","start":"2026-04-22T21:35:54.585564Z","end":"2026-04-22T21:35:54.704961Z","steps":["trace[962222416] 'agreement among raft nodes before linearized reading' (duration: 119.236668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:54.704971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:35:54.404166Z","time spent":"300.644528ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:35:54.704905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.980162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:54.705212Z","caller":"traceutil/trace.go:171","msg":"trace[599657516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25865; }","duration":"138.3562ms","start":"2026-04-22T21:35:54.566848Z","end":"2026-04-22T21:35:54.705204Z","steps":["trace[599657516] 'agreement among raft nodes before linearized reading' (duration: 137.994963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:54.704818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.565346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:35:54.705371Z","caller":"traceutil/trace.go:171","msg":"trace[961640019] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:25865; }","duration":"298.2734ms","start":"2026-04-22T21:35:54.407089Z","end":"2026-04-22T21:35:54.705362Z","steps":["trace[961640019] 'agreement among raft nodes before linearized reading' (duration: 297.581176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:35:54.705926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.926324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-04-22T21:35:54.705997Z","caller":"traceutil/trace.go:171","msg":"trace[247674128] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:25865; }","duration":"290.041097ms","start":"2026-04-22T21:35:54.415937Z","end":"2026-04-22T21:35:54.705978Z","steps":["trace[247674128] 'agreement among raft nodes before linearized reading' (duration: 288.806032ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:15.766419Z","caller":"traceutil/trace.go:171","msg":"trace[796453405] transaction","detail":"{read_only:false; response_revision:26033; number_of_response:1; }","duration":"140.163637ms","start":"2026-04-22T21:36:15.626141Z","end":"2026-04-22T21:36:15.766305Z","steps":["trace[796453405] 'process raft request' (duration: 139.972083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T21:36:15.944634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.609077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T21:36:15.944845Z","caller":"traceutil/trace.go:171","msg":"trace[677974976] linearizableReadLoop","detail":"{readStateIndex:26889; appliedIndex:26887; }","duration":"188.256676ms","start":"2026-04-22T21:36:15.756564Z","end":"2026-04-22T21:36:15.944821Z","steps":["trace[677974976] 'read index received' (duration: 9.649382ms)","trace[677974976] 'applied index is now lower than readState.Index' (duration: 178.606204ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:36:15.94494Z","caller":"traceutil/trace.go:171","msg":"trace[71019446] transaction","detail":"{read_only:false; response_revision:26034; number_of_response:1; }","duration":"305.035206ms","start":"2026-04-22T21:36:15.63989Z","end":"2026-04-22T21:36:15.944925Z","steps":["trace[71019446] 'process raft request' (duration: 198.043211ms)","trace[71019446] 'compare' (duration: 106.443284ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T21:36:15.945005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T21:36:15.63986Z","time spent":"305.113608ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T21:36:15.945221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.642443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T21:36:15.945313Z","caller":"traceutil/trace.go:171","msg":"trace[1207709307] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:26035; }","duration":"188.781306ms","start":"2026-04-22T21:36:15.756507Z","end":"2026-04-22T21:36:15.945288Z","steps":["trace[1207709307] 'agreement among raft nodes before linearized reading' (duration: 188.444239ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.017563Z","caller":"traceutil/trace.go:171","msg":"trace[587874708] transaction","detail":"{read_only:false; response_revision:26036; number_of_response:1; }","duration":"131.958832ms","start":"2026-04-22T21:36:15.885583Z","end":"2026-04-22T21:36:16.017542Z","steps":["trace[587874708] 'process raft request' (duration: 131.784659ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.017945Z","caller":"traceutil/trace.go:171","msg":"trace[1262834958] transaction","detail":"{read_only:false; response_revision:26038; number_of_response:1; }","duration":"127.932312ms","start":"2026-04-22T21:36:15.89Z","end":"2026-04-22T21:36:16.017933Z","steps":["trace[1262834958] 'process raft request' (duration: 127.695897ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.018023Z","caller":"traceutil/trace.go:171","msg":"trace[1610248913] transaction","detail":"{read_only:false; response_revision:26039; number_of_response:1; }","duration":"123.166807ms","start":"2026-04-22T21:36:15.894824Z","end":"2026-04-22T21:36:16.01799Z","steps":["trace[1610248913] 'process raft request' (duration: 122.950003ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.018089Z","caller":"traceutil/trace.go:171","msg":"trace[502388087] transaction","detail":"{read_only:false; response_revision:26037; number_of_response:1; }","duration":"129.587665ms","start":"2026-04-22T21:36:15.888483Z","end":"2026-04-22T21:36:16.01807Z","steps":["trace[502388087] 'process raft request' (duration: 129.004873ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.132044Z","caller":"traceutil/trace.go:171","msg":"trace[7366882] transaction","detail":"{read_only:false; response_revision:26041; number_of_response:1; }","duration":"107.897903ms","start":"2026-04-22T21:36:16.024129Z","end":"2026-04-22T21:36:16.132027Z","steps":["trace[7366882] 'process raft request' (duration: 107.854422ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T21:36:16.132149Z","caller":"traceutil/trace.go:171","msg":"trace[188286299] transaction","detail":"{read_only:false; response_revision:26040; number_of_response:1; }","duration":"144.019203ms","start":"2026-04-22T21:36:15.988085Z","end":"2026-04-22T21:36:16.132104Z","steps":["trace[188286299] 'process raft request' (duration: 73.016847ms)","trace[188286299] 'compare' (duration: 70.771382ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T21:37:02.627463Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b2c.wal"} {"level":"info","ts":"2026-04-22T21:40:11.380935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25485} {"level":"info","ts":"2026-04-22T21:40:11.532853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25485,"took":"146.564585ms","hash":1583785194,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":36192256,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-04-22T21:40:11.532925Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1583785194,"revision":25485,"compact-revision":22029} {"level":"info","ts":"2026-04-22T21:41:35.0343Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T21:41:35.040649Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-04-22T21:41:35.040745Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-04-22T21:45:11.388831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28454} {"level":"info","ts":"2026-04-22T21:45:11.560623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28454,"took":"167.137267ms","hash":410094528,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":30928896,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T21:45:11.560841Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":410094528,"revision":28454,"compact-revision":25485} {"level":"info","ts":"2026-04-22T21:50:11.39645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30678} {"level":"info","ts":"2026-04-22T21:50:11.518696Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30678,"took":"117.181736ms","hash":1799134326,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":31158272,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T21:50:11.518798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1799134326,"revision":30678,"compact-revision":28454} {"level":"info","ts":"2026-04-22T21:55:11.403112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32959} {"level":"info","ts":"2026-04-22T21:55:11.550049Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32959,"took":"141.629095ms","hash":3250444630,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":31416320,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T21:55:11.550137Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3250444630,"revision":32959,"compact-revision":30678} {"level":"info","ts":"2026-04-22T22:00:11.409577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35255} {"level":"info","ts":"2026-04-22T22:00:11.557622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35255,"took":"141.234076ms","hash":721545207,"current-db-size-bytes":59445248,"current-db-size":"59 MB","current-db-size-in-use-bytes":31592448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T22:00:11.557705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":721545207,"revision":35255,"compact-revision":32959} {"level":"info","ts":"2026-04-22T22:02:53.032767Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T22:02:53.038163Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-04-22T22:02:53.038302Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-04-22T22:05:11.419481Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37514} {"level":"info","ts":"2026-04-22T22:05:11.543891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37514,"took":"120.721433ms","hash":3179276420,"current-db-size-bytes":59445248,"current-db-size":"59 MB","current-db-size-in-use-bytes":33161216,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T22:05:11.543955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3179276420,"revision":37514,"compact-revision":35255}