{"level":"warn","ts":"2026-08-13T00:58:37.120474Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-13T00:58:37.120556Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.63:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.63:2380","--initial-cluster=instance=https://199.19.213.63:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.63:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.63:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-08-13T00:58:37.120727Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-13T00:58:37.12074Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.63:2380"]}
{"level":"info","ts":"2026-08-13T00:58:37.120756Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-13T00:58:37.121357Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"]}
{"level":"info","ts":"2026-08-13T00:58:37.121432Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.63:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-08-13T00:58:37.124799Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.179411ms"}
{"level":"info","ts":"2026-08-13T00:58:37.129516Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d75c480e593e7aed","cluster-id":"24fce67309ccbdc"}
{"level":"info","ts":"2026-08-13T00:58:37.129739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=()"}
{"level":"info","ts":"2026-08-13T00:58:37.129794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 0"}
{"level":"info","ts":"2026-08-13T00:58:37.129803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d75c480e593e7aed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-13T00:58:37.129813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 1"}
{"level":"info","ts":"2026-08-13T00:58:37.12984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"}
{"level":"warn","ts":"2026-08-13T00:58:37.136975Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-13T00:58:37.138468Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-13T00:58:37.139619Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-08-13T00:58:37.142127Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d75c480e593e7aed","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-13T00:58:37.14231Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d75c480e593e7aed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-13T00:58:37.142341Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-13T00:58:37.142484Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-13T00:58:37.142509Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-08-13T00:58:37.143698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"}
{"level":"info","ts":"2026-08-13T00:58:37.144279Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","added-peer-id":"d75c480e593e7aed","added-peer-peer-urls":["https://199.19.213.63:2380"]}
{"level":"info","ts":"2026-08-13T00:58:37.145964Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-08-13T00:58:37.146122Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.63:2380"}
{"level":"info","ts":"2026-08-13T00:58:37.14615Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.63:2380"}
{"level":"info","ts":"2026-08-13T00:58:37.146209Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d75c480e593e7aed","initial-advertise-peer-urls":["https://199.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-13T00:58:37.146249Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-13T00:58:38.13072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed is starting a new election at term 1"}
{"level":"info","ts":"2026-08-13T00:58:38.130772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-13T00:58:38.130802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgPreVoteResp from d75c480e593e7aed at term 1"}
{"level":"info","ts":"2026-08-13T00:58:38.130816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became candidate at term 2"}
{"level":"info","ts":"2026-08-13T00:58:38.130823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgVoteResp from d75c480e593e7aed at term 2"}
{"level":"info","ts":"2026-08-13T00:58:38.130833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became leader at term 2"}
{"level":"info","ts":"2026-08-13T00:58:38.130842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d75c480e593e7aed elected leader d75c480e593e7aed at term 2"}
{"level":"info","ts":"2026-08-13T00:58:38.13156Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d75c480e593e7aed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.63:2379]}","request-path":"/0/members/d75c480e593e7aed/attributes","cluster-id":"24fce67309ccbdc","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-13T00:58:38.131559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-13T00:58:38.131578Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-13T00:58:38.131788Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-13T00:58:38.131825Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-13T00:58:38.131797Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T00:58:38.132908Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T00:58:38.133073Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T00:58:38.133148Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-13T00:58:38.13529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-13T00:58:38.137675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.63:2379"}
{"level":"info","ts":"2026-08-13T00:59:20.226503Z","caller":"traceutil/trace.go:171","msg":"trace[1576503494] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"235.50098ms","start":"2026-08-13T00:59:19.990974Z","end":"2026-08-13T00:59:20.226475Z","steps":["trace[1576503494] 'process raft request'  (duration: 234.894826ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T00:59:20.335961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.911858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q4l25\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-08-13T00:59:20.336106Z","caller":"traceutil/trace.go:171","msg":"trace[434982624] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q4l25; range_end:; response_count:1; response_revision:586; }","duration":"136.152303ms","start":"2026-08-13T00:59:20.199927Z","end":"2026-08-13T00:59:20.33608Z","steps":["trace[434982624] 'agreement among raft nodes before linearized reading'  (duration: 26.520444ms)","trace[434982624] 'range keys from in-memory index tree'  (duration: 109.293432ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T00:59:20.86193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.787834ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306509357 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:573 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-13T00:59:20.862503Z","caller":"traceutil/trace.go:171","msg":"trace[214366384] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"476.047399ms","start":"2026-08-13T00:59:20.386426Z","end":"2026-08-13T00:59:20.862474Z","steps":["trace[214366384] 'process raft request'  (duration: 252.087149ms)","trace[214366384] 'compare'  (duration: 222.634261ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T00:59:20.862658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:20.386401Z","time spent":"476.190752ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:573 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-13T00:59:20.862785Z","caller":"traceutil/trace.go:171","msg":"trace[318167990] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"305.513893ms","start":"2026-08-13T00:59:20.55723Z","end":"2026-08-13T00:59:20.862744Z","steps":["trace[318167990] 'read index received'  (duration: 81.549813ms)","trace[318167990] 'applied index is now lower than readState.Index'  (duration: 223.95883ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T00:59:20.862973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.732208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T00:59:20.863038Z","caller":"traceutil/trace.go:171","msg":"trace[960722889] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"441.87476ms","start":"2026-08-13T00:59:20.421138Z","end":"2026-08-13T00:59:20.863012Z","steps":["trace[960722889] 'process raft request'  (duration: 440.96025ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T00:59:20.863164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:20.421115Z","time spent":"441.985443ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:438 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-08-13T00:59:20.86305Z","caller":"traceutil/trace.go:171","msg":"trace[551450836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"305.83627ms","start":"2026-08-13T00:59:20.557193Z","end":"2026-08-13T00:59:20.863029Z","steps":["trace[551450836] 'agreement among raft nodes before linearized reading'  (duration: 305.676207ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T00:59:20.863307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:20.557176Z","time spent":"306.114066ms","remote":"127.0.0.1:51562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-13T00:59:44.115061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.721743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-13T00:59:44.115151Z","caller":"traceutil/trace.go:171","msg":"trace[1979942835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"129.865426ms","start":"2026-08-13T00:59:43.985267Z","end":"2026-08-13T00:59:44.115132Z","steps":["trace[1979942835] 'range keys from in-memory index tree'  (duration: 129.502439ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:00:54.336489Z","caller":"traceutil/trace.go:171","msg":"trace[875483311] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"123.001221ms","start":"2026-08-13T01:00:54.21346Z","end":"2026-08-13T01:00:54.336462Z","steps":["trace[875483311] 'process raft request'  (duration: 109.76739ms)","trace[875483311] 'compare'  (duration: 12.848543ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:00:54.648102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.111363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-395570e1-5bf9-47de-a547-3f9c8b6695ea\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-08-13T01:00:54.648191Z","caller":"traceutil/trace.go:171","msg":"trace[685895843] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-395570e1-5bf9-47de-a547-3f9c8b6695ea; range_end:; response_count:1; response_revision:1810; }","duration":"147.241995ms","start":"2026-08-13T01:00:54.500925Z","end":"2026-08-13T01:00:54.648167Z","steps":["trace[685895843] 'range keys from in-memory index tree'  (duration: 146.919509ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:01:45.107631Z","caller":"traceutil/trace.go:171","msg":"trace[390135599] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"215.70853ms","start":"2026-08-13T01:01:44.891899Z","end":"2026-08-13T01:01:45.107607Z","steps":["trace[390135599] 'read index received'  (duration: 215.519386ms)","trace[390135599] 'applied index is now lower than readState.Index'  (duration: 188.254µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:01:45.10768Z","caller":"traceutil/trace.go:171","msg":"trace[2046122696] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"225.613421ms","start":"2026-08-13T01:01:44.882033Z","end":"2026-08-13T01:01:45.107647Z","steps":["trace[2046122696] 'process raft request'  (duration: 225.437427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:01:45.107873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.004798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-13T01:01:45.10792Z","caller":"traceutil/trace.go:171","msg":"trace[1677391931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2139; }","duration":"201.102371ms","start":"2026-08-13T01:01:44.906803Z","end":"2026-08-13T01:01:45.107905Z","steps":["trace[1677391931] 'agreement among raft nodes before linearized reading'  (duration: 200.940177ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:01:45.107933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.015746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-13T01:01:45.108016Z","caller":"traceutil/trace.go:171","msg":"trace[1534909500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2139; }","duration":"216.149469ms","start":"2026-08-13T01:01:44.891845Z","end":"2026-08-13T01:01:45.107995Z","steps":["trace[1534909500] 'agreement among raft nodes before linearized reading'  (duration: 215.902904ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:01:45.278894Z","caller":"traceutil/trace.go:171","msg":"trace[1659231057] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"166.673039ms","start":"2026-08-13T01:01:45.112193Z","end":"2026-08-13T01:01:45.278866Z","steps":["trace[1659231057] 'process raft request'  (duration: 166.606088ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:01:45.278989Z","caller":"traceutil/trace.go:171","msg":"trace[457058922] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"166.965235ms","start":"2026-08-13T01:01:45.111983Z","end":"2026-08-13T01:01:45.278949Z","steps":["trace[457058922] 'process raft request'  (duration: 110.853554ms)","trace[457058922] 'compare'  (duration: 55.809485ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:03:06.693091Z","caller":"traceutil/trace.go:171","msg":"trace[305035690] linearizableReadLoop","detail":"{readStateIndex:2885; appliedIndex:2884; }","duration":"135.883777ms","start":"2026-08-13T01:03:06.557176Z","end":"2026-08-13T01:03:06.69306Z","steps":["trace[305035690] 'read index received'  (duration: 135.755524ms)","trace[305035690] 'applied index is now lower than readState.Index'  (duration: 126.343µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:03:06.693225Z","caller":"traceutil/trace.go:171","msg":"trace[729226029] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"169.41367ms","start":"2026-08-13T01:03:06.523777Z","end":"2026-08-13T01:03:06.69319Z","steps":["trace[729226029] 'process raft request'  (duration: 169.074393ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:03:06.693251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.064632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:03:06.693434Z","caller":"traceutil/trace.go:171","msg":"trace[1058757692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2779; }","duration":"136.288126ms","start":"2026-08-13T01:03:06.557127Z","end":"2026-08-13T01:03:06.693415Z","steps":["trace[1058757692] 'agreement among raft nodes before linearized reading'  (duration: 136.064911ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:03:07.170633Z","caller":"traceutil/trace.go:171","msg":"trace[259321554] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"112.289814ms","start":"2026-08-13T01:03:07.058318Z","end":"2026-08-13T01:03:07.170608Z","steps":["trace[259321554] 'process raft request'  (duration: 112.151701ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:06:53.589092Z","caller":"traceutil/trace.go:171","msg":"trace[879048018] linearizableReadLoop","detail":"{readStateIndex:4901; appliedIndex:4900; }","duration":"103.903981ms","start":"2026-08-13T01:06:53.485159Z","end":"2026-08-13T01:06:53.589063Z","steps":["trace[879048018] 'read index received'  (duration: 103.763178ms)","trace[879048018] 'applied index is now lower than readState.Index'  (duration: 139.563µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:06:53.589239Z","caller":"traceutil/trace.go:171","msg":"trace[140677168] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"109.121965ms","start":"2026-08-13T01:06:53.480095Z","end":"2026-08-13T01:06:53.589217Z","steps":["trace[140677168] 'process raft request'  (duration: 108.793298ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:06:53.58938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.200397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6ec98d31-a5ee-44b3-bc2e-b0fcebcaf8ab\" ","response":"range_response_count:1 size:3773"}
{"level":"info","ts":"2026-08-13T01:06:53.589444Z","caller":"traceutil/trace.go:171","msg":"trace[928813384] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6ec98d31-a5ee-44b3-bc2e-b0fcebcaf8ab; range_end:; response_count:1; response_revision:4723; }","duration":"104.301459ms","start":"2026-08-13T01:06:53.485124Z","end":"2026-08-13T01:06:53.589425Z","steps":["trace[928813384] 'agreement among raft nodes before linearized reading'  (duration: 104.103395ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:06:56.771542Z","caller":"traceutil/trace.go:171","msg":"trace[9217019] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"105.951626ms","start":"2026-08-13T01:06:56.665568Z","end":"2026-08-13T01:06:56.771519Z","steps":["trace[9217019] 'process raft request'  (duration: 105.587488ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:06:56.772116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.615273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a822386a-4a1c-4aae-b643-c91e2f7a3e98\" ","response":"range_response_count:1 size:4067"}
{"level":"info","ts":"2026-08-13T01:06:56.77222Z","caller":"traceutil/trace.go:171","msg":"trace[92068000] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a822386a-4a1c-4aae-b643-c91e2f7a3e98; range_end:; response_count:1; response_revision:4778; }","duration":"113.729525ms","start":"2026-08-13T01:06:56.658462Z","end":"2026-08-13T01:06:56.772192Z","steps":["trace[92068000] 'agreement among raft nodes before linearized reading'  (duration: 113.444299ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:01.182772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.136589ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306519342 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/monitoring/vector\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/monitoring/vector\" value_size:828 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-13T01:07:01.182901Z","caller":"traceutil/trace.go:171","msg":"trace[38056707] linearizableReadLoop","detail":"{readStateIndex:5139; appliedIndex:5138; }","duration":"284.317236ms","start":"2026-08-13T01:07:00.898564Z","end":"2026-08-13T01:07:01.182881Z","steps":["trace[38056707] 'read index received'  (duration: 120.91514ms)","trace[38056707] 'applied index is now lower than readState.Index'  (duration: 163.400506ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:07:01.182987Z","caller":"traceutil/trace.go:171","msg":"trace[2131187547] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"339.917727ms","start":"2026-08-13T01:07:00.843036Z","end":"2026-08-13T01:07:01.182954Z","steps":["trace[2131187547] 'process raft request'  (duration: 176.518241ms)","trace[2131187547] 'compare'  (duration: 162.927985ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:07:01.18311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:07:00.843019Z","time spent":"340.039679ms","remote":"127.0.0.1:51760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":879,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/monitoring/vector\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/monitoring/vector\" value_size:828 >> failure:<>"}
{"level":"warn","ts":"2026-08-13T01:07:01.183163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.603703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-13T01:07:01.183424Z","caller":"traceutil/trace.go:171","msg":"trace[1956798394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4954; }","duration":"284.968701ms","start":"2026-08-13T01:07:00.898442Z","end":"2026-08-13T01:07:01.183411Z","steps":["trace[1956798394] 'agreement among raft nodes before linearized reading'  (duration: 284.517131ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:01.23492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.167601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-13T01:07:01.235021Z","caller":"traceutil/trace.go:171","msg":"trace[1972862840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4955; }","duration":"334.318034ms","start":"2026-08-13T01:07:00.90068Z","end":"2026-08-13T01:07:01.234998Z","steps":["trace[1972862840] 'agreement among raft nodes before linearized reading'  (duration: 334.027978ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:01.235071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:07:00.900669Z","time spent":"334.388695ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-13T01:07:01.235088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.857268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.63\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-08-13T01:07:01.235171Z","caller":"traceutil/trace.go:171","msg":"trace[1607300599] range","detail":"{range_begin:/registry/masterleases/199.19.213.63; range_end:; response_count:1; response_revision:4955; }","duration":"142.987001ms","start":"2026-08-13T01:07:01.092165Z","end":"2026-08-13T01:07:01.235152Z","steps":["trace[1607300599] 'agreement among raft nodes before linearized reading'  (duration: 142.776947ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:01.235211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.630576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29627a57-499c-4649-8798-86670e1eaca7\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-08-13T01:07:01.235277Z","caller":"traceutil/trace.go:171","msg":"trace[1319305898] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29627a57-499c-4649-8798-86670e1eaca7; range_end:; response_count:1; response_revision:4955; }","duration":"274.753709ms","start":"2026-08-13T01:07:00.960507Z","end":"2026-08-13T01:07:01.235261Z","steps":["trace[1319305898] 'agreement among raft nodes before linearized reading'  (duration: 274.534444ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:01.58446Z","caller":"traceutil/trace.go:171","msg":"trace[929022486] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"178.628477ms","start":"2026-08-13T01:07:01.405801Z","end":"2026-08-13T01:07:01.58443Z","steps":["trace[929022486] 'process raft request'  (duration: 178.423393ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:01.591248Z","caller":"traceutil/trace.go:171","msg":"trace[2082024890] linearizableReadLoop","detail":"{readStateIndex:5157; appliedIndex:5155; }","duration":"113.128191ms","start":"2026-08-13T01:07:01.477505Z","end":"2026-08-13T01:07:01.590633Z","steps":["trace[2082024890] 'read index received'  (duration: 106.65057ms)","trace[2082024890] 'applied index is now lower than readState.Index'  (duration: 6.476051ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:07:01.59136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.833266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-13T01:07:01.591425Z","caller":"traceutil/trace.go:171","msg":"trace[1759681897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4971; }","duration":"113.944309ms","start":"2026-08-13T01:07:01.477469Z","end":"2026-08-13T01:07:01.591413Z","steps":["trace[1759681897] 'agreement among raft nodes before linearized reading'  (duration: 113.745934ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:01.593618Z","caller":"traceutil/trace.go:171","msg":"trace[923051687] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"160.119633ms","start":"2026-08-13T01:07:01.433472Z","end":"2026-08-13T01:07:01.593591Z","steps":["trace[923051687] 'process raft request'  (duration: 157.011476ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:03.458853Z","caller":"traceutil/trace.go:171","msg":"trace[1004271691] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"140.450866ms","start":"2026-08-13T01:07:03.318362Z","end":"2026-08-13T01:07:03.458813Z","steps":["trace[1004271691] 'process raft request'  (duration: 139.848733ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:14.187087Z","caller":"traceutil/trace.go:171","msg":"trace[157736789] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"100.227971ms","start":"2026-08-13T01:07:14.086829Z","end":"2026-08-13T01:07:14.187057Z","steps":["trace[157736789] 'process raft request'  (duration: 64.013063ms)","trace[157736789] 'compare'  (duration: 36.088545ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:07:14.675912Z","caller":"traceutil/trace.go:171","msg":"trace[2057877585] linearizableReadLoop","detail":"{readStateIndex:5419; appliedIndex:5418; }","duration":"210.392918ms","start":"2026-08-13T01:07:14.465492Z","end":"2026-08-13T01:07:14.675885Z","steps":["trace[2057877585] 'read index received'  (duration: 210.206914ms)","trace[2057877585] 'applied index is now lower than readState.Index'  (duration: 184.784µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:07:14.675994Z","caller":"traceutil/trace.go:171","msg":"trace[732237130] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"249.451557ms","start":"2026-08-13T01:07:14.426507Z","end":"2026-08-13T01:07:14.675959Z","steps":["trace[732237130] 'process raft request'  (duration: 249.219752ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:14.676231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.717034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-13T01:07:14.676255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.607832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:07:14.676366Z","caller":"traceutil/trace.go:171","msg":"trace[831201259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5226; }","duration":"119.756165ms","start":"2026-08-13T01:07:14.556585Z","end":"2026-08-13T01:07:14.676341Z","steps":["trace[831201259] 'agreement among raft nodes before linearized reading'  (duration: 119.601322ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:07:14.676301Z","caller":"traceutil/trace.go:171","msg":"trace[657645785] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5226; }","duration":"210.870748ms","start":"2026-08-13T01:07:14.465413Z","end":"2026-08-13T01:07:14.676283Z","steps":["trace[657645785] 'agreement among raft nodes before linearized reading'  (duration: 210.708865ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:07:14.870244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.763874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-qpl68\" ","response":"range_response_count:1 size:7817"}
{"level":"info","ts":"2026-08-13T01:07:14.870321Z","caller":"traceutil/trace.go:171","msg":"trace[12714123] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-qpl68; range_end:; response_count:1; response_revision:5226; }","duration":"135.882037ms","start":"2026-08-13T01:07:14.734421Z","end":"2026-08-13T01:07:14.870303Z","steps":["trace[12714123] 'range keys from in-memory index tree'  (duration: 135.621431ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:08:38.163409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2951}
{"level":"info","ts":"2026-08-13T01:08:38.237946Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2951,"took":"72.669216ms","hash":262683883,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":33972224,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-13T01:08:38.238031Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":262683883,"revision":2951,"compact-revision":-1}
{"level":"info","ts":"2026-08-13T01:13:27.734751Z","caller":"traceutil/trace.go:171","msg":"trace[2098275521] linearizableReadLoop","detail":"{readStateIndex:8488; appliedIndex:8487; }","duration":"418.107419ms","start":"2026-08-13T01:13:27.316616Z","end":"2026-08-13T01:13:27.734724Z","steps":["trace[2098275521] 'read index received'  (duration: 417.940865ms)","trace[2098275521] 'applied index is now lower than readState.Index'  (duration: 165.404µs)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:13:27.734893Z","caller":"traceutil/trace.go:171","msg":"trace[1620856622] transaction","detail":"{read_only:false; response_revision:8204; number_of_response:1; }","duration":"518.620316ms","start":"2026-08-13T01:13:27.216257Z","end":"2026-08-13T01:13:27.734878Z","steps":["trace[1620856622] 'process raft request'  (duration: 518.31426ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.735015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:13:27.216248Z","time spent":"518.682497ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8194 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-08-13T01:13:27.735626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.994179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-13T01:13:27.735688Z","caller":"traceutil/trace.go:171","msg":"trace[846157822] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8204; }","duration":"419.130991ms","start":"2026-08-13T01:13:27.316545Z","end":"2026-08-13T01:13:27.735676Z","steps":["trace[846157822] 'agreement among raft nodes before linearized reading'  (duration: 418.471586ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.735723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:13:27.316526Z","time spent":"419.187473ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":866,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-08-13T01:13:27.737927Z","caller":"traceutil/trace.go:171","msg":"trace[555211026] transaction","detail":"{read_only:false; response_revision:8205; number_of_response:1; }","duration":"108.89698ms","start":"2026-08-13T01:13:27.629008Z","end":"2026-08-13T01:13:27.737905Z","steps":["trace[555211026] 'process raft request'  (duration: 108.715846ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.6131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-08-13T01:13:27.738129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.367126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-13T01:13:27.73819Z","caller":"traceutil/trace.go:171","msg":"trace[463924140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8205; }","duration":"283.470769ms","start":"2026-08-13T01:13:27.454704Z","end":"2026-08-13T01:13:27.738175Z","steps":["trace[463924140] 'agreement among raft nodes before linearized reading'  (duration: 283.346436ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:13:27.738107Z","caller":"traceutil/trace.go:171","msg":"trace[144859732] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8205; }","duration":"209.743624ms","start":"2026-08-13T01:13:27.528346Z","end":"2026-08-13T01:13:27.73809Z","steps":["trace[144859732] 'agreement among raft nodes before linearized reading'  (duration: 209.521889ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.738018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.803701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-13T01:13:27.738409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.573022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:13:27.738462Z","caller":"traceutil/trace.go:171","msg":"trace[2127692820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8205; }","duration":"344.282222ms","start":"2026-08-13T01:13:27.394163Z","end":"2026-08-13T01:13:27.738445Z","steps":["trace[2127692820] 'agreement among raft nodes before linearized reading'  (duration: 343.667508ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.738518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:13:27.394144Z","time spent":"344.359144ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-13T01:13:27.738528Z","caller":"traceutil/trace.go:171","msg":"trace[1260636154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8205; }","duration":"181.743526ms","start":"2026-08-13T01:13:27.556754Z","end":"2026-08-13T01:13:27.738497Z","steps":["trace[1260636154] 'agreement among raft nodes before linearized reading'  (duration: 181.478939ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.738578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.335007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-13T01:13:27.738664Z","caller":"traceutil/trace.go:171","msg":"trace[905935301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8205; }","duration":"300.46672ms","start":"2026-08-13T01:13:27.43818Z","end":"2026-08-13T01:13:27.738646Z","steps":["trace[905935301] 'agreement among raft nodes before linearized reading'  (duration: 300.123102ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:13:27.738698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:13:27.438162Z","time spent":"300.529281ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-08-13T01:13:38.173856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6078}
{"level":"info","ts":"2026-08-13T01:13:38.271557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6078,"took":"95.210942ms","hash":1615444902,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":23810048,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-08-13T01:13:38.271626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1615444902,"revision":6078,"compact-revision":2951}
{"level":"info","ts":"2026-08-13T01:13:40.826518Z","caller":"traceutil/trace.go:171","msg":"trace[1206668817] transaction","detail":"{read_only:false; response_revision:8284; number_of_response:1; }","duration":"103.629445ms","start":"2026-08-13T01:13:40.722855Z","end":"2026-08-13T01:13:40.826485Z","steps":["trace[1206668817] 'process raft request'  (duration: 37.376233ms)","trace[1206668817] 'compare'  (duration: 66.12239ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:14:10.163532Z","caller":"traceutil/trace.go:171","msg":"trace[1191000003] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"114.39562ms","start":"2026-08-13T01:14:10.049099Z","end":"2026-08-13T01:14:10.163495Z","steps":["trace[1191000003] 'process raft request'  (duration: 114.034682ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:12.405004Z","caller":"traceutil/trace.go:171","msg":"trace[640442977] linearizableReadLoop","detail":"{readStateIndex:8800; appliedIndex:8798; }","duration":"231.539119ms","start":"2026-08-13T01:14:12.173416Z","end":"2026-08-13T01:14:12.404955Z","steps":["trace[640442977] 'read index received'  (duration: 36.133307ms)","trace[640442977] 'applied index is now lower than readState.Index'  (duration: 195.404412ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:14:12.405152Z","caller":"traceutil/trace.go:171","msg":"trace[1029745167] transaction","detail":"{read_only:false; response_revision:8503; number_of_response:1; }","duration":"235.325441ms","start":"2026-08-13T01:14:12.169783Z","end":"2026-08-13T01:14:12.405108Z","steps":["trace[1029745167] 'process raft request'  (duration: 178.680059ms)","trace[1029745167] 'compare'  (duration: 56.291695ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:14:12.405331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.883247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-08-13T01:14:12.405375Z","caller":"traceutil/trace.go:171","msg":"trace[663597515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8503; }","duration":"231.999349ms","start":"2026-08-13T01:14:12.173361Z","end":"2026-08-13T01:14:12.405361Z","steps":["trace[663597515] 'agreement among raft nodes before linearized reading'  (duration: 231.797144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:14:12.405532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.571569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-13T01:14:12.405564Z","caller":"traceutil/trace.go:171","msg":"trace[1133775166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8503; }","duration":"100.666101ms","start":"2026-08-13T01:14:12.304889Z","end":"2026-08-13T01:14:12.405555Z","steps":["trace[1133775166] 'agreement among raft nodes before linearized reading'  (duration: 100.504137ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:14:12.405603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.347091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-08-13T01:14:12.405656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.1239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-13T01:14:12.405689Z","caller":"traceutil/trace.go:171","msg":"trace[1825456451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8503; }","duration":"229.501344ms","start":"2026-08-13T01:14:12.176167Z","end":"2026-08-13T01:14:12.405668Z","steps":["trace[1825456451] 'agreement among raft nodes before linearized reading'  (duration: 229.232659ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:12.405715Z","caller":"traceutil/trace.go:171","msg":"trace[1509758577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8503; }","duration":"214.220961ms","start":"2026-08-13T01:14:12.191479Z","end":"2026-08-13T01:14:12.4057Z","steps":["trace[1509758577] 'agreement among raft nodes before linearized reading'  (duration: 214.042517ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:14:12.405718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.105715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-13T01:14:12.405803Z","caller":"traceutil/trace.go:171","msg":"trace[1888880019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8503; }","duration":"229.254258ms","start":"2026-08-13T01:14:12.176525Z","end":"2026-08-13T01:14:12.405779Z","steps":["trace[1888880019] 'agreement among raft nodes before linearized reading'  (duration: 229.053613ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:22.614827Z","caller":"traceutil/trace.go:171","msg":"trace[1724098851] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"148.340119ms","start":"2026-08-13T01:14:22.466455Z","end":"2026-08-13T01:14:22.614795Z","steps":["trace[1724098851] 'process raft request'  (duration: 97.156904ms)","trace[1724098851] 'compare'  (duration: 51.065842ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:14:22.620468Z","caller":"traceutil/trace.go:171","msg":"trace[2034485382] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8600; }","duration":"152.616872ms","start":"2026-08-13T01:14:22.467813Z","end":"2026-08-13T01:14:22.62043Z","steps":["trace[2034485382] 'process raft request'  (duration: 152.321036ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:22.620636Z","caller":"traceutil/trace.go:171","msg":"trace[1795341931] linearizableReadLoop","detail":"{readStateIndex:8902; appliedIndex:8900; }","duration":"147.50588ms","start":"2026-08-13T01:14:22.473111Z","end":"2026-08-13T01:14:22.620617Z","steps":["trace[1795341931] 'read index received'  (duration: 90.689053ms)","trace[1795341931] 'applied index is now lower than readState.Index'  (duration: 56.815927ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:14:22.621026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.882349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-13T01:14:22.621114Z","caller":"traceutil/trace.go:171","msg":"trace[1399538049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8601; }","duration":"148.030961ms","start":"2026-08-13T01:14:22.473065Z","end":"2026-08-13T01:14:22.621096Z","steps":["trace[1399538049] 'agreement among raft nodes before linearized reading'  (duration: 147.756665ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:14:23.555027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.979178ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306529068 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8594 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-13T01:14:23.55516Z","caller":"traceutil/trace.go:171","msg":"trace[564702741] linearizableReadLoop","detail":"{readStateIndex:8913; appliedIndex:8911; }","duration":"201.497556ms","start":"2026-08-13T01:14:23.35364Z","end":"2026-08-13T01:14:23.555137Z","steps":["trace[564702741] 'read index received'  (duration: 1.276369ms)","trace[564702741] 'applied index is now lower than readState.Index'  (duration: 200.218797ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:14:23.555411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.772671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xjpzp\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-08-13T01:14:23.555421Z","caller":"traceutil/trace.go:171","msg":"trace[603821494] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"247.501536ms","start":"2026-08-13T01:14:23.30784Z","end":"2026-08-13T01:14:23.555342Z","steps":["trace[603821494] 'process raft request'  (duration: 77.119259ms)","trace[603821494] 'compare'  (duration: 169.779974ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:14:23.555478Z","caller":"traceutil/trace.go:171","msg":"trace[108319993] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xjpzp; range_end:; response_count:1; response_revision:8611; }","duration":"201.832383ms","start":"2026-08-13T01:14:23.353624Z","end":"2026-08-13T01:14:23.555457Z","steps":["trace[108319993] 'agreement among raft nodes before linearized reading'  (duration: 201.671299ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:24.591433Z","caller":"traceutil/trace.go:171","msg":"trace[1750100378] transaction","detail":"{read_only:false; response_revision:8614; number_of_response:1; }","duration":"227.46298ms","start":"2026-08-13T01:14:24.363895Z","end":"2026-08-13T01:14:24.591358Z","steps":["trace[1750100378] 'process raft request'  (duration: 227.093202ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:14:24.685911Z","caller":"traceutil/trace.go:171","msg":"trace[740695751] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"232.554041ms","start":"2026-08-13T01:14:24.453316Z","end":"2026-08-13T01:14:24.68587Z","steps":["trace[740695751] 'process raft request'  (duration: 190.67595ms)","trace[740695751] 'compare'  (duration: 41.633966ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:14:39.665635Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002378.wal"}
{"level":"info","ts":"2026-08-13T01:15:40.088352Z","caller":"traceutil/trace.go:171","msg":"trace[433334953] transaction","detail":"{read_only:false; response_revision:9359; number_of_response:1; }","duration":"254.904536ms","start":"2026-08-13T01:15:39.833421Z","end":"2026-08-13T01:15:40.088325Z","steps":["trace[433334953] 'process raft request'  (duration: 254.727842ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:15:40.08874Z","caller":"traceutil/trace.go:171","msg":"trace[1092732375] linearizableReadLoop","detail":"{readStateIndex:9682; appliedIndex:9682; }","duration":"151.600682ms","start":"2026-08-13T01:15:39.937099Z","end":"2026-08-13T01:15:40.088699Z","steps":["trace[1092732375] 'read index received'  (duration: 151.589131ms)","trace[1092732375] 'applied index is now lower than readState.Index'  (duration: 9.601µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:15:40.088912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.791557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-13T01:15:40.089024Z","caller":"traceutil/trace.go:171","msg":"trace[1648012512] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:9359; }","duration":"151.960861ms","start":"2026-08-13T01:15:39.937044Z","end":"2026-08-13T01:15:40.089005Z","steps":["trace[1648012512] 'agreement among raft nodes before linearized reading'  (duration: 151.777626ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:16:21.348809Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d75c480e593e7aed","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-13T01:16:21.354743Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-13T01:16:21.35484Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-13T01:18:38.181523Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8271}
{"level":"info","ts":"2026-08-13T01:18:38.268748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8271,"took":"84.377939ms","hash":2282344000,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":25321472,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-08-13T01:18:38.268818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2282344000,"revision":8271,"compact-revision":6078}
{"level":"warn","ts":"2026-08-13T01:19:24.31484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.296486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-13T01:19:24.314977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.560711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:19:24.315816Z","caller":"traceutil/trace.go:171","msg":"trace[1390502967] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11211; }","duration":"105.271288ms","start":"2026-08-13T01:19:24.210489Z","end":"2026-08-13T01:19:24.31576Z","steps":["trace[1390502967] 'range keys from in-memory index tree'  (duration: 104.247344ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:19:24.315888Z","caller":"traceutil/trace.go:171","msg":"trace[336187600] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11211; }","duration":"105.506722ms","start":"2026-08-13T01:19:24.210321Z","end":"2026-08-13T01:19:24.315828Z","steps":["trace[336187600] 'range keys from in-memory index tree'  (duration: 104.44944ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:19:24.31528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.655224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-13T01:19:24.315122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.401168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:19:24.316295Z","caller":"traceutil/trace.go:171","msg":"trace[877176933] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11211; }","duration":"105.660076ms","start":"2026-08-13T01:19:24.210577Z","end":"2026-08-13T01:19:24.316237Z","steps":["trace[877176933] 'range keys from in-memory index tree'  (duration: 104.321366ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:19:24.316401Z","caller":"traceutil/trace.go:171","msg":"trace[1742156279] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11211; }","duration":"105.710318ms","start":"2026-08-13T01:19:24.21065Z","end":"2026-08-13T01:19:24.316361Z","steps":["trace[1742156279] 'range keys from in-memory index tree'  (duration: 104.324187ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:19:24.666388Z","caller":"traceutil/trace.go:171","msg":"trace[106620526] transaction","detail":"{read_only:false; response_revision:11214; number_of_response:1; }","duration":"252.970238ms","start":"2026-08-13T01:19:24.413381Z","end":"2026-08-13T01:19:24.666351Z","steps":["trace[106620526] 'process raft request'  (duration: 252.773184ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:19:24.670708Z","caller":"traceutil/trace.go:171","msg":"trace[916893050] linearizableReadLoop","detail":"{readStateIndex:11593; appliedIndex:11591; }","duration":"256.62238ms","start":"2026-08-13T01:19:24.414057Z","end":"2026-08-13T01:19:24.670679Z","steps":["trace[916893050] 'read index received'  (duration: 252.114929ms)","trace[916893050] 'applied index is now lower than readState.Index'  (duration: 4.505811ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:19:24.67085Z","caller":"traceutil/trace.go:171","msg":"trace[977845950] transaction","detail":"{read_only:false; response_revision:11215; number_of_response:1; }","duration":"257.302375ms","start":"2026-08-13T01:19:24.413468Z","end":"2026-08-13T01:19:24.67077Z","steps":["trace[977845950] 'process raft request'  (duration: 257.07276ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:19:24.670957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.892355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-13T01:19:24.67102Z","caller":"traceutil/trace.go:171","msg":"trace[1576642530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11215; }","duration":"256.978618ms","start":"2026-08-13T01:19:24.414023Z","end":"2026-08-13T01:19:24.671002Z","steps":["trace[1576642530] 'agreement among raft nodes before linearized reading'  (duration: 256.778033ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:19:24.671038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.783353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-08-13T01:19:24.670886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.649562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-13T01:19:24.671123Z","caller":"traceutil/trace.go:171","msg":"trace[863435354] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11215; }","duration":"102.930816ms","start":"2026-08-13T01:19:24.568169Z","end":"2026-08-13T01:19:24.6711Z","steps":["trace[863435354] 'agreement among raft nodes before linearized reading'  (duration: 102.67408ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:19:24.671154Z","caller":"traceutil/trace.go:171","msg":"trace[1274932450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11215; }","duration":"112.992529ms","start":"2026-08-13T01:19:24.558151Z","end":"2026-08-13T01:19:24.671143Z","steps":["trace[1274932450] 'agreement among raft nodes before linearized reading'  (duration: 112.670972ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:23:38.187783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10763}
{"level":"info","ts":"2026-08-13T01:23:38.267565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10763,"took":"77.189752ms","hash":1705597785,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":27877376,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-13T01:23:38.268079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1705597785,"revision":10763,"compact-revision":8271}
{"level":"warn","ts":"2026-08-13T01:26:07.323661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.816461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xjpzp\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-08-13T01:26:07.323752Z","caller":"traceutil/trace.go:171","msg":"trace[720382911] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xjpzp; range_end:; response_count:1; response_revision:13899; }","duration":"364.958094ms","start":"2026-08-13T01:26:06.958775Z","end":"2026-08-13T01:26:07.323734Z","steps":["trace[720382911] 'range keys from in-memory index tree'  (duration: 364.653918ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:26:07.323769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.254718ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306543955 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:13843 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"warn","ts":"2026-08-13T01:26:07.323793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:26:06.958753Z","time spent":"365.029876ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-xjpzp\" "}
{"level":"info","ts":"2026-08-13T01:26:07.323837Z","caller":"traceutil/trace.go:171","msg":"trace[142848762] transaction","detail":"{read_only:false; response_revision:13900; number_of_response:1; }","duration":"303.430143ms","start":"2026-08-13T01:26:07.020396Z","end":"2026-08-13T01:26:07.323826Z","steps":["trace[142848762] 'process raft request'  (duration: 133.047852ms)","trace[142848762] 'compare'  (duration: 170.042434ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:26:07.323889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:26:07.020356Z","time spent":"303.509535ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:13843 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-13T01:26:07.356686Z","caller":"traceutil/trace.go:171","msg":"trace[1235033486] transaction","detail":"{read_only:false; response_revision:13901; number_of_response:1; }","duration":"172.348824ms","start":"2026-08-13T01:26:07.184301Z","end":"2026-08-13T01:26:07.35665Z","steps":["trace[1235033486] 'process raft request'  (duration: 172.18074ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:27:47.911829Z","caller":"traceutil/trace.go:171","msg":"trace[857755600] transaction","detail":"{read_only:false; response_revision:15113; number_of_response:1; }","duration":"120.720161ms","start":"2026-08-13T01:27:47.791089Z","end":"2026-08-13T01:27:47.911809Z","steps":["trace[857755600] 'process raft request'  (duration: 120.008926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:27:48.007201Z","caller":"traceutil/trace.go:171","msg":"trace[238451714] transaction","detail":"{read_only:false; response_revision:15114; number_of_response:1; }","duration":"126.846215ms","start":"2026-08-13T01:27:47.880322Z","end":"2026-08-13T01:27:48.007168Z","steps":["trace[238451714] 'process raft request'  (duration: 120.994577ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:27:48.075015Z","caller":"traceutil/trace.go:171","msg":"trace[289581832] linearizableReadLoop","detail":"{readStateIndex:15626; appliedIndex:15624; }","duration":"157.062689ms","start":"2026-08-13T01:27:47.91792Z","end":"2026-08-13T01:27:48.074982Z","steps":["trace[289581832] 'read index received'  (duration: 83.485414ms)","trace[289581832] 'applied index is now lower than readState.Index'  (duration: 73.575725ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:27:48.075144Z","caller":"traceutil/trace.go:171","msg":"trace[1924025139] transaction","detail":"{read_only:false; response_revision:15115; number_of_response:1; }","duration":"163.488361ms","start":"2026-08-13T01:27:47.9116Z","end":"2026-08-13T01:27:48.075089Z","steps":["trace[1924025139] 'process raft request'  (duration: 163.182354ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:27:48.076093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.137273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769675"}
{"level":"info","ts":"2026-08-13T01:27:48.076158Z","caller":"traceutil/trace.go:171","msg":"trace[1425766656] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15115; }","duration":"158.230095ms","start":"2026-08-13T01:27:47.917914Z","end":"2026-08-13T01:27:48.076144Z","steps":["trace[1425766656] 'agreement among raft nodes before linearized reading'  (duration: 157.270124ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:28:38.194383Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12946}
{"level":"info","ts":"2026-08-13T01:28:38.271524Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12946,"took":"74.65114ms","hash":3050809533,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":30556160,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-13T01:28:38.271589Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3050809533,"revision":12946,"compact-revision":10763}
{"level":"info","ts":"2026-08-13T01:33:38.200746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15429}
{"level":"info","ts":"2026-08-13T01:33:38.297159Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15429,"took":"93.674227ms","hash":4291265884,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":31535104,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-13T01:33:38.297211Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4291265884,"revision":15429,"compact-revision":12946}
{"level":"info","ts":"2026-08-13T01:33:43.200415Z","caller":"traceutil/trace.go:171","msg":"trace[1011343816] linearizableReadLoop","detail":"{readStateIndex:18344; appliedIndex:18343; }","duration":"134.686468ms","start":"2026-08-13T01:33:43.065681Z","end":"2026-08-13T01:33:43.200368Z","steps":["trace[1011343816] 'read index received'  (duration: 90.489217ms)","trace[1011343816] 'applied index is now lower than readState.Index'  (duration: 44.194941ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:33:43.203843Z","caller":"traceutil/trace.go:171","msg":"trace[540931032] transaction","detail":"{read_only:false; response_revision:17743; number_of_response:1; }","duration":"142.253403ms","start":"2026-08-13T01:33:43.061573Z","end":"2026-08-13T01:33:43.203827Z","steps":["trace[540931032] 'process raft request'  (duration: 94.580157ms)","trace[540931032] 'compare'  (duration: 43.178817ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:33:43.204339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.646444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-13T01:33:43.204427Z","caller":"traceutil/trace.go:171","msg":"trace[456468226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17743; }","duration":"138.808177ms","start":"2026-08-13T01:33:43.0656Z","end":"2026-08-13T01:33:43.204408Z","steps":["trace[456468226] 'agreement among raft nodes before linearized reading'  (duration: 138.535031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:43.204712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.144357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vcpg4\" ","response":"range_response_count:1 size:22121"}
{"level":"info","ts":"2026-08-13T01:33:43.204733Z","caller":"traceutil/trace.go:171","msg":"trace[1303606342] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vcpg4; range_end:; response_count:1; response_revision:17743; }","duration":"115.199729ms","start":"2026-08-13T01:33:43.089528Z","end":"2026-08-13T01:33:43.204728Z","steps":["trace[1303606342] 'agreement among raft nodes before linearized reading'  (duration: 115.117487ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:43.821625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.838608ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306557895 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:17168 > success:<request_put:<key:\"/registry/minions/instance\" value_size:18700 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-13T01:33:43.821795Z","caller":"traceutil/trace.go:171","msg":"trace[457440500] linearizableReadLoop","detail":"{readStateIndex:18350; appliedIndex:18349; }","duration":"344.467483ms","start":"2026-08-13T01:33:43.477307Z","end":"2026-08-13T01:33:43.821775Z","steps":["trace[457440500] 'read index received'  (duration: 240.666183ms)","trace[457440500] 'applied index is now lower than readState.Index'  (duration: 103.79894ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:33:43.821839Z","caller":"traceutil/trace.go:171","msg":"trace[2097640136] transaction","detail":"{read_only:false; response_revision:17749; number_of_response:1; }","duration":"394.671215ms","start":"2026-08-13T01:33:43.427127Z","end":"2026-08-13T01:33:43.821798Z","steps":["trace[2097640136] 'process raft request'  (duration: 290.812284ms)","trace[2097640136] 'compare'  (duration: 102.400129ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:33:43.821959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.310517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-13T01:33:43.822003Z","caller":"traceutil/trace.go:171","msg":"trace[880984760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17749; }","duration":"266.387948ms","start":"2026-08-13T01:33:43.555603Z","end":"2026-08-13T01:33:43.821991Z","steps":["trace[880984760] 'agreement among raft nodes before linearized reading'  (duration: 266.296556ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:43.822042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:33:43.427107Z","time spent":"394.825518ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18736,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:17168 > success:<request_put:<key:\"/registry/minions/instance\" value_size:18700 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-08-13T01:33:43.822119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.79929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-08-13T01:33:43.822273Z","caller":"traceutil/trace.go:171","msg":"trace[239704369] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17749; }","duration":"344.956353ms","start":"2026-08-13T01:33:43.477257Z","end":"2026-08-13T01:33:43.822213Z","steps":["trace[239704369] 'agreement among raft nodes before linearized reading'  (duration: 344.633166ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:43.822356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:33:43.477228Z","time spent":"345.115287ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-13T01:33:43.822422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.578971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-13T01:33:43.822469Z","caller":"traceutil/trace.go:171","msg":"trace[1404058402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:17749; }","duration":"209.655783ms","start":"2026-08-13T01:33:43.6128Z","end":"2026-08-13T01:33:43.822456Z","steps":["trace[1404058402] 'agreement among raft nodes before linearized reading'  (duration: 209.581452ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:43.8225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.360681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-tt44q\" ","response":"range_response_count:1 size:9799"}
{"level":"info","ts":"2026-08-13T01:33:43.822596Z","caller":"traceutil/trace.go:171","msg":"trace[1250535091] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-tt44q; range_end:; response_count:1; response_revision:17749; }","duration":"257.517924ms","start":"2026-08-13T01:33:43.565058Z","end":"2026-08-13T01:33:43.822576Z","steps":["trace[1250535091] 'agreement among raft nodes before linearized reading'  (duration: 257.211157ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:44.230859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.151027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3226"}
{"level":"warn","ts":"2026-08-13T01:33:44.2309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.4349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-23218476-77a8-49f1-aa98-c9f6ccebf341\" ","response":"range_response_count:1 size:3756"}
{"level":"info","ts":"2026-08-13T01:33:44.230937Z","caller":"traceutil/trace.go:171","msg":"trace[918106221] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:17750; }","duration":"191.28746ms","start":"2026-08-13T01:33:44.03963Z","end":"2026-08-13T01:33:44.230917Z","steps":["trace[918106221] 'range keys from in-memory index tree'  (duration: 190.942623ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:33:44.230985Z","caller":"traceutil/trace.go:171","msg":"trace[184845365] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-23218476-77a8-49f1-aa98-c9f6ccebf341; range_end:; response_count:1; response_revision:17750; }","duration":"215.531782ms","start":"2026-08-13T01:33:44.015428Z","end":"2026-08-13T01:33:44.23096Z","steps":["trace[184845365] 'range keys from in-memory index tree'  (duration: 215.216655ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:33:44.370518Z","caller":"traceutil/trace.go:171","msg":"trace[1734496935] linearizableReadLoop","detail":"{readStateIndex:18352; appliedIndex:18351; }","duration":"133.881738ms","start":"2026-08-13T01:33:44.2366Z","end":"2026-08-13T01:33:44.370481Z","steps":["trace[1734496935] 'read index received'  (duration: 133.521691ms)","trace[1734496935] 'applied index is now lower than readState.Index'  (duration: 358.917µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:33:44.37083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.234217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-heat-default-user\" ","response":"range_response_count:1 size:1145"}
{"level":"info","ts":"2026-08-13T01:33:44.370879Z","caller":"traceutil/trace.go:171","msg":"trace[1502937362] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-heat-default-user; range_end:; response_count:1; response_revision:17751; }","duration":"134.35535ms","start":"2026-08-13T01:33:44.23651Z","end":"2026-08-13T01:33:44.370865Z","steps":["trace[1502937362] 'agreement among raft nodes before linearized reading'  (duration: 134.107433ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:33:44.371284Z","caller":"traceutil/trace.go:171","msg":"trace[948220362] transaction","detail":"{read_only:false; response_revision:17751; number_of_response:1; }","duration":"309.921634ms","start":"2026-08-13T01:33:44.061348Z","end":"2026-08-13T01:33:44.37127Z","steps":["trace[948220362] 'process raft request'  (duration: 308.912042ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:44.371412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:33:44.061325Z","time spent":"309.998076ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":919,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/libvirt-libvirt-default-c28gd.18cb396e870ff0c5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/libvirt-libvirt-default-c28gd.18cb396e870ff0c5\" value_size:828 lease:8857911932306556335 >> failure:<>"}
{"level":"info","ts":"2026-08-13T01:33:49.297136Z","caller":"traceutil/trace.go:171","msg":"trace[561120190] linearizableReadLoop","detail":"{readStateIndex:18414; appliedIndex:18413; }","duration":"126.466176ms","start":"2026-08-13T01:33:49.170646Z","end":"2026-08-13T01:33:49.297113Z","steps":["trace[561120190] 'read index received'  (duration: 124.557913ms)","trace[561120190] 'applied index is now lower than readState.Index'  (duration: 1.907153ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:33:49.297231Z","caller":"traceutil/trace.go:171","msg":"trace[722899243] transaction","detail":"{read_only:false; response_revision:17811; number_of_response:1; }","duration":"127.474308ms","start":"2026-08-13T01:33:49.169723Z","end":"2026-08-13T01:33:49.297197Z","steps":["trace[722899243] 'process raft request'  (duration: 125.570035ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:33:49.297594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.940857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-08-13T01:33:49.297645Z","caller":"traceutil/trace.go:171","msg":"trace[614590721] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:17811; }","duration":"127.030648ms","start":"2026-08-13T01:33:49.170599Z","end":"2026-08-13T01:33:49.29763Z","steps":["trace[614590721] 'agreement among raft nodes before linearized reading'  (duration: 126.6499ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:37:01.737796Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d75c480e593e7aed","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-13T01:37:01.742818Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-13T01:37:01.74294Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-13T01:38:38.207945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17660}
{"level":"info","ts":"2026-08-13T01:38:38.305734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17660,"took":"94.482422ms","hash":2234481337,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":34267136,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-13T01:38:38.305797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2234481337,"revision":17660,"compact-revision":15429}
{"level":"info","ts":"2026-08-13T01:39:50.797255Z","caller":"traceutil/trace.go:171","msg":"trace[323119150] transaction","detail":"{read_only:false; response_revision:20474; number_of_response:1; }","duration":"111.354822ms","start":"2026-08-13T01:39:50.685879Z","end":"2026-08-13T01:39:50.797234Z","steps":["trace[323119150] 'process raft request'  (duration: 111.226749ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:39:50.952354Z","caller":"traceutil/trace.go:171","msg":"trace[511956380] transaction","detail":"{read_only:false; response_revision:20475; number_of_response:1; }","duration":"227.729114ms","start":"2026-08-13T01:39:50.724607Z","end":"2026-08-13T01:39:50.952337Z","steps":["trace[511956380] 'process raft request'  (duration: 218.170935ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:39:56.83427Z","caller":"traceutil/trace.go:171","msg":"trace[1982460721] transaction","detail":"{read_only:false; response_revision:20506; number_of_response:1; }","duration":"209.094776ms","start":"2026-08-13T01:39:56.62515Z","end":"2026-08-13T01:39:56.834244Z","steps":["trace[1982460721] 'process raft request'  (duration: 208.943063ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.117342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.071953ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306566014 > lease_revoke:<id:7aed9ff8a0d3aa9a>","response":"size:29"}
{"level":"info","ts":"2026-08-13T01:39:57.117556Z","caller":"traceutil/trace.go:171","msg":"trace[2122192320] linearizableReadLoop","detail":"{readStateIndex:21201; appliedIndex:21199; }","duration":"288.415875ms","start":"2026-08-13T01:39:56.82912Z","end":"2026-08-13T01:39:57.117536Z","steps":["trace[2122192320] 'read index received'  (duration: 4.945598ms)","trace[2122192320] 'applied index is now lower than readState.Index'  (duration: 283.469307ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:39:57.117763Z","caller":"traceutil/trace.go:171","msg":"trace[1808132507] transaction","detail":"{read_only:false; response_revision:20507; number_of_response:1; }","duration":"139.865787ms","start":"2026-08-13T01:39:56.977841Z","end":"2026-08-13T01:39:57.117707Z","steps":["trace[1808132507] 'process raft request'  (duration: 139.602562ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.167943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.810041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-13T01:39:57.168036Z","caller":"traceutil/trace.go:171","msg":"trace[667939879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20507; }","duration":"338.932643ms","start":"2026-08-13T01:39:56.829079Z","end":"2026-08-13T01:39:57.168012Z","steps":["trace[667939879] 'agreement among raft nodes before linearized reading'  (duration: 288.579838ms)","trace[667939879] 'range keys from in-memory index tree'  (duration: 50.15688ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:39:57.168075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T01:39:56.829063Z","time spent":"339.004955ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-13T01:39:57.168184Z","caller":"traceutil/trace.go:171","msg":"trace[1751307559] transaction","detail":"{read_only:false; response_revision:20508; number_of_response:1; }","duration":"186.065811ms","start":"2026-08-13T01:39:56.982081Z","end":"2026-08-13T01:39:57.168146Z","steps":["trace[1751307559] 'process raft request'  (duration: 180.204352ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.168699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.054663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-13T01:39:57.168742Z","caller":"traceutil/trace.go:171","msg":"trace[1761759885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20509; }","duration":"167.151326ms","start":"2026-08-13T01:39:57.001579Z","end":"2026-08-13T01:39:57.16873Z","steps":["trace[1761759885] 'agreement among raft nodes before linearized reading'  (duration: 167.047293ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:39:57.168794Z","caller":"traceutil/trace.go:171","msg":"trace[368849596] transaction","detail":"{read_only:false; response_revision:20509; number_of_response:1; }","duration":"184.364574ms","start":"2026-08-13T01:39:56.984397Z","end":"2026-08-13T01:39:57.168761Z","steps":["trace[368849596] 'process raft request'  (duration: 183.662958ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.425701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.254088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306566022 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20497 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-13T01:39:57.425813Z","caller":"traceutil/trace.go:171","msg":"trace[1275789003] linearizableReadLoop","detail":"{readStateIndex:21205; appliedIndex:21204; }","duration":"250.128495ms","start":"2026-08-13T01:39:57.175656Z","end":"2026-08-13T01:39:57.425784Z","steps":["trace[1275789003] 'read index received'  (duration: 108.669533ms)","trace[1275789003] 'applied index is now lower than readState.Index'  (duration: 141.457532ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:39:57.425841Z","caller":"traceutil/trace.go:171","msg":"trace[878713886] transaction","detail":"{read_only:false; response_revision:20510; number_of_response:1; }","duration":"253.290794ms","start":"2026-08-13T01:39:57.172521Z","end":"2026-08-13T01:39:57.425812Z","steps":["trace[878713886] 'process raft request'  (duration: 111.834543ms)","trace[878713886] 'compare'  (duration: 141.068713ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:39:57.426038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.370326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-13T01:39:57.426077Z","caller":"traceutil/trace.go:171","msg":"trace[1838991909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20510; }","duration":"217.444018ms","start":"2026-08-13T01:39:57.208623Z","end":"2026-08-13T01:39:57.426067Z","steps":["trace[1838991909] 'agreement among raft nodes before linearized reading'  (duration: 217.271544ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.426073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.569301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-13T01:39:57.426146Z","caller":"traceutil/trace.go:171","msg":"trace[250524293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20510; }","duration":"155.688884ms","start":"2026-08-13T01:39:57.270437Z","end":"2026-08-13T01:39:57.426126Z","steps":["trace[250524293] 'agreement among raft nodes before linearized reading'  (duration: 155.470169ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.426347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.826883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-13T01:39:57.426422Z","caller":"traceutil/trace.go:171","msg":"trace[21804507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20510; }","duration":"215.946435ms","start":"2026-08-13T01:39:57.210458Z","end":"2026-08-13T01:39:57.426405Z","steps":["trace[21804507] 'agreement among raft nodes before linearized reading'  (duration: 215.7014ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.426556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.888633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-08-13T01:39:57.426597Z","caller":"traceutil/trace.go:171","msg":"trace[1493430528] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:20510; }","duration":"250.951384ms","start":"2026-08-13T01:39:57.175635Z","end":"2026-08-13T01:39:57.426587Z","steps":["trace[1493430528] 'agreement among raft nodes before linearized reading'  (duration: 250.238208ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.721518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.286676ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8857911932306566026 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20502 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-13T01:39:57.721629Z","caller":"traceutil/trace.go:171","msg":"trace[571791576] linearizableReadLoop","detail":"{readStateIndex:21206; appliedIndex:21205; }","duration":"291.152366ms","start":"2026-08-13T01:39:57.43046Z","end":"2026-08-13T01:39:57.721612Z","steps":["trace[571791576] 'read index received'  (duration: 177.668426ms)","trace[571791576] 'applied index is now lower than readState.Index'  (duration: 113.4829ms)"],"step_count":2}
{"level":"info","ts":"2026-08-13T01:39:57.721679Z","caller":"traceutil/trace.go:171","msg":"trace[409037381] transaction","detail":"{read_only:false; response_revision:20511; number_of_response:1; }","duration":"291.545664ms","start":"2026-08-13T01:39:57.4301Z","end":"2026-08-13T01:39:57.721646Z","steps":["trace[409037381] 'process raft request'  (duration: 178.031444ms)","trace[409037381] 'compare'  (duration: 113.173812ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-13T01:39:57.721732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.265228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-13T01:39:57.721761Z","caller":"traceutil/trace.go:171","msg":"trace[1488623491] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:20511; }","duration":"291.315809ms","start":"2026-08-13T01:39:57.430436Z","end":"2026-08-13T01:39:57.721752Z","steps":["trace[1488623491] 'agreement among raft nodes before linearized reading'  (duration: 291.247838ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:39:57.724562Z","caller":"traceutil/trace.go:171","msg":"trace[1080922655] transaction","detail":"{read_only:false; response_revision:20513; number_of_response:1; }","duration":"293.563618ms","start":"2026-08-13T01:39:57.430985Z","end":"2026-08-13T01:39:57.724548Z","steps":["trace[1080922655] 'process raft request'  (duration: 293.404405ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:39:57.724601Z","caller":"traceutil/trace.go:171","msg":"trace[1704830749] transaction","detail":"{read_only:false; response_revision:20512; number_of_response:1; }","duration":"293.753653ms","start":"2026-08-13T01:39:57.430783Z","end":"2026-08-13T01:39:57.724537Z","steps":["trace[1704830749] 'process raft request'  (duration: 293.461177ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-13T01:39:57.724514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.493493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-13T01:39:57.724753Z","caller":"traceutil/trace.go:171","msg":"trace[814372249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20513; }","duration":"167.77382ms","start":"2026-08-13T01:39:57.556968Z","end":"2026-08-13T01:39:57.724742Z","steps":["trace[814372249] 'agreement among raft nodes before linearized reading'  (duration: 167.470513ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:43:38.228489Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20105}
{"level":"info","ts":"2026-08-13T01:43:38.355107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20105,"took":"118.867077ms","hash":1645693931,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":36143104,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-08-13T01:43:38.355168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1645693931,"revision":20105,"compact-revision":17660}
{"level":"warn","ts":"2026-08-13T01:43:51.590931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.803056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-13T01:43:51.591053Z","caller":"traceutil/trace.go:171","msg":"trace[907507166] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:22951; }","duration":"118.971699ms","start":"2026-08-13T01:43:51.472053Z","end":"2026-08-13T01:43:51.591025Z","steps":["trace[907507166] 'count revisions from in-memory index tree'  (duration: 118.738775ms)"],"step_count":1}
{"level":"info","ts":"2026-08-13T01:48:38.235111Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22528}
{"level":"info","ts":"2026-08-13T01:48:38.347102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22528,"took":"109.081694ms","hash":4140896575,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":42688512,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-13T01:48:38.347192Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4140896575,"revision":22528,"compact-revision":20105}
{"level":"info","ts":"2026-08-13T01:51:41.345405Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c17.wal"}
{"level":"info","ts":"2026-08-13T01:53:38.243032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25412}
{"level":"info","ts":"2026-08-13T01:53:38.377873Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25412,"took":"131.145098ms","hash":2501881618,"current-db-size-bytes":58621952,"current-db-size":"59 MB","current-db-size-in-use-bytes":30265344,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-13T01:53:38.377937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2501881618,"revision":25412,"compact-revision":22528}