{"level":"warn","ts":"2026-06-15T19:15:43.564652Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:15:43.564754Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-06-15T19:15:43.564836Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:15:43.564848Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-06-15T19:15:43.564864Z","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-06-15T19:15:43.56553Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-06-15T19:15:43.565604Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-06-15T19:15:43.568059Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.234631ms"} {"level":"info","ts":"2026-06-15T19:15:43.578269Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-06-15T19:15:43.578427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T19:15:43.578472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-06-15T19:15:43.578497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T19:15:43.57852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-06-15T19:15:43.578589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-06-15T19:15:43.583201Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T19:15:43.584477Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T19:15:43.585707Z","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-06-15T19:15:43.587922Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T19:15:43.588249Z","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-06-15T19:15:43.588398Z","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-06-15T19:15:43.58842Z","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-06-15T19:15:43.588396Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T19:15:43.591017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-06-15T19:15:43.591376Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-06-15T19:15:43.594321Z","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-06-15T19:15:43.594397Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-15T19:15:43.594433Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-15T19:15:43.594813Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T19:15:43.594862Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T19:15:43.679616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T19:15:43.67969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T19:15:43.679729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-06-15T19:15:43.679758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-06-15T19:15:43.679769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-15T19:15:43.679785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-06-15T19:15:43.679799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-15T19:15:43.680712Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:15:43.681512Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:15:43.681513Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T19:15:43.681807Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:15:43.682025Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:15:43.68217Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:15:43.682207Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:15:43.682524Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T19:15:43.682561Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T19:15:43.684707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-06-15T19:15:43.685526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T19:16:20.465237Z","caller":"traceutil/trace.go:171","msg":"trace[796619866] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"100.568019ms","start":"2026-06-15T19:16:20.364645Z","end":"2026-06-15T19:16:20.465213Z","steps":["trace[796619866] 'process raft request' (duration: 98.023983ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:16:20.470931Z","caller":"traceutil/trace.go:171","msg":"trace[39348941] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"104.046836ms","start":"2026-06-15T19:16:20.366847Z","end":"2026-06-15T19:16:20.470894Z","steps":["trace[39348941] 'process raft request' (duration: 103.866532ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:16:20.471082Z","caller":"traceutil/trace.go:171","msg":"trace[1897728572] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"100.448628ms","start":"2026-06-15T19:16:20.370615Z","end":"2026-06-15T19:16:20.471064Z","steps":["trace[1897728572] 'process raft request' (duration: 100.211283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:16:26.857229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.062447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-15T19:16:26.857332Z","caller":"traceutil/trace.go:171","msg":"trace[1722790011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"361.2484ms","start":"2026-06-15T19:16:26.496066Z","end":"2026-06-15T19:16:26.857314Z","steps":["trace[1722790011] 'range keys from in-memory index tree' (duration: 360.885214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:16:26.857371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:16:26.496042Z","time spent":"361.319382ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T19:16:26.857343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.859353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fbgxx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-15T19:16:26.857453Z","caller":"traceutil/trace.go:171","msg":"trace[1152265158] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fbgxx; range_end:; response_count:1; response_revision:637; }","duration":"254.022276ms","start":"2026-06-15T19:16:26.603411Z","end":"2026-06-15T19:16:26.857433Z","steps":["trace[1152265158] 'range keys from in-memory index tree' (duration: 253.614709ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:16:41.863848Z","caller":"traceutil/trace.go:171","msg":"trace[2008574460] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"144.681133ms","start":"2026-06-15T19:16:41.719147Z","end":"2026-06-15T19:16:41.863828Z","steps":["trace[2008574460] 'read index received' (duration: 144.565191ms)","trace[2008574460] 'applied index is now lower than readState.Index' (duration: 115.082µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:16:41.863922Z","caller":"traceutil/trace.go:171","msg":"trace[1166220561] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"158.636713ms","start":"2026-06-15T19:16:41.705244Z","end":"2026-06-15T19:16:41.86388Z","steps":["trace[1166220561] 'process raft request' (duration: 158.437109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:16:41.86402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.852766ms","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-06-15T19:16:41.864077Z","caller":"traceutil/trace.go:171","msg":"trace[1537692439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"144.945127ms","start":"2026-06-15T19:16:41.719121Z","end":"2026-06-15T19:16:41.864066Z","steps":["trace[1537692439] 'agreement among raft nodes before linearized reading' (duration: 144.799954ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:17:09.028219Z","caller":"traceutil/trace.go:171","msg":"trace[656892523] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"104.82628ms","start":"2026-06-15T19:17:08.923362Z","end":"2026-06-15T19:17:09.028188Z","steps":["trace[656892523] 'process raft request' (duration: 104.542435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:17:09.183054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.612881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-15T19:17:09.183165Z","caller":"traceutil/trace.go:171","msg":"trace[912716468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1188; }","duration":"122.811315ms","start":"2026-06-15T19:17:09.060328Z","end":"2026-06-15T19:17:09.183139Z","steps":["trace[912716468] 'range keys from in-memory index tree' (duration: 122.399876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:17:55.820726Z","caller":"traceutil/trace.go:171","msg":"trace[1320165623] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"287.117121ms","start":"2026-06-15T19:17:55.533568Z","end":"2026-06-15T19:17:55.820685Z","steps":["trace[1320165623] 'process raft request' (duration: 251.394818ms)","trace[1320165623] 'compare' (duration: 35.532159ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:17:56.245848Z","caller":"traceutil/trace.go:171","msg":"trace[157954285] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"169.380479ms","start":"2026-06-15T19:17:56.076433Z","end":"2026-06-15T19:17:56.245813Z","steps":["trace[157954285] 'process raft request' (duration: 169.138225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:18:51.111368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.637016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:18:51.111565Z","caller":"traceutil/trace.go:171","msg":"trace[1372996381] linearizableReadLoop","detail":"{readStateIndex:2301; appliedIndex:2300; }","duration":"194.129993ms","start":"2026-06-15T19:18:50.917408Z","end":"2026-06-15T19:18:51.111538Z","steps":["trace[1372996381] 'read index received' (duration: 72.56347ms)","trace[1372996381] 'applied index is now lower than readState.Index' (duration: 121.564723ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:18:51.111625Z","caller":"traceutil/trace.go:171","msg":"trace[656163367] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"271.074895ms","start":"2026-06-15T19:18:50.840512Z","end":"2026-06-15T19:18:51.111587Z","steps":["trace[656163367] 'process raft request' (duration: 149.505071ms)","trace[656163367] 'compare' (duration: 120.528954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:18:51.111737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.313137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:18:51.111797Z","caller":"traceutil/trace.go:171","msg":"trace[1137129329] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2215; }","duration":"194.375008ms","start":"2026-06-15T19:18:50.917403Z","end":"2026-06-15T19:18:51.111778Z","steps":["trace[1137129329] 'agreement among raft nodes before linearized reading' (duration: 194.257436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:18:51.204094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.815011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:18:51.204149Z","caller":"traceutil/trace.go:171","msg":"trace[1380933690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"207.914663ms","start":"2026-06-15T19:18:50.996221Z","end":"2026-06-15T19:18:51.204136Z","steps":["trace[1380933690] 'agreement among raft nodes before linearized reading' (duration: 207.814142ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:18:51.204201Z","caller":"traceutil/trace.go:171","msg":"trace[1504487899] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"135.730972ms","start":"2026-06-15T19:18:51.068417Z","end":"2026-06-15T19:18:51.204148Z","steps":["trace[1504487899] 'process raft request' (duration: 135.514408ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:18:51.536696Z","caller":"traceutil/trace.go:171","msg":"trace[824451845] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"115.521919ms","start":"2026-06-15T19:18:51.421151Z","end":"2026-06-15T19:18:51.536673Z","steps":["trace[824451845] 'process raft request' (duration: 115.373406ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:20:00.003126Z","caller":"traceutil/trace.go:171","msg":"trace[2143211855] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"100.239968ms","start":"2026-06-15T19:19:59.90286Z","end":"2026-06-15T19:20:00.0031Z","steps":["trace[2143211855] 'process raft request' (duration: 99.78982ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:20:00.353369Z","caller":"traceutil/trace.go:171","msg":"trace[126568639] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"125.933823ms","start":"2026-06-15T19:20:00.227368Z","end":"2026-06-15T19:20:00.353302Z","steps":["trace[126568639] 'process raft request' (duration: 125.609577ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:23:53.029577Z","caller":"traceutil/trace.go:171","msg":"trace[2093853143] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"185.661406ms","start":"2026-06-15T19:23:52.843887Z","end":"2026-06-15T19:23:53.029549Z","steps":["trace[2093853143] 'process raft request' (duration: 185.423951ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:24:13.132395Z","caller":"traceutil/trace.go:171","msg":"trace[1865844038] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"414.896644ms","start":"2026-06-15T19:24:12.717468Z","end":"2026-06-15T19:24:13.132364Z","steps":["trace[1865844038] 'process raft request' (duration: 414.72344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:24:13.132578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:24:12.717458Z","time spent":"415.036667ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:24:13.146123Z","caller":"traceutil/trace.go:171","msg":"trace[1551182857] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"418.261365ms","start":"2026-06-15T19:24:12.727845Z","end":"2026-06-15T19:24:13.146106Z","steps":["trace[1551182857] 'process raft request' (duration: 418.105632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:24:13.146219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.41486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:24:13.146251Z","caller":"traceutil/trace.go:171","msg":"trace[1885286929] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:5394; }","duration":"272.506822ms","start":"2026-06-15T19:24:12.873737Z","end":"2026-06-15T19:24:13.146244Z","steps":["trace[1885286929] 'agreement among raft nodes before linearized reading' (duration: 272.42082ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:24:13.146405Z","caller":"traceutil/trace.go:171","msg":"trace[407562057] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"246.057967ms","start":"2026-06-15T19:24:12.900319Z","end":"2026-06-15T19:24:13.146377Z","steps":["trace[407562057] 'process raft request' (duration: 245.739449ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:24:13.146112Z","caller":"traceutil/trace.go:171","msg":"trace[1243081126] linearizableReadLoop","detail":"{readStateIndex:5594; appliedIndex:5593; }","duration":"272.309358ms","start":"2026-06-15T19:24:12.873781Z","end":"2026-06-15T19:24:13.14609Z","steps":["trace[1243081126] 'read index received' (duration: 258.601976ms)","trace[1243081126] 'applied index is now lower than readState.Index' (duration: 13.706712ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:24:13.146611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.746529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:24:13.146659Z","caller":"traceutil/trace.go:171","msg":"trace[1171590497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5394; }","duration":"149.846081ms","start":"2026-06-15T19:24:12.996797Z","end":"2026-06-15T19:24:13.146643Z","steps":["trace[1171590497] 'agreement among raft nodes before linearized reading' (duration: 149.77755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:24:13.146662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.406019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aa2f7e24-7cb2-4c07-b969-a357e9d9fa1e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-15T19:24:13.146692Z","caller":"traceutil/trace.go:171","msg":"trace[81696715] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aa2f7e24-7cb2-4c07-b969-a357e9d9fa1e; range_end:; response_count:1; response_revision:5394; }","duration":"140.472292ms","start":"2026-06-15T19:24:13.006212Z","end":"2026-06-15T19:24:13.146684Z","steps":["trace[81696715] 'agreement among raft nodes before linearized reading' (duration: 140.35955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:24:13.146869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:24:12.72782Z","time spent":"418.945751ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:24:13.147349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.960817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-15T19:24:13.147435Z","caller":"traceutil/trace.go:171","msg":"trace[569786584] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5394; }","duration":"248.08131ms","start":"2026-06-15T19:24:12.899332Z","end":"2026-06-15T19:24:13.147414Z","steps":["trace[569786584] 'agreement among raft nodes before linearized reading' (duration: 247.229872ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:25:43.923184Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3027} {"level":"info","ts":"2026-06-15T19:25:44.00145Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3027,"took":"76.80208ms","hash":1484626651,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":32010240,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T19:25:44.001532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1484626651,"revision":3027,"compact-revision":-1} {"level":"warn","ts":"2026-06-15T19:30:25.379143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.827729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.379241Z","caller":"traceutil/trace.go:171","msg":"trace[1309800441] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8258; }","duration":"292.976112ms","start":"2026-06-15T19:30:25.086247Z","end":"2026-06-15T19:30:25.379223Z","steps":["trace[1309800441] 'count revisions from in-memory index tree' (duration: 292.757558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.380639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.379359Z","caller":"traceutil/trace.go:171","msg":"trace[484720332] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8258; }","duration":"340.44142ms","start":"2026-06-15T19:30:25.038897Z","end":"2026-06-15T19:30:25.379338Z","steps":["trace[484720332] 'count revisions from in-memory index tree' (duration: 340.348648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.608159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.379368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.985273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.379416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.038893Z","time spent":"340.512411ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:30:25.37944Z","caller":"traceutil/trace.go:171","msg":"trace[338316624] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8258; }","duration":"307.780622ms","start":"2026-06-15T19:30:25.071637Z","end":"2026-06-15T19:30:25.379418Z","steps":["trace[338316624] 'range keys from in-memory index tree' (duration: 307.541478ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.37945Z","caller":"traceutil/trace.go:171","msg":"trace[1207940022] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8258; }","duration":"293.121535ms","start":"2026-06-15T19:30:25.086312Z","end":"2026-06-15T19:30:25.379434Z","steps":["trace[1207940022] 'range keys from in-memory index tree' (duration: 292.9071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.071601Z","time spent":"307.880464ms","remote":"127.0.0.1:36750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "} {"level":"warn","ts":"2026-06-15T19:30:25.3796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.973526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.379653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.752008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.379662Z","caller":"traceutil/trace.go:171","msg":"trace[842234581] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8258; }","duration":"308.139369ms","start":"2026-06-15T19:30:25.071508Z","end":"2026-06-15T19:30:25.379648Z","steps":["trace[842234581] 'count revisions from in-memory index tree' (duration: 307.828213ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.379683Z","caller":"traceutil/trace.go:171","msg":"trace[647186499] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8258; }","duration":"292.807479ms","start":"2026-06-15T19:30:25.086867Z","end":"2026-06-15T19:30:25.379674Z","steps":["trace[647186499] 'range keys from in-memory index tree' (duration: 292.669706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.071483Z","time spent":"308.21741ms","remote":"127.0.0.1:36750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:30:25.379744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.908688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.379779Z","caller":"traceutil/trace.go:171","msg":"trace[963573146] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8258; }","duration":"340.98527ms","start":"2026-06-15T19:30:25.038785Z","end":"2026-06-15T19:30:25.37977Z","steps":["trace[963573146] 'range keys from in-memory index tree' (duration: 340.767256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.038759Z","time spent":"341.04829ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 "} {"level":"warn","ts":"2026-06-15T19:30:25.379912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.681183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.379911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.667064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.379209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.372998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.379955Z","caller":"traceutil/trace.go:171","msg":"trace[910094973] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8258; }","duration":"276.740455ms","start":"2026-06-15T19:30:25.103203Z","end":"2026-06-15T19:30:25.379944Z","steps":["trace[910094973] 'count revisions from in-memory index tree' (duration: 276.589302ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.379968Z","caller":"traceutil/trace.go:171","msg":"trace[2049250321] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8258; }","duration":"340.740375ms","start":"2026-06-15T19:30:25.039211Z","end":"2026-06-15T19:30:25.379952Z","steps":["trace[2049250321] 'range keys from in-memory index tree' (duration: 340.631094ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.379976Z","caller":"traceutil/trace.go:171","msg":"trace[718914228] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8258; }","duration":"324.212253ms","start":"2026-06-15T19:30:25.055749Z","end":"2026-06-15T19:30:25.379961Z","steps":["trace[718914228] 'range keys from in-memory index tree' (duration: 323.204204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.039205Z","time spent":"340.789706ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 "} {"level":"warn","ts":"2026-06-15T19:30:25.380022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.055725Z","time spent":"324.282254ms","remote":"127.0.0.1:36736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 "} {"level":"warn","ts":"2026-06-15T19:30:25.380007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.182906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.380048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.946284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.380079Z","caller":"traceutil/trace.go:171","msg":"trace[1607872036] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8258; }","duration":"320.302638ms","start":"2026-06-15T19:30:25.059754Z","end":"2026-06-15T19:30:25.380057Z","steps":["trace[1607872036] 'range keys from in-memory index tree' (duration: 320.122955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.784977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.380098Z","caller":"traceutil/trace.go:171","msg":"trace[152125076] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8258; }","duration":"308.031547ms","start":"2026-06-15T19:30:25.072054Z","end":"2026-06-15T19:30:25.380086Z","steps":["trace[152125076] 'range keys from in-memory index tree' (duration: 307.842272ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.38013Z","caller":"traceutil/trace.go:171","msg":"trace[1742327247] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8258; }","duration":"276.862027ms","start":"2026-06-15T19:30:25.10326Z","end":"2026-06-15T19:30:25.380122Z","steps":["trace[1742327247] 'range keys from in-memory index tree' (duration: 276.714854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.059747Z","time spent":"320.367461ms","remote":"127.0.0.1:36736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 "} {"level":"warn","ts":"2026-06-15T19:30:25.38015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.072042Z","time spent":"308.086149ms","remote":"127.0.0.1:36750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "} {"level":"warn","ts":"2026-06-15T19:30:25.380305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.036753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.380355Z","caller":"traceutil/trace.go:171","msg":"trace[2048443778] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8258; }","duration":"276.129594ms","start":"2026-06-15T19:30:25.104208Z","end":"2026-06-15T19:30:25.380338Z","steps":["trace[2048443778] 'range keys from in-memory index tree' (duration: 275.95797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.781659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.380536Z","caller":"traceutil/trace.go:171","msg":"trace[544647054] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8258; }","duration":"256.847939ms","start":"2026-06-15T19:30:25.123677Z","end":"2026-06-15T19:30:25.380525Z","steps":["trace[544647054] 'range keys from in-memory index tree' (duration: 256.685627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.019741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-15T19:30:25.380695Z","caller":"traceutil/trace.go:171","msg":"trace[1143095354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8258; }","duration":"231.114342ms","start":"2026-06-15T19:30:25.149566Z","end":"2026-06-15T19:30:25.38068Z","steps":["trace[1143095354] 'range keys from in-memory index tree' (duration: 230.840807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.380681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.471662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:30:25.380707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.968872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.380739Z","caller":"traceutil/trace.go:171","msg":"trace[1813038957] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8258; }","duration":"256.550113ms","start":"2026-06-15T19:30:25.124173Z","end":"2026-06-15T19:30:25.380723Z","steps":["trace[1813038957] 'range keys from in-memory index tree' (duration: 256.425101ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.380761Z","caller":"traceutil/trace.go:171","msg":"trace[707396837] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8258; }","duration":"257.068794ms","start":"2026-06-15T19:30:25.123677Z","end":"2026-06-15T19:30:25.380746Z","steps":["trace[707396837] 'count revisions from in-memory index tree' (duration: 256.84327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.379941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.05458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:25.38083Z","caller":"traceutil/trace.go:171","msg":"trace[1900746737] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8258; }","duration":"324.920726ms","start":"2026-06-15T19:30:25.055869Z","end":"2026-06-15T19:30:25.38079Z","steps":["trace[1900746737] 'count revisions from in-memory index tree' (duration: 324.013199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:25.38087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:30:25.055864Z","time spent":"324.994328ms","remote":"127.0.0.1:36736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:30:25.496925Z","caller":"traceutil/trace.go:171","msg":"trace[1014775879] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"233.696851ms","start":"2026-06-15T19:30:25.263173Z","end":"2026-06-15T19:30:25.49687Z","steps":["trace[1014775879] 'process raft request' (duration: 233.538459ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:25.49767Z","caller":"traceutil/trace.go:171","msg":"trace[154398871] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"113.077898ms","start":"2026-06-15T19:30:25.38456Z","end":"2026-06-15T19:30:25.497638Z","steps":["trace[154398871] 'process raft request' (duration: 112.956606ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:36.226353Z","caller":"traceutil/trace.go:171","msg":"trace[555372651] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"102.398847ms","start":"2026-06-15T19:30:36.123932Z","end":"2026-06-15T19:30:36.226331Z","steps":["trace[555372651] 'process raft request' (duration: 102.244014ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:36.457669Z","caller":"traceutil/trace.go:171","msg":"trace[1037702939] transaction","detail":"{read_only:false; response_revision:8319; number_of_response:1; }","duration":"228.36691ms","start":"2026-06-15T19:30:36.229269Z","end":"2026-06-15T19:30:36.457636Z","steps":["trace[1037702939] 'process raft request' (duration: 170.853942ms)","trace[1037702939] 'compare' (duration: 57.383975ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:30:37.195977Z","caller":"traceutil/trace.go:171","msg":"trace[1308345891] linearizableReadLoop","detail":"{readStateIndex:8614; appliedIndex:8613; }","duration":"157.171474ms","start":"2026-06-15T19:30:37.038777Z","end":"2026-06-15T19:30:37.195948Z","steps":["trace[1308345891] 'read index received' (duration: 155.792128ms)","trace[1308345891] 'applied index is now lower than readState.Index' (duration: 1.377126ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:30:37.195985Z","caller":"traceutil/trace.go:171","msg":"trace[1465788939] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"210.775447ms","start":"2026-06-15T19:30:36.985185Z","end":"2026-06-15T19:30:37.195961Z","steps":["trace[1465788939] 'process raft request' (duration: 209.429412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:37.196255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.470309ms","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-06-15T19:30:37.196341Z","caller":"traceutil/trace.go:171","msg":"trace[840598185] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8324; }","duration":"157.600262ms","start":"2026-06-15T19:30:37.038722Z","end":"2026-06-15T19:30:37.196322Z","steps":["trace[840598185] 'agreement among raft nodes before linearized reading' (duration: 157.337667ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:43.929409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6193} {"level":"info","ts":"2026-06-15T19:30:44.027876Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6193,"took":"96.530526ms","hash":3024497316,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":23183360,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-15T19:30:44.028059Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3024497316,"revision":6193,"compact-revision":3027} {"level":"info","ts":"2026-06-15T19:31:06.111739Z","caller":"traceutil/trace.go:171","msg":"trace[1901773385] linearizableReadLoop","detail":"{readStateIndex:8831; appliedIndex:8830; }","duration":"421.692177ms","start":"2026-06-15T19:31:05.68998Z","end":"2026-06-15T19:31:06.111672Z","steps":["trace[1901773385] 'read index received' (duration: 421.516004ms)","trace[1901773385] 'applied index is now lower than readState.Index' (duration: 174.963µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:31:06.112079Z","caller":"traceutil/trace.go:171","msg":"trace[1995364972] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"422.778808ms","start":"2026-06-15T19:31:05.689282Z","end":"2026-06-15T19:31:06.112061Z","steps":["trace[1995364972] 'process raft request' (duration: 422.221078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:31:06.112206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:31:05.689266Z","time spent":"422.863599ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:31:06.112581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.597133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-15T19:31:06.112635Z","caller":"traceutil/trace.go:171","msg":"trace[1810915583] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8533; }","duration":"422.699595ms","start":"2026-06-15T19:31:05.68992Z","end":"2026-06-15T19:31:06.11262Z","steps":["trace[1810915583] 'agreement among raft nodes before linearized reading' (duration: 422.505152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:31:06.112693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:31:05.689894Z","time spent":"422.764948ms","remote":"127.0.0.1:52578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5672,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-15T19:31:06.113463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.403892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:31:06.113535Z","caller":"traceutil/trace.go:171","msg":"trace[1615291613] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8534; }","duration":"338.545435ms","start":"2026-06-15T19:31:05.774974Z","end":"2026-06-15T19:31:06.11352Z","steps":["trace[1615291613] 'agreement among raft nodes before linearized reading' (duration: 338.434803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:31:06.113567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:31:05.774954Z","time spent":"338.603915ms","remote":"127.0.0.1:44810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:31:06.113779Z","caller":"traceutil/trace.go:171","msg":"trace[596499840] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"415.276875ms","start":"2026-06-15T19:31:05.698492Z","end":"2026-06-15T19:31:06.113769Z","steps":["trace[596499840] 'process raft request' (duration: 414.854587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:31:06.113844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:31:05.698474Z","time spent":"415.336747ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:31:06.113981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.276248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:31:06.114012Z","caller":"traceutil/trace.go:171","msg":"trace[624976511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8534; }","duration":"108.345009ms","start":"2026-06-15T19:31:06.005658Z","end":"2026-06-15T19:31:06.114003Z","steps":["trace[624976511] 'agreement among raft nodes before linearized reading' (duration: 108.297128ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:31:08.702042Z","caller":"traceutil/trace.go:171","msg":"trace[916984404] transaction","detail":"{read_only:false; response_revision:8549; number_of_response:1; }","duration":"108.413782ms","start":"2026-06-15T19:31:08.593607Z","end":"2026-06-15T19:31:08.702021Z","steps":["trace[916984404] 'process raft request' (duration: 108.259729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:31:08.907908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.416952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:31:08.908325Z","caller":"traceutil/trace.go:171","msg":"trace[55392030] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"218.515754ms","start":"2026-06-15T19:31:08.689788Z","end":"2026-06-15T19:31:08.908304Z","steps":["trace[55392030] 'process raft request' (duration: 73.632613ms)","trace[55392030] 'compare' (duration: 143.673008ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:31:08.908525Z","caller":"traceutil/trace.go:171","msg":"trace[940472457] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"202.177945ms","start":"2026-06-15T19:31:08.706336Z","end":"2026-06-15T19:31:08.908514Z","steps":["trace[940472457] 'process raft request' (duration: 201.666495ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:31:08.908689Z","caller":"traceutil/trace.go:171","msg":"trace[243090886] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"191.36128ms","start":"2026-06-15T19:31:08.717318Z","end":"2026-06-15T19:31:08.90868Z","steps":["trace[243090886] 'process raft request' (duration: 190.752199ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:32:04.213913Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024c8.wal"} {"level":"info","ts":"2026-06-15T19:32:29.909215Z","caller":"traceutil/trace.go:171","msg":"trace[119642406] transaction","detail":"{read_only:false; response_revision:9366; number_of_response:1; }","duration":"121.02385ms","start":"2026-06-15T19:32:29.788168Z","end":"2026-06-15T19:32:29.909191Z","steps":["trace[119642406] 'process raft request' (duration: 120.832316ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:33:10.099228Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T19:33:10.105136Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T19:33:10.105206Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-15T19:35:43.938575Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8364} {"level":"info","ts":"2026-06-15T19:35:44.020896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8364,"took":"80.207235ms","hash":1923129962,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":26529792,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-15T19:35:44.020947Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1923129962,"revision":8364,"compact-revision":6193} {"level":"warn","ts":"2026-06-15T19:36:12.032918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.001781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:36:12.033029Z","caller":"traceutil/trace.go:171","msg":"trace[925033889] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:11208; }","duration":"160.192355ms","start":"2026-06-15T19:36:11.872813Z","end":"2026-06-15T19:36:12.033006Z","steps":["trace[925033889] 'count revisions from in-memory index tree' (duration: 159.881769ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:36:12.033014Z","caller":"traceutil/trace.go:171","msg":"trace[210694492] transaction","detail":"{read_only:false; response_revision:11209; number_of_response:1; }","duration":"148.158728ms","start":"2026-06-15T19:36:11.884809Z","end":"2026-06-15T19:36:12.032968Z","steps":["trace[210694492] 'process raft request' (duration: 127.285024ms)","trace[210694492] 'compare' (duration: 20.753012ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:36:12.03292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.164789ms","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-06-15T19:36:12.033182Z","caller":"traceutil/trace.go:171","msg":"trace[129051040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11208; }","duration":"201.489025ms","start":"2026-06-15T19:36:11.831672Z","end":"2026-06-15T19:36:12.033161Z","steps":["trace[129051040] 'range keys from in-memory index tree' (duration: 200.934354ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:40:43.946346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11030} {"level":"info","ts":"2026-06-15T19:40:44.0351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11030,"took":"86.100854ms","hash":3436717640,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":28049408,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-15T19:40:44.035159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3436717640,"revision":11030,"compact-revision":8364} {"level":"info","ts":"2026-06-15T19:42:37.711688Z","caller":"traceutil/trace.go:171","msg":"trace[1555344530] transaction","detail":"{read_only:false; response_revision:13790; number_of_response:1; }","duration":"222.266834ms","start":"2026-06-15T19:42:37.489394Z","end":"2026-06-15T19:42:37.711661Z","steps":["trace[1555344530] 'process raft request' (duration: 222.101421ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:42:37.713049Z","caller":"traceutil/trace.go:171","msg":"trace[1138654288] transaction","detail":"{read_only:false; response_revision:13791; number_of_response:1; }","duration":"217.798869ms","start":"2026-06-15T19:42:37.495229Z","end":"2026-06-15T19:42:37.713028Z","steps":["trace[1138654288] 'process raft request' (duration: 217.467243ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:42:37.713143Z","caller":"traceutil/trace.go:171","msg":"trace[1807659641] transaction","detail":"{read_only:false; response_revision:13792; number_of_response:1; }","duration":"123.711395ms","start":"2026-06-15T19:42:37.589404Z","end":"2026-06-15T19:42:37.713116Z","steps":["trace[1807659641] 'process raft request' (duration: 123.45755ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:42:54.834112Z","caller":"traceutil/trace.go:171","msg":"trace[670625439] linearizableReadLoop","detail":"{readStateIndex:14369; appliedIndex:14368; }","duration":"418.577977ms","start":"2026-06-15T19:42:54.415508Z","end":"2026-06-15T19:42:54.834086Z","steps":["trace[670625439] 'read index received' (duration: 418.478105ms)","trace[670625439] 'applied index is now lower than readState.Index' (duration: 98.842µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:42:54.834176Z","caller":"traceutil/trace.go:171","msg":"trace[695386780] transaction","detail":"{read_only:false; response_revision:13893; number_of_response:1; }","duration":"435.864433ms","start":"2026-06-15T19:42:54.398277Z","end":"2026-06-15T19:42:54.834141Z","steps":["trace[695386780] 'process raft request' (duration: 435.671539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:42:54.834265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.73763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:42:54.834298Z","caller":"traceutil/trace.go:171","msg":"trace[492520199] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:13893; }","duration":"418.833671ms","start":"2026-06-15T19:42:54.415455Z","end":"2026-06-15T19:42:54.834289Z","steps":["trace[492520199] 'agreement among raft nodes before linearized reading' (duration: 418.75615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:42:54.834341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:42:54.415429Z","time spent":"418.904403ms","remote":"127.0.0.1:44742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":26,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-15T19:42:54.834363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:42:54.398253Z","time spent":"436.007686ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:42:54.87027Z","caller":"traceutil/trace.go:171","msg":"trace[424704310] transaction","detail":"{read_only:false; response_revision:13894; number_of_response:1; }","duration":"238.743815ms","start":"2026-06-15T19:42:54.631499Z","end":"2026-06-15T19:42:54.870243Z","steps":["trace[424704310] 'process raft request' (duration: 217.247729ms)","trace[424704310] 'compare' (duration: 21.344943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:42:54.870333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.341228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/openstack/ovn-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:42:54.870381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.033892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:42:54.870471Z","caller":"traceutil/trace.go:171","msg":"trace[155034170] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:13894; }","duration":"237.133984ms","start":"2026-06-15T19:42:54.633319Z","end":"2026-06-15T19:42:54.870453Z","steps":["trace[155034170] 'agreement among raft nodes before linearized reading' (duration: 236.991671ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:42:54.870418Z","caller":"traceutil/trace.go:171","msg":"trace[1241186561] range","detail":"{range_begin:/registry/daemonsets/openstack/ovn-controller; range_end:; response_count:0; response_revision:13894; }","duration":"193.48635ms","start":"2026-06-15T19:42:54.676912Z","end":"2026-06-15T19:42:54.870399Z","steps":["trace[1241186561] 'agreement among raft nodes before linearized reading' (duration: 193.330807ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:44:42.442835Z","caller":"traceutil/trace.go:171","msg":"trace[1590872964] transaction","detail":"{read_only:false; response_revision:15139; number_of_response:1; }","duration":"107.758246ms","start":"2026-06-15T19:44:42.335044Z","end":"2026-06-15T19:44:42.442802Z","steps":["trace[1590872964] 'process raft request' (duration: 107.321718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.051038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.685636ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:44:43.051168Z","caller":"traceutil/trace.go:171","msg":"trace[455929479] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:15139; }","duration":"452.848079ms","start":"2026-06-15T19:44:42.598301Z","end":"2026-06-15T19:44:43.051149Z","steps":["trace[455929479] 'range keys from in-memory index tree' (duration: 452.651185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.051162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.381689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:44:43.051318Z","caller":"traceutil/trace.go:171","msg":"trace[1787105688] linearizableReadLoop","detail":"{readStateIndex:15653; appliedIndex:15652; }","duration":"529.653242ms","start":"2026-06-15T19:44:42.521603Z","end":"2026-06-15T19:44:43.051257Z","steps":["trace[1787105688] 'read index received' (duration: 267.001057ms)","trace[1787105688] 'applied index is now lower than readState.Index' (duration: 262.650515ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:44:43.05134Z","caller":"traceutil/trace.go:171","msg":"trace[1108445469] transaction","detail":"{read_only:false; response_revision:15140; number_of_response:1; }","duration":"536.036572ms","start":"2026-06-15T19:44:42.515269Z","end":"2026-06-15T19:44:43.051306Z","steps":["trace[1108445469] 'process raft request' (duration: 273.428418ms)","trace[1108445469] 'compare' (duration: 262.166565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:44:43.051546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.977863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"warn","ts":"2026-06-15T19:44:43.051571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.501425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-15T19:44:43.051546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.887656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:44:43.051657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.586369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:44:43.051661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.515238Z","time spent":"536.171464ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:44:43.051701Z","caller":"traceutil/trace.go:171","msg":"trace[1936680633] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15140; }","duration":"357.64003ms","start":"2026-06-15T19:44:42.69405Z","end":"2026-06-15T19:44:43.05169Z","steps":["trace[1936680633] 'agreement among raft nodes before linearized reading' (duration: 357.574869ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:44:43.051695Z","caller":"traceutil/trace.go:171","msg":"trace[531172182] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15140; }","duration":"530.066319ms","start":"2026-06-15T19:44:42.521596Z","end":"2026-06-15T19:44:43.051662Z","steps":["trace[531172182] 'agreement among raft nodes before linearized reading' (duration: 529.795884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.051774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.736172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:44:43.051794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.521541Z","time spent":"530.237372ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-06-15T19:44:43.051858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.819904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:44:43.051892Z","caller":"traceutil/trace.go:171","msg":"trace[1438772887] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15140; }","duration":"357.896645ms","start":"2026-06-15T19:44:42.693987Z","end":"2026-06-15T19:44:43.051884Z","steps":["trace[1438772887] 'agreement among raft nodes before linearized reading' (duration: 357.849544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.051926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.693963Z","time spent":"357.957186ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":26,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-06-15T19:44:43.051834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.671712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-ksjkk\" ","response":"range_response_count:1 size:9788"} {"level":"warn","ts":"2026-06-15T19:44:43.052014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.64564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-15T19:44:43.052043Z","caller":"traceutil/trace.go:171","msg":"trace[1167063021] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-ksjkk; range_end:; response_count:1; response_revision:15140; }","duration":"246.972647ms","start":"2026-06-15T19:44:42.805062Z","end":"2026-06-15T19:44:43.052034Z","steps":["trace[1167063021] 'agreement among raft nodes before linearized reading' (duration: 246.644481ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:44:43.052063Z","caller":"traceutil/trace.go:171","msg":"trace[612800912] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15140; }","duration":"311.741092ms","start":"2026-06-15T19:44:42.740308Z","end":"2026-06-15T19:44:43.052049Z","steps":["trace[612800912] 'agreement among raft nodes before linearized reading' (duration: 311.571109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.05206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.396741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-15T19:44:43.052106Z","caller":"traceutil/trace.go:171","msg":"trace[123836648] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15140; }","duration":"515.441922ms","start":"2026-06-15T19:44:42.536652Z","end":"2026-06-15T19:44:43.052094Z","steps":["trace[123836648] 'agreement among raft nodes before linearized reading' (duration: 515.295609ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:44:43.051813Z","caller":"traceutil/trace.go:171","msg":"trace[101732392] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15140; }","duration":"357.817964ms","start":"2026-06-15T19:44:42.693987Z","end":"2026-06-15T19:44:43.051805Z","steps":["trace[101732392] 'agreement among raft nodes before linearized reading' (duration: 357.770153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.052128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.740288Z","time spent":"311.810553ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5542,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-06-15T19:44:43.052153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.536575Z","time spent":"515.570414ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5542,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-06-15T19:44:43.052182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.693964Z","time spent":"358.205111ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"info","ts":"2026-06-15T19:44:43.051655Z","caller":"traceutil/trace.go:171","msg":"trace[738117806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15140; }","duration":"331.583387ms","start":"2026-06-15T19:44:42.720055Z","end":"2026-06-15T19:44:43.051638Z","steps":["trace[738117806] 'agreement among raft nodes before linearized reading' (duration: 331.361233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.052229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.719983Z","time spent":"332.234999ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:44:43.051737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.694045Z","time spent":"357.68478ms","remote":"127.0.0.1:44472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"info","ts":"2026-06-15T19:44:43.0516Z","caller":"traceutil/trace.go:171","msg":"trace[2011389986] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15140; }","duration":"515.060265ms","start":"2026-06-15T19:44:42.536525Z","end":"2026-06-15T19:44:43.051586Z","steps":["trace[2011389986] 'agreement among raft nodes before linearized reading' (duration: 514.893352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:44:43.05232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:44:42.53651Z","time spent":"515.797748ms","remote":"127.0.0.1:44408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"info","ts":"2026-06-15T19:44:43.198048Z","caller":"traceutil/trace.go:171","msg":"trace[166533245] linearizableReadLoop","detail":"{readStateIndex:15654; appliedIndex:15653; }","duration":"139.349963ms","start":"2026-06-15T19:44:43.058665Z","end":"2026-06-15T19:44:43.198015Z","steps":["trace[166533245] 'read index received' (duration: 109.714003ms)","trace[166533245] 'applied index is now lower than readState.Index' (duration: 29.63471ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:44:43.19817Z","caller":"traceutil/trace.go:171","msg":"trace[153711944] transaction","detail":"{read_only:false; response_revision:15141; number_of_response:1; }","duration":"140.934344ms","start":"2026-06-15T19:44:43.057168Z","end":"2026-06-15T19:44:43.198102Z","steps":["trace[153711944] 'process raft request' (duration: 111.315764ms)","trace[153711944] 'compare' (duration: 29.379605ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:44:43.199377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.656079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769808"} {"level":"info","ts":"2026-06-15T19:44:43.199494Z","caller":"traceutil/trace.go:171","msg":"trace[1076831778] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15141; }","duration":"140.848541ms","start":"2026-06-15T19:44:43.058618Z","end":"2026-06-15T19:44:43.199467Z","steps":["trace[1076831778] 'agreement among raft nodes before linearized reading' (duration: 139.519216ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:45:43.954154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13064} {"level":"info","ts":"2026-06-15T19:45:44.037388Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13064,"took":"81.175295ms","hash":1453535097,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":30699520,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-15T19:45:44.037483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1453535097,"revision":13064,"compact-revision":11030} {"level":"info","ts":"2026-06-15T19:50:27.736605Z","caller":"traceutil/trace.go:171","msg":"trace[773271576] transaction","detail":"{read_only:false; response_revision:17669; number_of_response:1; }","duration":"269.271146ms","start":"2026-06-15T19:50:27.467308Z","end":"2026-06-15T19:50:27.736579Z","steps":["trace[773271576] 'process raft request' (duration: 269.088933ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:27.741131Z","caller":"traceutil/trace.go:171","msg":"trace[1452565038] linearizableReadLoop","detail":"{readStateIndex:18268; appliedIndex:18265; }","duration":"147.830163ms","start":"2026-06-15T19:50:27.59325Z","end":"2026-06-15T19:50:27.741081Z","steps":["trace[1452565038] 'read index received' (duration: 143.143574ms)","trace[1452565038] 'applied index is now lower than readState.Index' (duration: 4.685179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:27.74134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.068497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:27.741488Z","caller":"traceutil/trace.go:171","msg":"trace[411880703] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:17671; }","duration":"148.23455ms","start":"2026-06-15T19:50:27.593212Z","end":"2026-06-15T19:50:27.741447Z","steps":["trace[411880703] 'agreement among raft nodes before linearized reading' (duration: 148.016626ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:27.741552Z","caller":"traceutil/trace.go:171","msg":"trace[1302120020] transaction","detail":"{read_only:false; response_revision:17670; number_of_response:1; }","duration":"267.197407ms","start":"2026-06-15T19:50:27.474319Z","end":"2026-06-15T19:50:27.741516Z","steps":["trace[1302120020] 'process raft request' (duration: 266.429353ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:27.741579Z","caller":"traceutil/trace.go:171","msg":"trace[201236980] transaction","detail":"{read_only:false; response_revision:17671; number_of_response:1; }","duration":"260.299716ms","start":"2026-06-15T19:50:27.481244Z","end":"2026-06-15T19:50:27.741544Z","steps":["trace[201236980] 'process raft request' (duration: 259.763666ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:28.484581Z","caller":"traceutil/trace.go:171","msg":"trace[718930688] linearizableReadLoop","detail":"{readStateIndex:18269; appliedIndex:18268; }","duration":"148.998086ms","start":"2026-06-15T19:50:28.335565Z","end":"2026-06-15T19:50:28.484563Z","steps":["trace[718930688] 'read index received' (duration: 148.839683ms)","trace[718930688] 'applied index is now lower than readState.Index' (duration: 157.733µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:28.484721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.141998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:28.484704Z","caller":"traceutil/trace.go:171","msg":"trace[1992597987] transaction","detail":"{read_only:false; response_revision:17672; number_of_response:1; }","duration":"331.542578ms","start":"2026-06-15T19:50:28.153131Z","end":"2026-06-15T19:50:28.484674Z","steps":["trace[1992597987] 'process raft request' (duration: 331.316263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:28.484834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.83831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-06-15T19:50:28.484857Z","caller":"traceutil/trace.go:171","msg":"trace[851648049] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17672; }","duration":"130.913912ms","start":"2026-06-15T19:50:28.353938Z","end":"2026-06-15T19:50:28.484852Z","steps":["trace[851648049] 'agreement among raft nodes before linearized reading' (duration: 130.82857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:28.484852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:28.15312Z","time spent":"331.65815ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:28.484751Z","caller":"traceutil/trace.go:171","msg":"trace[1421623801] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:17672; }","duration":"149.22283ms","start":"2026-06-15T19:50:28.33552Z","end":"2026-06-15T19:50:28.484743Z","steps":["trace[1421623801] 'agreement among raft nodes before linearized reading' (duration: 149.137028ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:28.66836Z","caller":"traceutil/trace.go:171","msg":"trace[1147402090] transaction","detail":"{read_only:false; response_revision:17673; number_of_response:1; }","duration":"132.323719ms","start":"2026-06-15T19:50:28.536002Z","end":"2026-06-15T19:50:28.668326Z","steps":["trace[1147402090] 'process raft request' (duration: 126.760074ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:43.964573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15522} {"level":"info","ts":"2026-06-15T19:50:44.059544Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15522,"took":"91.773039ms","hash":3873791652,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":31850496,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T19:50:44.059626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3873791652,"revision":15522,"compact-revision":13064} {"level":"info","ts":"2026-06-15T19:55:28.870993Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T19:55:28.875886Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-15T19:55:28.876094Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-15T19:55:43.974179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17842} {"level":"info","ts":"2026-06-15T19:55:44.07035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17842,"took":"92.318058ms","hash":2800515211,"current-db-size-bytes":57581568,"current-db-size":"58 MB","current-db-size-in-use-bytes":26996736,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-15T19:55:44.070415Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2800515211,"revision":17842,"compact-revision":15522}