{"level":"warn","ts":"2026-07-08T03:09:14.364755Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T03:09:14.364896Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-07-08T03:09:14.364982Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T03:09:14.364998Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-08T03:09:14.365015Z","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-07-08T03:09:14.367352Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-07-08T03:09:14.367586Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-07-08T03:09:14.370025Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.032837ms"} {"level":"info","ts":"2026-07-08T03:09:14.37481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-07-08T03:09:14.374901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T03:09:14.374933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-07-08T03:09:14.37496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T03:09:14.37498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-07-08T03:09:14.375045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-07-08T03:09:14.385333Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T03:09:14.388554Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T03:09:14.390513Z","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-07-08T03:09:14.394726Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T03:09:14.395071Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T03:09:14.395062Z","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-07-08T03:09:14.395188Z","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-07-08T03:09:14.395211Z","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-07-08T03:09:14.396063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-07-08T03:09:14.396328Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-08T03:09:14.398234Z","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-07-08T03:09:14.398396Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-08T03:09:14.398447Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-08T03:09:14.398519Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T03:09:14.398557Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T03:09:14.976036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T03:09:14.976102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T03:09:14.976127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-07-08T03:09:14.976147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-07-08T03:09:14.976158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-08T03:09:14.976184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-07-08T03:09:14.976236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-08T03:09:14.977659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T03:09:14.977727Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T03:09:14.977818Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T03:09:14.977919Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T03:09:14.977703Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T03:09:14.977994Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T03:09:14.978876Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T03:09:14.979134Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T03:09:14.979174Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T03:09:14.981076Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T03:09:14.981829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-07-08T03:09:30.771109Z","caller":"traceutil/trace.go:171","msg":"trace[807367079] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"255.028273ms","start":"2026-07-08T03:09:30.516052Z","end":"2026-07-08T03:09:30.77108Z","steps":["trace[807367079] 'process raft request' (duration: 254.865659ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:09:30.907347Z","caller":"traceutil/trace.go:171","msg":"trace[1727343127] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"115.842671ms","start":"2026-07-08T03:09:30.791482Z","end":"2026-07-08T03:09:30.907325Z","steps":["trace[1727343127] 'process raft request' (duration: 115.703618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:09:55.268408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.116609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:09:55.268757Z","caller":"traceutil/trace.go:171","msg":"trace[1730358328] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"226.613263ms","start":"2026-07-08T03:09:55.042103Z","end":"2026-07-08T03:09:55.268717Z","steps":["trace[1730358328] 'process raft request' (duration: 31.376323ms)","trace[1730358328] 'compare' (duration: 193.919014ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:09:55.382924Z","caller":"traceutil/trace.go:171","msg":"trace[1498125428] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"108.523289ms","start":"2026-07-08T03:09:55.274366Z","end":"2026-07-08T03:09:55.382889Z","steps":["trace[1498125428] 'process raft request' (duration: 99.661362ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:09:59.091953Z","caller":"traceutil/trace.go:171","msg":"trace[1134371117] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"129.878493ms","start":"2026-07-08T03:09:58.962023Z","end":"2026-07-08T03:09:59.091901Z","steps":["trace[1134371117] 'process raft request' (duration: 124.227065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:09:59.592443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.32059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:09:59.592589Z","caller":"traceutil/trace.go:171","msg":"trace[1428574864] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"305.424305ms","start":"2026-07-08T03:09:59.287139Z","end":"2026-07-08T03:09:59.592564Z","steps":["trace[1428574864] 'read index received' (duration: 140.92421ms)","trace[1428574864] 'applied index is now lower than readState.Index' (duration: 164.497935ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:09:59.592712Z","caller":"traceutil/trace.go:171","msg":"trace[1134834655] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"440.437181ms","start":"2026-07-08T03:09:59.152232Z","end":"2026-07-08T03:09:59.59267Z","steps":["trace[1134834655] 'process raft request' (duration: 275.769741ms)","trace[1134834655] 'compare' (duration: 162.713855ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:09:59.592879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.569201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T03:09:59.592869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:09:59.15221Z","time spent":"440.581814ms","remote":"127.0.0.1:38342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T03:09:59.592973Z","caller":"traceutil/trace.go:171","msg":"trace[1942965170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"231.718295ms","start":"2026-07-08T03:09:59.361232Z","end":"2026-07-08T03:09:59.592951Z","steps":["trace[1942965170] 'agreement among raft nodes before linearized reading' (duration: 231.55731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:09:59.592974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.817915ms","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-07-08T03:09:59.593025Z","caller":"traceutil/trace.go:171","msg":"trace[863073787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"305.926479ms","start":"2026-07-08T03:09:59.287084Z","end":"2026-07-08T03:09:59.593011Z","steps":["trace[863073787] 'agreement among raft nodes before linearized reading' (duration: 305.623971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:09:59.593031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.521006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T03:09:59.593081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:09:59.287058Z","time spent":"306.012951ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T03:09:59.593092Z","caller":"traceutil/trace.go:171","msg":"trace[154937452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"196.626509ms","start":"2026-07-08T03:09:59.396448Z","end":"2026-07-08T03:09:59.593074Z","steps":["trace[154937452] 'agreement among raft nodes before linearized reading' (duration: 196.409763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:11:28.184356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.710006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T03:11:28.184435Z","caller":"traceutil/trace.go:171","msg":"trace[805444488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1852; }","duration":"113.850761ms","start":"2026-07-08T03:11:28.070567Z","end":"2026-07-08T03:11:28.184418Z","steps":["trace[805444488] 'range keys from in-memory index tree' (duration: 113.47111ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:11:28.184504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.156811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T03:11:28.184618Z","caller":"traceutil/trace.go:171","msg":"trace[1941659856] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1852; }","duration":"113.342637ms","start":"2026-07-08T03:11:28.071252Z","end":"2026-07-08T03:11:28.184595Z","steps":["trace[1941659856] 'range keys from in-memory index tree' (duration: 112.921285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:11:28.18451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.98011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f0c5669-57e8-454c-b2f6-3404c83f8b0d\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-08T03:11:28.184702Z","caller":"traceutil/trace.go:171","msg":"trace[799877658] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0f0c5669-57e8-454c-b2f6-3404c83f8b0d; range_end:; response_count:1; response_revision:1852; }","duration":"300.210687ms","start":"2026-07-08T03:11:27.884466Z","end":"2026-07-08T03:11:28.184676Z","steps":["trace[799877658] 'range keys from in-memory index tree' (duration: 299.794205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:11:28.184757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:11:27.884445Z","time spent":"300.299979ms","remote":"127.0.0.1:38312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f0c5669-57e8-454c-b2f6-3404c83f8b0d\" "} {"level":"warn","ts":"2026-07-08T03:11:28.184435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.173775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-08T03:11:28.184869Z","caller":"traceutil/trace.go:171","msg":"trace[109737310] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1852; }","duration":"281.655989ms","start":"2026-07-08T03:11:27.903188Z","end":"2026-07-08T03:11:28.184844Z","steps":["trace[109737310] 'range keys from in-memory index tree' (duration: 280.888797ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.409702Z","caller":"traceutil/trace.go:171","msg":"trace[1341320178] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"221.615341ms","start":"2026-07-08T03:11:28.188046Z","end":"2026-07-08T03:11:28.409661Z","steps":["trace[1341320178] 'process raft request' (duration: 221.363564ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.409722Z","caller":"traceutil/trace.go:171","msg":"trace[342774553] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1926; }","duration":"184.095303ms","start":"2026-07-08T03:11:28.225598Z","end":"2026-07-08T03:11:28.409693Z","steps":["trace[342774553] 'read index received' (duration: 188.565µs)","trace[342774553] 'applied index is now lower than readState.Index' (duration: 183.905508ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:11:28.409894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.275527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:11:28.40995Z","caller":"traceutil/trace.go:171","msg":"trace[1948871258] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1856; }","duration":"184.388361ms","start":"2026-07-08T03:11:28.225546Z","end":"2026-07-08T03:11:28.409935Z","steps":["trace[1948871258] 'agreement among raft nodes before linearized reading' (duration: 184.234476ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.409966Z","caller":"traceutil/trace.go:171","msg":"trace[1909215122] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"221.832186ms","start":"2026-07-08T03:11:28.188098Z","end":"2026-07-08T03:11:28.40993Z","steps":["trace[1909215122] 'process raft request' (duration: 221.435045ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.409997Z","caller":"traceutil/trace.go:171","msg":"trace[846233489] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"218.454363ms","start":"2026-07-08T03:11:28.19152Z","end":"2026-07-08T03:11:28.409974Z","steps":["trace[846233489] 'process raft request' (duration: 218.066802ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.432389Z","caller":"traceutil/trace.go:171","msg":"trace[366732203] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"148.165798ms","start":"2026-07-08T03:11:28.284206Z","end":"2026-07-08T03:11:28.432372Z","steps":["trace[366732203] 'process raft request' (duration: 148.075436ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.584922Z","caller":"traceutil/trace.go:171","msg":"trace[2139026851] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"151.182784ms","start":"2026-07-08T03:11:28.433713Z","end":"2026-07-08T03:11:28.584896Z","steps":["trace[2139026851] 'read index received' (duration: 130.446664ms)","trace[2139026851] 'applied index is now lower than readState.Index' (duration: 20.734899ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:11:28.585009Z","caller":"traceutil/trace.go:171","msg":"trace[1925544630] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"173.793975ms","start":"2026-07-08T03:11:28.411162Z","end":"2026-07-08T03:11:28.584956Z","steps":["trace[1925544630] 'process raft request' (duration: 152.982434ms)","trace[1925544630] 'compare' (duration: 20.632016ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:11:28.585216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.40312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:11:28.585425Z","caller":"traceutil/trace.go:171","msg":"trace[1555478181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1858; }","duration":"151.653397ms","start":"2026-07-08T03:11:28.433686Z","end":"2026-07-08T03:11:28.585339Z","steps":["trace[1555478181] 'agreement among raft nodes before linearized reading' (duration: 151.304097ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.616266Z","caller":"traceutil/trace.go:171","msg":"trace[1161672225] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"178.518787ms","start":"2026-07-08T03:11:28.437716Z","end":"2026-07-08T03:11:28.616235Z","steps":["trace[1161672225] 'process raft request' (duration: 178.315321ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:11:28.616434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.12066ms","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-07-08T03:11:28.616432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.793413ms","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-07-08T03:11:28.616514Z","caller":"traceutil/trace.go:171","msg":"trace[1826367291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1859; }","duration":"176.210052ms","start":"2026-07-08T03:11:28.440286Z","end":"2026-07-08T03:11:28.616496Z","steps":["trace[1826367291] 'agreement among raft nodes before linearized reading' (duration: 176.004887ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:28.616574Z","caller":"traceutil/trace.go:171","msg":"trace[259609865] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"175.02007ms","start":"2026-07-08T03:11:28.441525Z","end":"2026-07-08T03:11:28.616545Z","steps":["trace[259609865] 'agreement among raft nodes before linearized reading' (duration: 174.626649ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:13:12.977546Z","caller":"traceutil/trace.go:171","msg":"trace[1918590290] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"110.424592ms","start":"2026-07-08T03:13:12.867094Z","end":"2026-07-08T03:13:12.977519Z","steps":["trace[1918590290] 'process raft request' (duration: 110.191656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:13:41.47365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.26806ms","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-07-08T03:13:41.473744Z","caller":"traceutil/trace.go:171","msg":"trace[2072449521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2822; }","duration":"168.431836ms","start":"2026-07-08T03:13:41.305294Z","end":"2026-07-08T03:13:41.473726Z","steps":["trace[2072449521] 'range keys from in-memory index tree' (duration: 168.058565ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:13:41.47373Z","caller":"traceutil/trace.go:171","msg":"trace[152444398] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"143.930251ms","start":"2026-07-08T03:13:41.329773Z","end":"2026-07-08T03:13:41.473703Z","steps":["trace[152444398] 'process raft request' (duration: 54.505233ms)","trace[152444398] 'compare' (duration: 89.221952ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:13:41.711621Z","caller":"traceutil/trace.go:171","msg":"trace[47438950] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"139.768434ms","start":"2026-07-08T03:13:41.571817Z","end":"2026-07-08T03:13:41.711585Z","steps":["trace[47438950] 'process raft request' (duration: 139.531098ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:17:39.395313Z","caller":"traceutil/trace.go:171","msg":"trace[729362172] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"123.313802ms","start":"2026-07-08T03:17:39.271951Z","end":"2026-07-08T03:17:39.395265Z","steps":["trace[729362172] 'process raft request' (duration: 123.090816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:17:44.674602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.938566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:17:44.674806Z","caller":"traceutil/trace.go:171","msg":"trace[1240622309] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"209.816145ms","start":"2026-07-08T03:17:44.464936Z","end":"2026-07-08T03:17:44.674752Z","steps":["trace[1240622309] 'process raft request' (duration: 74.637883ms)","trace[1240622309] 'compare' (duration: 134.823073ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:17:44.674835Z","caller":"traceutil/trace.go:171","msg":"trace[588007175] linearizableReadLoop","detail":"{readStateIndex:5231; appliedIndex:5230; }","duration":"185.165648ms","start":"2026-07-08T03:17:44.489625Z","end":"2026-07-08T03:17:44.674791Z","steps":["trace[588007175] 'read index received' (duration: 49.916853ms)","trace[588007175] 'applied index is now lower than readState.Index' (duration: 135.245734ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:17:44.675038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.404955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-07256b97-7d35-4d0d-82b4-dd92c151736e\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-07-08T03:17:44.675088Z","caller":"traceutil/trace.go:171","msg":"trace[1374308499] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-07256b97-7d35-4d0d-82b4-dd92c151736e; range_end:; response_count:1; response_revision:5040; }","duration":"185.508507ms","start":"2026-07-08T03:17:44.489567Z","end":"2026-07-08T03:17:44.675075Z","steps":["trace[1374308499] 'agreement among raft nodes before linearized reading' (duration: 185.331123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:17:44.67543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.085644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-07-08T03:17:44.675553Z","caller":"traceutil/trace.go:171","msg":"trace[1200815660] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5040; }","duration":"181.242348ms","start":"2026-07-08T03:17:44.494278Z","end":"2026-07-08T03:17:44.67552Z","steps":["trace[1200815660] 'agreement among raft nodes before linearized reading' (duration: 180.878468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:17:44.675432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.725924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-08T03:17:44.67562Z","caller":"traceutil/trace.go:171","msg":"trace[517425823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5040; }","duration":"103.982502ms","start":"2026-07-08T03:17:44.57162Z","end":"2026-07-08T03:17:44.675603Z","steps":["trace[517425823] 'agreement among raft nodes before linearized reading' (duration: 103.55519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:17:44.675669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.179453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786829"} {"level":"info","ts":"2026-07-08T03:17:44.675749Z","caller":"traceutil/trace.go:171","msg":"trace[1321829057] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5040; }","duration":"135.296956ms","start":"2026-07-08T03:17:44.540434Z","end":"2026-07-08T03:17:44.675731Z","steps":["trace[1321829057] 'agreement among raft nodes before linearized reading' (duration: 134.765461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:17:58.1279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.691766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-08T03:17:58.127982Z","caller":"traceutil/trace.go:171","msg":"trace[1177364520] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:5300; }","duration":"207.83132ms","start":"2026-07-08T03:17:57.920134Z","end":"2026-07-08T03:17:58.127966Z","steps":["trace[1177364520] 'range keys from in-memory index tree' (duration: 207.518951ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:17:58.288666Z","caller":"traceutil/trace.go:171","msg":"trace[1720432765] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"108.297733ms","start":"2026-07-08T03:17:58.180343Z","end":"2026-07-08T03:17:58.288641Z","steps":["trace[1720432765] 'process raft request' (duration: 108.139538ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:18:05.748584Z","caller":"traceutil/trace.go:171","msg":"trace[1759340949] linearizableReadLoop","detail":"{readStateIndex:5668; appliedIndex:5667; }","duration":"133.324571ms","start":"2026-07-08T03:18:05.615234Z","end":"2026-07-08T03:18:05.748558Z","steps":["trace[1759340949] 'read index received' (duration: 133.28057ms)","trace[1759340949] 'applied index is now lower than readState.Index' (duration: 42.611µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:18:05.748693Z","caller":"traceutil/trace.go:171","msg":"trace[848706535] transaction","detail":"{read_only:false; response_revision:5463; number_of_response:1; }","duration":"136.796518ms","start":"2026-07-08T03:18:05.611858Z","end":"2026-07-08T03:18:05.748654Z","steps":["trace[848706535] 'process raft request' (duration: 136.554631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:18:05.748902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.64563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80035"} {"level":"info","ts":"2026-07-08T03:18:05.748951Z","caller":"traceutil/trace.go:171","msg":"trace[657158344] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5463; }","duration":"133.747643ms","start":"2026-07-08T03:18:05.615192Z","end":"2026-07-08T03:18:05.748939Z","steps":["trace[657158344] 'agreement among raft nodes before linearized reading' (duration: 133.473895ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:19:15.00593Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006} {"level":"info","ts":"2026-07-08T03:19:15.0896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"82.143442ms","hash":471051826,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":32030720,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T03:19:15.089676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":471051826,"revision":3006,"compact-revision":-1} {"level":"info","ts":"2026-07-08T03:24:15.017229Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6103} {"level":"info","ts":"2026-07-08T03:24:15.124778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6103,"took":"104.65154ms","hash":3390481525,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":23535616,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-07-08T03:24:15.124873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3390481525,"revision":6103,"compact-revision":3006} {"level":"warn","ts":"2026-07-08T03:24:18.428079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.189443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:24:18.428387Z","caller":"traceutil/trace.go:171","msg":"trace[1522845471] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"215.249396ms","start":"2026-07-08T03:24:18.212963Z","end":"2026-07-08T03:24:18.428212Z","steps":["trace[1522845471] 'process raft request' (duration: 56.811236ms)","trace[1522845471] 'compare' (duration: 157.941486ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:24:29.923912Z","caller":"traceutil/trace.go:171","msg":"trace[1032872194] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"122.112256ms","start":"2026-07-08T03:24:29.801768Z","end":"2026-07-08T03:24:29.92388Z","steps":["trace[1032872194] 'process raft request' (duration: 40.547201ms)","trace[1032872194] 'compare' (duration: 81.420951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:24:30.164586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.357404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bq567\" ","response":"range_response_count:1 size:6441"} {"level":"info","ts":"2026-07-08T03:24:30.164695Z","caller":"traceutil/trace.go:171","msg":"trace[1158388218] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bq567; range_end:; response_count:1; response_revision:8375; }","duration":"103.534148ms","start":"2026-07-08T03:24:30.061136Z","end":"2026-07-08T03:24:30.16467Z","steps":["trace[1158388218] 'range keys from in-memory index tree' (duration: 103.101686ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:25:02.295395Z","caller":"traceutil/trace.go:171","msg":"trace[777122694] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"240.619453ms","start":"2026-07-08T03:25:02.054713Z","end":"2026-07-08T03:25:02.295333Z","steps":["trace[777122694] 'process raft request' (duration: 193.506388ms)","trace[777122694] 'compare' (duration: 46.632211ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:25:05.15119Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022de.wal"} {"level":"info","ts":"2026-07-08T03:25:11.263197Z","caller":"traceutil/trace.go:171","msg":"trace[723476881] linearizableReadLoop","detail":"{readStateIndex:9000; appliedIndex:9000; }","duration":"213.588759ms","start":"2026-07-08T03:25:11.049572Z","end":"2026-07-08T03:25:11.263161Z","steps":["trace[723476881] 'read index received' (duration: 213.572689ms)","trace[723476881] 'applied index is now lower than readState.Index' (duration: 12.69µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:25:11.263529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.931619ms","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-07-08T03:25:11.26362Z","caller":"traceutil/trace.go:171","msg":"trace[443652691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8689; }","duration":"214.058943ms","start":"2026-07-08T03:25:11.049541Z","end":"2026-07-08T03:25:11.2636Z","steps":["trace[443652691] 'agreement among raft nodes before linearized reading' (duration: 213.757014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:25:11.263651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.165224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T03:25:11.263727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.092905ms","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-07-08T03:25:11.263777Z","caller":"traceutil/trace.go:171","msg":"trace[360131947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8689; }","duration":"105.337329ms","start":"2026-07-08T03:25:11.158417Z","end":"2026-07-08T03:25:11.263755Z","steps":["trace[360131947] 'agreement among raft nodes before linearized reading' (duration: 105.062431ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:25:11.263851Z","caller":"traceutil/trace.go:171","msg":"trace[1748627475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8689; }","duration":"142.27514ms","start":"2026-07-08T03:25:11.121551Z","end":"2026-07-08T03:25:11.263826Z","steps":["trace[1748627475] 'agreement among raft nodes before linearized reading' (duration: 141.871769ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:25:11.263121Z","caller":"traceutil/trace.go:171","msg":"trace[220191555] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"237.493536ms","start":"2026-07-08T03:25:11.025593Z","end":"2026-07-08T03:25:11.263086Z","steps":["trace[220191555] 'process raft request' (duration: 237.287011ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:25:11.839052Z","caller":"traceutil/trace.go:171","msg":"trace[1229165943] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"163.926134ms","start":"2026-07-08T03:25:11.675099Z","end":"2026-07-08T03:25:11.839025Z","steps":["trace[1229165943] 'process raft request' (duration: 163.753269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:26:30.605523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.543786ms","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:5"} {"level":"info","ts":"2026-07-08T03:26:30.605634Z","caller":"traceutil/trace.go:171","msg":"trace[2114593737] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:9456; }","duration":"209.713301ms","start":"2026-07-08T03:26:30.395898Z","end":"2026-07-08T03:26:30.605611Z","steps":["trace[2114593737] 'count revisions from in-memory index tree' (duration: 209.36112ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:26:58.745894Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T03:26:58.753689Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-08T03:26:58.753805Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-08T03:29:15.023913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8297} {"level":"info","ts":"2026-07-08T03:29:15.104712Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8297,"took":"78.342565ms","hash":3867303517,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":25210880,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-07-08T03:29:15.104805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3867303517,"revision":8297,"compact-revision":6103} {"level":"info","ts":"2026-07-08T03:31:49.621913Z","caller":"traceutil/trace.go:171","msg":"trace[653907509] transaction","detail":"{read_only:false; response_revision:11775; number_of_response:1; }","duration":"103.741002ms","start":"2026-07-08T03:31:49.51813Z","end":"2026-07-08T03:31:49.621871Z","steps":["trace[653907509] 'process raft request' (duration: 103.451524ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:32:12.501812Z","caller":"traceutil/trace.go:171","msg":"trace[1934972016] transaction","detail":"{read_only:false; response_revision:11903; number_of_response:1; }","duration":"110.383257ms","start":"2026-07-08T03:32:12.391399Z","end":"2026-07-08T03:32:12.501782Z","steps":["trace[1934972016] 'process raft request' (duration: 109.784291ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:32:12.648208Z","caller":"traceutil/trace.go:171","msg":"trace[278453575] transaction","detail":"{read_only:false; response_revision:11904; number_of_response:1; }","duration":"141.988138ms","start":"2026-07-08T03:32:12.506178Z","end":"2026-07-08T03:32:12.648166Z","steps":["trace[278453575] 'process raft request' (duration: 59.54967ms)","trace[278453575] 'compare' (duration: 82.215542ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:32:13.332933Z","caller":"traceutil/trace.go:171","msg":"trace[1726707688] transaction","detail":"{read_only:false; response_revision:11906; number_of_response:1; }","duration":"105.758558ms","start":"2026-07-08T03:32:13.22714Z","end":"2026-07-08T03:32:13.332899Z","steps":["trace[1726707688] 'process raft request' (duration: 84.968139ms)","trace[1726707688] 'compare' (duration: 20.646695ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:34:15.031025Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10522} {"level":"info","ts":"2026-07-08T03:34:15.107565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10522,"took":"74.073406ms","hash":33241186,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":26226688,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-08T03:34:15.107638Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":33241186,"revision":10522,"compact-revision":8297} {"level":"info","ts":"2026-07-08T03:38:06.78343Z","caller":"traceutil/trace.go:171","msg":"trace[1939606730] transaction","detail":"{read_only:false; response_revision:14319; number_of_response:1; }","duration":"134.05282ms","start":"2026-07-08T03:38:06.649346Z","end":"2026-07-08T03:38:06.783399Z","steps":["trace[1939606730] 'process raft request' (duration: 42.325418ms)","trace[1939606730] 'compare' (duration: 91.577257ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:38:32.863322Z","caller":"traceutil/trace.go:171","msg":"trace[78098722] transaction","detail":"{read_only:false; response_revision:14456; number_of_response:1; }","duration":"167.610003ms","start":"2026-07-08T03:38:32.695686Z","end":"2026-07-08T03:38:32.863296Z","steps":["trace[78098722] 'process raft request' (duration: 150.316122ms)","trace[78098722] 'compare' (duration: 16.929771ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:38:48.245608Z","caller":"traceutil/trace.go:171","msg":"trace[1792026269] transaction","detail":"{read_only:false; response_revision:14532; number_of_response:1; }","duration":"442.11535ms","start":"2026-07-08T03:38:47.803471Z","end":"2026-07-08T03:38:48.245587Z","steps":["trace[1792026269] 'process raft request' (duration: 441.991026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:38:48.245754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:47.80345Z","time spent":"442.226702ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:38:48.245788Z","caller":"traceutil/trace.go:171","msg":"trace[709325330] linearizableReadLoop","detail":"{readStateIndex:15038; appliedIndex:15038; }","duration":"395.862933ms","start":"2026-07-08T03:38:47.849907Z","end":"2026-07-08T03:38:48.24577Z","steps":["trace[709325330] 'read index received' (duration: 395.851302ms)","trace[709325330] 'applied index is now lower than readState.Index' (duration: 9.611µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:38:48.245972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.058228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-08T03:38:48.246008Z","caller":"traceutil/trace.go:171","msg":"trace[2062271936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14532; }","duration":"396.11586ms","start":"2026-07-08T03:38:47.849879Z","end":"2026-07-08T03:38:48.245995Z","steps":["trace[2062271936] 'agreement among raft nodes before linearized reading' (duration: 395.971566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:38:48.246046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:47.849866Z","time spent":"396.172611ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T03:38:48.27606Z","caller":"traceutil/trace.go:171","msg":"trace[42090798] transaction","detail":"{read_only:false; response_revision:14533; number_of_response:1; }","duration":"301.370864ms","start":"2026-07-08T03:38:47.974669Z","end":"2026-07-08T03:38:48.27604Z","steps":["trace[42090798] 'process raft request' (duration: 285.090901ms)","trace[42090798] 'compare' (duration: 16.129789ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:38:48.276159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:47.974652Z","time spent":"301.457747ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:38:48.276537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.015695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-08T03:38:48.276549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.781874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-08T03:38:48.276519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.163536ms","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-07-08T03:38:48.276588Z","caller":"traceutil/trace.go:171","msg":"trace[1915216218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14534; }","duration":"421.842516ms","start":"2026-07-08T03:38:47.854734Z","end":"2026-07-08T03:38:48.276576Z","steps":["trace[1915216218] 'agreement among raft nodes before linearized reading' (duration: 421.328621ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:38:48.276592Z","caller":"traceutil/trace.go:171","msg":"trace[956997614] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:14534; }","duration":"291.089188ms","start":"2026-07-08T03:38:47.985487Z","end":"2026-07-08T03:38:48.276576Z","steps":["trace[956997614] 'agreement among raft nodes before linearized reading' (duration: 290.558933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:38:48.276617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:47.854723Z","time spent":"421.886917ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T03:38:48.276612Z","caller":"traceutil/trace.go:171","msg":"trace[444130827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14534; }","duration":"426.276399ms","start":"2026-07-08T03:38:47.850316Z","end":"2026-07-08T03:38:48.276592Z","steps":["trace[444130827] 'agreement among raft nodes before linearized reading' (duration: 425.760535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:38:48.276659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:47.850291Z","time spent":"426.358811ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T03:38:59.70564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.591605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:38:59.705854Z","caller":"traceutil/trace.go:171","msg":"trace[581287026] linearizableReadLoop","detail":"{readStateIndex:15241; appliedIndex:15239; }","duration":"110.05281ms","start":"2026-07-08T03:38:59.595789Z","end":"2026-07-08T03:38:59.705842Z","steps":["trace[581287026] 'read index received' (duration: 101.250245ms)","trace[581287026] 'applied index is now lower than readState.Index' (duration: 8.801635ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:38:59.705928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.146383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:38:59.70595Z","caller":"traceutil/trace.go:171","msg":"trace[1196627226] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:14730; }","duration":"110.204625ms","start":"2026-07-08T03:38:59.595736Z","end":"2026-07-08T03:38:59.705941Z","steps":["trace[1196627226] 'agreement among raft nodes before linearized reading' (duration: 110.140263ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:38:59.70601Z","caller":"traceutil/trace.go:171","msg":"trace[483938780] transaction","detail":"{read_only:false; response_revision:14730; number_of_response:1; }","duration":"219.948238ms","start":"2026-07-08T03:38:59.486026Z","end":"2026-07-08T03:38:59.705974Z","steps":["trace[483938780] 'process raft request' (duration: 219.736202ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:38:59.706107Z","caller":"traceutil/trace.go:171","msg":"trace[675609649] transaction","detail":"{read_only:false; response_revision:14729; number_of_response:1; }","duration":"406.162578ms","start":"2026-07-08T03:38:59.299919Z","end":"2026-07-08T03:38:59.706082Z","steps":["trace[675609649] 'process raft request' (duration: 107.056228ms)","trace[675609649] 'compare' (duration: 298.449681ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:38:59.706243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:38:59.299896Z","time spent":"406.278431ms","remote":"127.0.0.1:38312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3711,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:39:15.037954Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12742} {"level":"info","ts":"2026-07-08T03:39:15.1133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12742,"took":"72.088185ms","hash":11803822,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":29220864,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-08T03:39:15.113368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":11803822,"revision":12742,"compact-revision":10522} {"level":"info","ts":"2026-07-08T03:40:04.528309Z","caller":"traceutil/trace.go:171","msg":"trace[677630748] transaction","detail":"{read_only:false; response_revision:15623; number_of_response:1; }","duration":"106.696811ms","start":"2026-07-08T03:40:04.421581Z","end":"2026-07-08T03:40:04.528278Z","steps":["trace[677630748] 'process raft request' (duration: 106.403243ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:40:22.921393Z","caller":"traceutil/trace.go:171","msg":"trace[794251100] transaction","detail":"{read_only:false; response_revision:15730; number_of_response:1; }","duration":"117.641326ms","start":"2026-07-08T03:40:22.803704Z","end":"2026-07-08T03:40:22.921346Z","steps":["trace[794251100] 'process raft request' (duration: 116.780392ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:40:29.375589Z","caller":"traceutil/trace.go:171","msg":"trace[1003443326] transaction","detail":"{read_only:false; response_revision:15763; number_of_response:1; }","duration":"111.110204ms","start":"2026-07-08T03:40:29.264455Z","end":"2026-07-08T03:40:29.375565Z","steps":["trace[1003443326] 'process raft request' (duration: 110.983331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.703834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.568811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:40:29.704122Z","caller":"traceutil/trace.go:171","msg":"trace[1724553088] linearizableReadLoop","detail":"{readStateIndex:16310; appliedIndex:16308; }","duration":"355.281965ms","start":"2026-07-08T03:40:29.348817Z","end":"2026-07-08T03:40:29.704099Z","steps":["trace[1724553088] 'read index received' (duration: 26.608351ms)","trace[1724553088] 'applied index is now lower than readState.Index' (duration: 328.671444ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:40:29.704144Z","caller":"traceutil/trace.go:171","msg":"trace[461743390] transaction","detail":"{read_only:false; response_revision:15764; number_of_response:1; }","duration":"396.985786ms","start":"2026-07-08T03:40:29.307121Z","end":"2026-07-08T03:40:29.704107Z","steps":["trace[461743390] 'process raft request' (duration: 216.944862ms)","trace[461743390] 'compare' (duration: 179.270773ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:40:29.704299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.398368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T03:40:29.704279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.440829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T03:40:29.70432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:40:29.307097Z","time spent":"397.122061ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:40:29.704344Z","caller":"traceutil/trace.go:171","msg":"trace[163199446] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15764; }","duration":"355.46587ms","start":"2026-07-08T03:40:29.348867Z","end":"2026-07-08T03:40:29.704333Z","steps":["trace[163199446] 'agreement among raft nodes before linearized reading' (duration: 355.367787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.502151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:40:29.704364Z","caller":"traceutil/trace.go:171","msg":"trace[1546846525] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15764; }","duration":"355.577053ms","start":"2026-07-08T03:40:29.348767Z","end":"2026-07-08T03:40:29.704344Z","steps":["trace[1546846525] 'agreement among raft nodes before linearized reading' (duration: 355.439439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:40:29.348859Z","time spent":"355.525362ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"info","ts":"2026-07-08T03:40:29.704411Z","caller":"traceutil/trace.go:171","msg":"trace[1553062658] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15764; }","duration":"197.604003ms","start":"2026-07-08T03:40:29.506785Z","end":"2026-07-08T03:40:29.704389Z","steps":["trace[1553062658] 'agreement among raft nodes before linearized reading' (duration: 197.460859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:40:29.348747Z","time spent":"355.654206ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-07-08T03:40:29.704484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.931396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-08T03:40:29.704589Z","caller":"traceutil/trace.go:171","msg":"trace[1416155715] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15764; }","duration":"192.049729ms","start":"2026-07-08T03:40:29.512517Z","end":"2026-07-08T03:40:29.704567Z","steps":["trace[1416155715] 'agreement among raft nodes before linearized reading' (duration: 191.745901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.481854ms","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-07-08T03:40:29.704641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.773647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-08T03:40:29.704673Z","caller":"traceutil/trace.go:171","msg":"trace[662295725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15764; }","duration":"279.601957ms","start":"2026-07-08T03:40:29.425063Z","end":"2026-07-08T03:40:29.704665Z","steps":["trace[662295725] 'agreement among raft nodes before linearized reading' (duration: 279.490854ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:40:29.704685Z","caller":"traceutil/trace.go:171","msg":"trace[4228834] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15764; }","duration":"193.838438ms","start":"2026-07-08T03:40:29.510833Z","end":"2026-07-08T03:40:29.704672Z","steps":["trace[4228834] 'agreement among raft nodes before linearized reading' (duration: 193.698174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.991385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:40:29.704775Z","caller":"traceutil/trace.go:171","msg":"trace[1872660570] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15764; }","duration":"198.041356ms","start":"2026-07-08T03:40:29.506728Z","end":"2026-07-08T03:40:29.704769Z","steps":["trace[1872660570] 'agreement among raft nodes before linearized reading' (duration: 198.013545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.239374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-08T03:40:29.704836Z","caller":"traceutil/trace.go:171","msg":"trace[322430939] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15764; }","duration":"355.297615ms","start":"2026-07-08T03:40:29.349528Z","end":"2026-07-08T03:40:29.704826Z","steps":["trace[322430939] 'agreement among raft nodes before linearized reading' (duration: 355.132801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.521169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-08T03:40:29.704873Z","caller":"traceutil/trace.go:171","msg":"trace[1999430243] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15764; }","duration":"198.570491ms","start":"2026-07-08T03:40:29.506298Z","end":"2026-07-08T03:40:29.704868Z","steps":["trace[1999430243] 'agreement among raft nodes before linearized reading' (duration: 198.519579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:40:29.349518Z","time spent":"355.339276ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5470,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-07-08T03:40:29.704871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.993894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-08T03:40:29.704912Z","caller":"traceutil/trace.go:171","msg":"trace[1944017053] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15764; }","duration":"198.046036ms","start":"2026-07-08T03:40:29.506854Z","end":"2026-07-08T03:40:29.7049Z","steps":["trace[1944017053] 'agreement among raft nodes before linearized reading' (duration: 197.931322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.704985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.909453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:40:29.705016Z","caller":"traceutil/trace.go:171","msg":"trace[367464681] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15764; }","duration":"355.937864ms","start":"2026-07-08T03:40:29.349069Z","end":"2026-07-08T03:40:29.705006Z","steps":["trace[367464681] 'agreement among raft nodes before linearized reading' (duration: 355.891842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:40:29.705041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:40:29.349033Z","time spent":"356.002125ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"info","ts":"2026-07-08T03:43:31.299775Z","caller":"traceutil/trace.go:171","msg":"trace[1078650517] transaction","detail":"{read_only:false; response_revision:17192; number_of_response:1; }","duration":"110.852098ms","start":"2026-07-08T03:43:31.188895Z","end":"2026-07-08T03:43:31.299747Z","steps":["trace[1078650517] 'process raft request' (duration: 110.674553ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:43:33.231206Z","caller":"traceutil/trace.go:171","msg":"trace[1272363179] transaction","detail":"{read_only:false; response_revision:17207; number_of_response:1; }","duration":"109.034817ms","start":"2026-07-08T03:43:33.122134Z","end":"2026-07-08T03:43:33.231169Z","steps":["trace[1272363179] 'process raft request' (duration: 108.644536ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:44:15.043884Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15015} {"level":"info","ts":"2026-07-08T03:44:15.202328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15015,"took":"155.368385ms","hash":2841231092,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":30687232,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-08T03:44:15.202392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2841231092,"revision":15015,"compact-revision":12742} {"level":"info","ts":"2026-07-08T03:46:22.749808Z","caller":"traceutil/trace.go:171","msg":"trace[324390168] transaction","detail":"{read_only:false; response_revision:18179; number_of_response:1; }","duration":"128.095716ms","start":"2026-07-08T03:46:22.62167Z","end":"2026-07-08T03:46:22.749765Z","steps":["trace[324390168] 'process raft request' (duration: 82.209779ms)","trace[324390168] 'compare' (duration: 45.604639ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:46:22.794097Z","caller":"traceutil/trace.go:171","msg":"trace[1449757826] transaction","detail":"{read_only:false; response_revision:18180; number_of_response:1; }","duration":"168.913832ms","start":"2026-07-08T03:46:22.625141Z","end":"2026-07-08T03:46:22.794055Z","steps":["trace[1449757826] 'process raft request' (duration: 168.308535ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:46:23.155283Z","caller":"traceutil/trace.go:171","msg":"trace[197464857] transaction","detail":"{read_only:false; response_revision:18182; number_of_response:1; }","duration":"234.157598ms","start":"2026-07-08T03:46:22.921067Z","end":"2026-07-08T03:46:23.155225Z","steps":["trace[197464857] 'process raft request' (duration: 233.975963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.711601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.372124ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-08T03:46:23.711827Z","caller":"traceutil/trace.go:171","msg":"trace[741654499] linearizableReadLoop","detail":"{readStateIndex:18811; appliedIndex:18810; }","duration":"457.998049ms","start":"2026-07-08T03:46:23.25381Z","end":"2026-07-08T03:46:23.711808Z","steps":["trace[741654499] 'read index received' (duration: 51.881µs)","trace[741654499] 'applied index is now lower than readState.Index' (duration: 457.945047ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:46:23.711945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.139393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:46:23.711979Z","caller":"traceutil/trace.go:171","msg":"trace[837640199] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:18182; }","duration":"458.222965ms","start":"2026-07-08T03:46:23.253745Z","end":"2026-07-08T03:46:23.711968Z","steps":["trace[837640199] 'agreement among raft nodes before linearized reading' (duration: 458.160673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.712069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.253722Z","time spent":"458.339009ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "} {"level":"info","ts":"2026-07-08T03:46:23.712829Z","caller":"traceutil/trace.go:171","msg":"trace[457707346] transaction","detail":"{read_only:false; response_revision:18183; number_of_response:1; }","duration":"380.685747ms","start":"2026-07-08T03:46:23.33213Z","end":"2026-07-08T03:46:23.712816Z","steps":["trace[457707346] 'process raft request' (duration: 379.580386ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.712931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.332085Z","time spent":"380.783239ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:46:23.734523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.729664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:46:23.734604Z","caller":"traceutil/trace.go:171","msg":"trace[1939196196] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:0; response_revision:18184; }","duration":"479.882639ms","start":"2026-07-08T03:46:23.254702Z","end":"2026-07-08T03:46:23.734585Z","steps":["trace[1939196196] 'agreement among raft nodes before linearized reading' (duration: 479.740505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.734707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.254664Z","time spent":"480.034023ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "} {"level":"warn","ts":"2026-07-08T03:46:23.734806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.792146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:46:23.734864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.223073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-db-sync\" ","response":"range_response_count:1 size:5434"} {"level":"info","ts":"2026-07-08T03:46:23.734889Z","caller":"traceutil/trace.go:171","msg":"trace[4381396] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:18184; }","duration":"479.92102ms","start":"2026-07-08T03:46:23.254947Z","end":"2026-07-08T03:46:23.734868Z","steps":["trace[4381396] 'agreement among raft nodes before linearized reading' (duration: 479.772825ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:46:23.734932Z","caller":"traceutil/trace.go:171","msg":"trace[293897669] range","detail":"{range_begin:/registry/jobs/openstack/neutron-db-sync; range_end:; response_count:1; response_revision:18184; }","duration":"334.335407ms","start":"2026-07-08T03:46:23.400577Z","end":"2026-07-08T03:46:23.734913Z","steps":["trace[293897669] 'agreement among raft nodes before linearized reading' (duration: 334.151512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.734973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.400554Z","time spent":"334.410768ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5456,"request content":"key:\"/registry/jobs/openstack/neutron-db-sync\" "} {"level":"warn","ts":"2026-07-08T03:46:23.734984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.009123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:46:23.735019Z","caller":"traceutil/trace.go:171","msg":"trace[2071107673] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:18184; }","duration":"475.066115ms","start":"2026-07-08T03:46:23.259943Z","end":"2026-07-08T03:46:23.735009Z","steps":["trace[2071107673] 'agreement among raft nodes before linearized reading' (duration: 475.012113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.259933Z","time spent":"475.110816ms","remote":"127.0.0.1:38464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:46:23.735088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.827615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-07-08T03:46:23.735048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.790535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-08T03:46:23.735137Z","caller":"traceutil/trace.go:171","msg":"trace[158588889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18184; }","duration":"175.916238ms","start":"2026-07-08T03:46:23.559204Z","end":"2026-07-08T03:46:23.735121Z","steps":["trace[158588889] 'agreement among raft nodes before linearized reading' (duration: 175.802865ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:46:23.735152Z","caller":"traceutil/trace.go:171","msg":"trace[1535023478] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18184; }","duration":"345.9478ms","start":"2026-07-08T03:46:23.389188Z","end":"2026-07-08T03:46:23.735135Z","steps":["trace[1535023478] 'agreement among raft nodes before linearized reading' (duration: 345.59902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.389161Z","time spent":"346.052032ms","remote":"127.0.0.1:38312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-08T03:46:23.735303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.44571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:46:23.734933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.254935Z","time spent":"479.989981ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "} {"level":"info","ts":"2026-07-08T03:46:23.735344Z","caller":"traceutil/trace.go:171","msg":"trace[1113969766] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:0; response_revision:18184; }","duration":"334.510082ms","start":"2026-07-08T03:46:23.400824Z","end":"2026-07-08T03:46:23.735334Z","steps":["trace[1113969766] 'agreement among raft nodes before linearized reading' (duration: 334.4528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.213554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"} {"level":"info","ts":"2026-07-08T03:46:23.735482Z","caller":"traceutil/trace.go:171","msg":"trace[638676423] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18184; }","duration":"269.249575ms","start":"2026-07-08T03:46:23.466224Z","end":"2026-07-08T03:46:23.735474Z","steps":["trace[638676423] 'agreement among raft nodes before linearized reading' (duration: 269.138811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.59576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-b8f99\" ","response":"range_response_count:1 size:22010"} {"level":"warn","ts":"2026-07-08T03:46:23.735485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.400801Z","time spent":"334.673396ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "} {"level":"warn","ts":"2026-07-08T03:46:23.73565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.867031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:46:23.735689Z","caller":"traceutil/trace.go:171","msg":"trace[971049268] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:18184; }","duration":"334.944193ms","start":"2026-07-08T03:46:23.400735Z","end":"2026-07-08T03:46:23.735679Z","steps":["trace[971049268] 'agreement among raft nodes before linearized reading' (duration: 334.888362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.400711Z","time spent":"335.001125ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "} {"level":"info","ts":"2026-07-08T03:46:23.735663Z","caller":"traceutil/trace.go:171","msg":"trace[82742195] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-b8f99; range_end:; response_count:1; response_revision:18184; }","duration":"382.95661ms","start":"2026-07-08T03:46:23.352643Z","end":"2026-07-08T03:46:23.7356Z","steps":["trace[82742195] 'agreement among raft nodes before linearized reading' (duration: 382.083306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.817884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-db-sync\" ","response":"range_response_count:1 size:5434"} {"level":"info","ts":"2026-07-08T03:46:23.735872Z","caller":"traceutil/trace.go:171","msg":"trace[2049653029] range","detail":"{range_begin:/registry/jobs/openstack/neutron-db-sync; range_end:; response_count:1; response_revision:18184; }","duration":"481.053591ms","start":"2026-07-08T03:46:23.254796Z","end":"2026-07-08T03:46:23.73585Z","steps":["trace[2049653029] 'agreement among raft nodes before linearized reading' (duration: 480.66472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.091977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:46:23.735922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.254789Z","time spent":"481.123393ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5456,"request content":"key:\"/registry/jobs/openstack/neutron-db-sync\" "} {"level":"info","ts":"2026-07-08T03:46:23.735929Z","caller":"traceutil/trace.go:171","msg":"trace[1136068160] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:18184; }","duration":"335.281933ms","start":"2026-07-08T03:46:23.400633Z","end":"2026-07-08T03:46:23.735915Z","steps":["trace[1136068160] 'agreement among raft nodes before linearized reading' (duration: 333.909435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:46:23.735974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.400615Z","time spent":"335.345394ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "} {"level":"warn","ts":"2026-07-08T03:46:23.735837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:46:23.352613Z","time spent":"383.209457ms","remote":"127.0.0.1:38312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22032,"request content":"key:\"/registry/pods/openstack/nova-compute-default-b8f99\" "} {"level":"info","ts":"2026-07-08T03:49:15.052095Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17455} {"level":"info","ts":"2026-07-08T03:49:15.143212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17455,"took":"88.786011ms","hash":1840997671,"current-db-size-bytes":59367424,"current-db-size":"59 MB","current-db-size-in-use-bytes":27578368,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-08T03:49:15.143267Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1840997671,"revision":17455,"compact-revision":15015} {"level":"info","ts":"2026-07-08T03:49:50.744075Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T03:49:50.749828Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-08T03:49:50.749928Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}