{"level":"warn","ts":"2026-07-08T21:34:49.280624Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T21:34:49.280708Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-08T21:34:49.280769Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T21:34:49.280779Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-07-08T21:34:49.280794Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T21:34:49.281397Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-07-08T21:34:49.281463Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-08T21:34:49.286084Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.414888ms"} {"level":"info","ts":"2026-07-08T21:34:49.29192Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-07-08T21:34:49.291994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T21:34:49.292018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-07-08T21:34:49.292036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T21:34:49.292049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-07-08T21:34:49.292098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-07-08T21:34:49.297706Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T21:34:49.299226Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T21:34:49.300868Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-08T21:34:49.304073Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T21:34:49.304907Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T21:34:49.305125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-07-08T21:34:49.305089Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T21:34:49.305218Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T21:34:49.30522Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-07-08T21:34:49.305231Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T21:34:49.309365Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T21:34:49.309536Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-07-08T21:34:49.309605Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-07-08T21:34:49.309877Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T21:34:49.309949Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T21:34:49.693082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T21:34:49.693189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T21:34:49.693229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-07-08T21:34:49.693253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-07-08T21:34:49.693268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-07-08T21:34:49.693283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-07-08T21:34:49.6933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-07-08T21:34:49.70154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T21:34:49.701571Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T21:34:49.701706Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T21:34:49.701752Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T21:34:49.702045Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T21:34:49.702149Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T21:34:49.702635Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T21:34:49.702785Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T21:34:49.702823Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T21:34:49.705359Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T21:34:49.705566Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"info","ts":"2026-07-08T21:35:07.913821Z","caller":"traceutil/trace.go:171","msg":"trace[37042418] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"158.368845ms","start":"2026-07-08T21:35:07.755419Z","end":"2026-07-08T21:35:07.913788Z","steps":["trace[37042418] 'read index received' (duration: 158.14289ms)","trace[37042418] 'applied index is now lower than readState.Index' (duration: 224.635µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:35:07.913896Z","caller":"traceutil/trace.go:171","msg":"trace[748669540] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"182.621873ms","start":"2026-07-08T21:35:07.731225Z","end":"2026-07-08T21:35:07.913847Z","steps":["trace[748669540] 'process raft request' (duration: 182.327297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:07.914015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.565429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T21:35:07.914117Z","caller":"traceutil/trace.go:171","msg":"trace[1914983694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:373; }","duration":"158.733073ms","start":"2026-07-08T21:35:07.755365Z","end":"2026-07-08T21:35:07.914098Z","steps":["trace[1914983694] 'agreement among raft nodes before linearized reading' (duration: 158.562709ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:35:08.186426Z","caller":"traceutil/trace.go:171","msg":"trace[206350199] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"195.829175ms","start":"2026-07-08T21:35:07.990558Z","end":"2026-07-08T21:35:08.186387Z","steps":["trace[206350199] 'read index received' (duration: 195.427147ms)","trace[206350199] 'applied index is now lower than readState.Index' (duration: 400.568µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:35:08.186521Z","caller":"traceutil/trace.go:171","msg":"trace[579778924] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"258.500127ms","start":"2026-07-08T21:35:07.927981Z","end":"2026-07-08T21:35:08.186481Z","steps":["trace[579778924] 'process raft request' (duration: 258.1756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:08.186708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.281633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T21:35:08.186761Z","caller":"traceutil/trace.go:171","msg":"trace[272787874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:375; }","duration":"176.445106ms","start":"2026-07-08T21:35:08.010303Z","end":"2026-07-08T21:35:08.186748Z","steps":["trace[272787874] 'agreement among raft nodes before linearized reading' (duration: 176.277023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:08.18673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.102573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-08T21:35:08.18686Z","caller":"traceutil/trace.go:171","msg":"trace[412414877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:375; }","duration":"196.327598ms","start":"2026-07-08T21:35:07.990503Z","end":"2026-07-08T21:35:08.18683Z","steps":["trace[412414877] 'agreement among raft nodes before linearized reading' (duration: 196.031212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:08.18693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.260868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:35:08.187184Z","caller":"traceutil/trace.go:171","msg":"trace[344950920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:375; }","duration":"124.504854ms","start":"2026-07-08T21:35:08.062581Z","end":"2026-07-08T21:35:08.187086Z","steps":["trace[344950920] 'agreement among raft nodes before linearized reading' (duration: 124.271859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:08.340628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.560313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:35:08.340971Z","caller":"traceutil/trace.go:171","msg":"trace[1189989422] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"148.888245ms","start":"2026-07-08T21:35:08.192017Z","end":"2026-07-08T21:35:08.340905Z","steps":["trace[1189989422] 'process raft request' (duration: 33.069784ms)","trace[1189989422] 'compare' (duration: 114.359358ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:35:08.34112Z","caller":"traceutil/trace.go:171","msg":"trace[1947816465] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"149.047228ms","start":"2026-07-08T21:35:08.192018Z","end":"2026-07-08T21:35:08.341065Z","steps":["trace[1947816465] 'process raft request' (duration: 148.749472ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:35:08.341044Z","caller":"traceutil/trace.go:171","msg":"trace[1838635091] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:388; }","duration":"129.286059ms","start":"2026-07-08T21:35:08.211724Z","end":"2026-07-08T21:35:08.34101Z","steps":["trace[1838635091] 'read index received' (duration: 13.355995ms)","trace[1838635091] 'applied index is now lower than readState.Index' (duration: 115.928394ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:35:08.341347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.559756ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:35:08.341456Z","caller":"traceutil/trace.go:171","msg":"trace[1895772459] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:377; }","duration":"129.73106ms","start":"2026-07-08T21:35:08.211712Z","end":"2026-07-08T21:35:08.341443Z","steps":["trace[1895772459] 'agreement among raft nodes before linearized reading' (duration: 129.367492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:36.567076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.53132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:35:36.567232Z","caller":"traceutil/trace.go:171","msg":"trace[631819055] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"174.173048ms","start":"2026-07-08T21:35:36.39302Z","end":"2026-07-08T21:35:36.567193Z","steps":["trace[631819055] 'process raft request' (duration: 21.431584ms)","trace[631819055] 'compare' (duration: 152.239033ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:35:36.863875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.061335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:35:36.864245Z","caller":"traceutil/trace.go:171","msg":"trace[84006394] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"291.997589ms","start":"2026-07-08T21:35:36.57213Z","end":"2026-07-08T21:35:36.864127Z","steps":["trace[84006394] 'process raft request' (duration: 98.555907ms)","trace[84006394] 'compare' (duration: 192.827539ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:35:36.864314Z","caller":"traceutil/trace.go:171","msg":"trace[1802812709] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"285.726301ms","start":"2026-07-08T21:35:36.578538Z","end":"2026-07-08T21:35:36.864264Z","steps":["trace[1802812709] 'read index received' (duration: 92.168305ms)","trace[1802812709] 'applied index is now lower than readState.Index' (duration: 193.555306ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:35:36.864518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.977147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:35:36.864564Z","caller":"traceutil/trace.go:171","msg":"trace[1295550894] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:601; }","duration":"286.068839ms","start":"2026-07-08T21:35:36.578482Z","end":"2026-07-08T21:35:36.864551Z","steps":["trace[1295550894] 'agreement among raft nodes before linearized reading' (duration: 285.992697ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:35:36.864413Z","caller":"traceutil/trace.go:171","msg":"trace[664976275] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"292.242526ms","start":"2026-07-08T21:35:36.572152Z","end":"2026-07-08T21:35:36.864394Z","steps":["trace[664976275] 'process raft request' (duration: 291.894798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:36.86484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.232433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-08T21:35:36.865188Z","caller":"traceutil/trace.go:171","msg":"trace[2099864770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"143.53108ms","start":"2026-07-08T21:35:36.721513Z","end":"2026-07-08T21:35:36.865044Z","steps":["trace[2099864770] 'agreement among raft nodes before linearized reading' (duration: 143.047459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:37.322016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.83445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:35:37.322289Z","caller":"traceutil/trace.go:171","msg":"trace[262631250] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"260.371702ms","start":"2026-07-08T21:35:37.061901Z","end":"2026-07-08T21:35:37.322273Z","steps":["trace[262631250] 'read index received' (duration: 72.179555ms)","trace[262631250] 'applied index is now lower than readState.Index' (duration: 188.190967ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:35:37.322366Z","caller":"traceutil/trace.go:171","msg":"trace[1446383375] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"450.755128ms","start":"2026-07-08T21:35:36.871552Z","end":"2026-07-08T21:35:37.322307Z","steps":["trace[1446383375] 'process raft request' (duration: 262.52877ms)","trace[1446383375] 'compare' (duration: 187.668786ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:35:37.32241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.486764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T21:35:37.322601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T21:35:36.871512Z","time spent":"450.978413ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T21:35:37.322706Z","caller":"traceutil/trace.go:171","msg":"trace[2142904583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"260.781521ms","start":"2026-07-08T21:35:37.061843Z","end":"2026-07-08T21:35:37.322625Z","steps":["trace[2142904583] 'agreement among raft nodes before linearized reading' (duration: 260.496424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:52.259255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.571364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:35:52.259395Z","caller":"traceutil/trace.go:171","msg":"trace[238132280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"196.752778ms","start":"2026-07-08T21:35:52.062615Z","end":"2026-07-08T21:35:52.259367Z","steps":["trace[238132280] 'range keys from in-memory index tree' (duration: 196.463132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:52.25938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.740431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T21:35:52.259505Z","caller":"traceutil/trace.go:171","msg":"trace[1094780642] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"116.894714ms","start":"2026-07-08T21:35:52.142568Z","end":"2026-07-08T21:35:52.259463Z","steps":["trace[1094780642] 'range keys from in-memory index tree' (duration: 116.599138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:35:52.259487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.261478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T21:35:52.259587Z","caller":"traceutil/trace.go:171","msg":"trace[1249725614] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:761; }","duration":"197.385551ms","start":"2026-07-08T21:35:52.062181Z","end":"2026-07-08T21:35:52.259567Z","steps":["trace[1249725614] 'count revisions from in-memory index tree' (duration: 197.151066ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:37:08.270164Z","caller":"traceutil/trace.go:171","msg":"trace[1716337061] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"231.987338ms","start":"2026-07-08T21:37:08.038125Z","end":"2026-07-08T21:37:08.270112Z","steps":["trace[1716337061] 'process raft request' (duration: 231.64841ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:37:08.270096Z","caller":"traceutil/trace.go:171","msg":"trace[1911549759] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"226.926017ms","start":"2026-07-08T21:37:08.04313Z","end":"2026-07-08T21:37:08.270056Z","steps":["trace[1911549759] 'read index received' (duration: 226.654601ms)","trace[1911549759] 'applied index is now lower than readState.Index' (duration: 269.816µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:37:08.270406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.236955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-846fe0b6-ca71-47ac-89fc-73a1da85b7f1\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-08T21:37:08.270516Z","caller":"traceutil/trace.go:171","msg":"trace[1395693247] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-846fe0b6-ca71-47ac-89fc-73a1da85b7f1; range_end:; response_count:1; response_revision:1829; }","duration":"227.400248ms","start":"2026-07-08T21:37:08.04309Z","end":"2026-07-08T21:37:08.27049Z","steps":["trace[1395693247] 'agreement among raft nodes before linearized reading' (duration: 227.081202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:37:08.283411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.293179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:37:08.283519Z","caller":"traceutil/trace.go:171","msg":"trace[660501406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1830; }","duration":"219.485512ms","start":"2026-07-08T21:37:08.064007Z","end":"2026-07-08T21:37:08.283493Z","steps":["trace[660501406] 'agreement among raft nodes before linearized reading' (duration: 219.317868ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:37:15.184116Z","caller":"traceutil/trace.go:171","msg":"trace[559058824] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"115.408581ms","start":"2026-07-08T21:37:15.068668Z","end":"2026-07-08T21:37:15.184077Z","steps":["trace[559058824] 'process raft request' (duration: 15.540072ms)","trace[559058824] 'compare' (duration: 99.596583ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:37:59.444015Z","caller":"traceutil/trace.go:171","msg":"trace[1793860771] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"105.134043ms","start":"2026-07-08T21:37:59.338847Z","end":"2026-07-08T21:37:59.443981Z","steps":["trace[1793860771] 'process raft request' (duration: 104.934709ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:37:59.846176Z","caller":"traceutil/trace.go:171","msg":"trace[650759199] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"100.477561ms","start":"2026-07-08T21:37:59.74565Z","end":"2026-07-08T21:37:59.846128Z","steps":["trace[650759199] 'read index received' (duration: 100.223334ms)","trace[650759199] 'applied index is now lower than readState.Index' (duration: 252.647µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:37:59.846227Z","caller":"traceutil/trace.go:171","msg":"trace[1249707587] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"138.809245ms","start":"2026-07-08T21:37:59.70737Z","end":"2026-07-08T21:37:59.84618Z","steps":["trace[1249707587] 'process raft request' (duration: 138.564458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:37:59.84653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.860409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-08T21:37:59.846731Z","caller":"traceutil/trace.go:171","msg":"trace[1643917930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2156; }","duration":"101.005322ms","start":"2026-07-08T21:37:59.745593Z","end":"2026-07-08T21:37:59.846598Z","steps":["trace[1643917930] 'agreement among raft nodes before linearized reading' (duration: 100.681335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:38:00.130497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.957437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:38:00.130895Z","caller":"traceutil/trace.go:171","msg":"trace[248259617] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2245; }","duration":"245.388798ms","start":"2026-07-08T21:37:59.885482Z","end":"2026-07-08T21:38:00.130871Z","steps":["trace[248259617] 'read index received' (duration: 150.534441ms)","trace[248259617] 'applied index is now lower than readState.Index' (duration: 94.852817ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:38:00.131131Z","caller":"traceutil/trace.go:171","msg":"trace[1759662925] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"275.743706ms","start":"2026-07-08T21:37:59.855369Z","end":"2026-07-08T21:38:00.131113Z","steps":["trace[1759662925] 'process raft request' (duration: 275.44683ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:38:00.131133Z","caller":"traceutil/trace.go:171","msg":"trace[1690995057] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"279.654973ms","start":"2026-07-08T21:37:59.85145Z","end":"2026-07-08T21:38:00.131105Z","steps":["trace[1690995057] 'process raft request' (duration: 30.994772ms)","trace[1690995057] 'compare' (duration: 247.810423ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:38:00.131399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.91963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-08T21:38:00.131383Z","caller":"traceutil/trace.go:171","msg":"trace[325786694] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"279.422577ms","start":"2026-07-08T21:37:59.851869Z","end":"2026-07-08T21:38:00.131292Z","steps":["trace[325786694] 'process raft request' (duration: 278.866055ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:38:00.131572Z","caller":"traceutil/trace.go:171","msg":"trace[1082137987] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2159; }","duration":"246.040893ms","start":"2026-07-08T21:37:59.885461Z","end":"2026-07-08T21:38:00.131501Z","steps":["trace[1082137987] 'agreement among raft nodes before linearized reading' (duration: 245.675995ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:39:24.715907Z","caller":"traceutil/trace.go:171","msg":"trace[255920824] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"162.927228ms","start":"2026-07-08T21:39:24.552939Z","end":"2026-07-08T21:39:24.715866Z","steps":["trace[255920824] 'process raft request' (duration: 137.667821ms)","trace[255920824] 'compare' (duration: 25.077713ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:39:24.775522Z","caller":"traceutil/trace.go:171","msg":"trace[1627724112] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"221.638863ms","start":"2026-07-08T21:39:24.553851Z","end":"2026-07-08T21:39:24.77549Z","steps":["trace[1627724112] 'process raft request' (duration: 221.471219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:39:25.083518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.272291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:39:25.083867Z","caller":"traceutil/trace.go:171","msg":"trace[915563388] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"280.374715ms","start":"2026-07-08T21:39:24.803453Z","end":"2026-07-08T21:39:25.083828Z","steps":["trace[915563388] 'process raft request' (duration: 24.287855ms)","trace[915563388] 'compare' (duration: 255.074387ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:39:25.252126Z","caller":"traceutil/trace.go:171","msg":"trace[1653884201] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"112.735604ms","start":"2026-07-08T21:39:25.139339Z","end":"2026-07-08T21:39:25.252075Z","steps":["trace[1653884201] 'process raft request' (duration: 81.411014ms)","trace[1653884201] 'compare' (duration: 31.019903ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:43:35.236419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.233643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:43:35.236655Z","caller":"traceutil/trace.go:171","msg":"trace[1295678929] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4938; }","duration":"131.500269ms","start":"2026-07-08T21:43:35.105125Z","end":"2026-07-08T21:43:35.236626Z","steps":["trace[1295678929] 'agreement among raft nodes before linearized reading' (duration: 30.608243ms)","trace[1295678929] 'range keys from in-memory index tree' (duration: 100.59394ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:43:35.236783Z","caller":"traceutil/trace.go:171","msg":"trace[627192192] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"120.748803ms","start":"2026-07-08T21:43:35.115993Z","end":"2026-07-08T21:43:35.236742Z","steps":["trace[627192192] 'process raft request' (duration: 49.356505ms)","trace[627192192] 'compare' (duration: 71.211724ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:43:35.246958Z","caller":"traceutil/trace.go:171","msg":"trace[40910386] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"105.008127ms","start":"2026-07-08T21:43:35.14192Z","end":"2026-07-08T21:43:35.246928Z","steps":["trace[40910386] 'process raft request' (duration: 104.574208ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:35.247192Z","caller":"traceutil/trace.go:171","msg":"trace[1202943089] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"104.241679ms","start":"2026-07-08T21:43:35.142915Z","end":"2026-07-08T21:43:35.247156Z","steps":["trace[1202943089] 'process raft request' (duration: 103.876941ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:35.247408Z","caller":"traceutil/trace.go:171","msg":"trace[116571648] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"105.278103ms","start":"2026-07-08T21:43:35.142119Z","end":"2026-07-08T21:43:35.247397Z","steps":["trace[116571648] 'process raft request' (duration: 104.616208ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:35.24739Z","caller":"traceutil/trace.go:171","msg":"trace[1278801844] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"105.242122ms","start":"2026-07-08T21:43:35.142083Z","end":"2026-07-08T21:43:35.247325Z","steps":["trace[1278801844] 'process raft request' (duration: 104.608618ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:35.247495Z","caller":"traceutil/trace.go:171","msg":"trace[1142620334] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"105.357854ms","start":"2026-07-08T21:43:35.142127Z","end":"2026-07-08T21:43:35.247485Z","steps":["trace[1142620334] 'process raft request' (duration: 104.637179ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:35.24766Z","caller":"traceutil/trace.go:171","msg":"trace[927849128] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"105.630011ms","start":"2026-07-08T21:43:35.142014Z","end":"2026-07-08T21:43:35.247645Z","steps":["trace[927849128] 'process raft request' (duration: 104.616019ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:40.291514Z","caller":"traceutil/trace.go:171","msg":"trace[1104446994] linearizableReadLoop","detail":"{readStateIndex:5289; appliedIndex:5288; }","duration":"193.379738ms","start":"2026-07-08T21:43:40.098106Z","end":"2026-07-08T21:43:40.291486Z","steps":["trace[1104446994] 'read index received' (duration: 192.981618ms)","trace[1104446994] 'applied index is now lower than readState.Index' (duration: 396.75µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:43:40.291598Z","caller":"traceutil/trace.go:171","msg":"trace[2091022392] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"195.2766ms","start":"2026-07-08T21:43:40.09628Z","end":"2026-07-08T21:43:40.291557Z","steps":["trace[2091022392] 'process raft request' (duration: 195.024904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:43:40.291741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.615943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/vector-headless\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T21:43:40.291813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.752003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-08T21:43:40.291818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.639048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-08T21:43:40.291838Z","caller":"traceutil/trace.go:171","msg":"trace[1493471059] range","detail":"{range_begin:/registry/services/specs/monitoring/vector-headless; range_end:; response_count:0; response_revision:5092; }","duration":"193.774736ms","start":"2026-07-08T21:43:40.098042Z","end":"2026-07-08T21:43:40.291817Z","steps":["trace[1493471059] 'agreement among raft nodes before linearized reading' (duration: 193.600262ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:40.291861Z","caller":"traceutil/trace.go:171","msg":"trace[975471148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5092; }","duration":"187.855456ms","start":"2026-07-08T21:43:40.103995Z","end":"2026-07-08T21:43:40.29185Z","steps":["trace[975471148] 'agreement among raft nodes before linearized reading' (duration: 187.674672ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:40.291879Z","caller":"traceutil/trace.go:171","msg":"trace[285260208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5092; }","duration":"185.73357ms","start":"2026-07-08T21:43:40.106129Z","end":"2026-07-08T21:43:40.291863Z","steps":["trace[285260208] 'agreement among raft nodes before linearized reading' (duration: 185.596907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:43:40.689814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.164052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T21:43:40.690137Z","caller":"traceutil/trace.go:171","msg":"trace[1481797309] transaction","detail":"{read_only:false; response_revision:5099; number_of_response:1; }","duration":"243.10886ms","start":"2026-07-08T21:43:40.446951Z","end":"2026-07-08T21:43:40.69006Z","steps":["trace[1481797309] 'process raft request' (duration: 70.59963ms)","trace[1481797309] 'compare' (duration: 171.512758ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T21:43:54.270975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.400259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-2mtz5\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-07-08T21:43:54.271099Z","caller":"traceutil/trace.go:171","msg":"trace[202502908] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-2mtz5; range_end:; response_count:1; response_revision:5367; }","duration":"275.580653ms","start":"2026-07-08T21:43:53.995499Z","end":"2026-07-08T21:43:54.27108Z","steps":["trace[202502908] 'range keys from in-memory index tree' (duration: 275.187965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:43:54.271534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.627855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:43:54.271642Z","caller":"traceutil/trace.go:171","msg":"trace[1860213562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5367; }","duration":"209.824579ms","start":"2026-07-08T21:43:54.061796Z","end":"2026-07-08T21:43:54.271621Z","steps":["trace[1860213562] 'range keys from in-memory index tree' (duration: 209.43686ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:54.271816Z","caller":"traceutil/trace.go:171","msg":"trace[1179563228] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"150.412794ms","start":"2026-07-08T21:43:54.121383Z","end":"2026-07-08T21:43:54.271796Z","steps":["trace[1179563228] 'process raft request' (duration: 141.60892ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:54.564999Z","caller":"traceutil/trace.go:171","msg":"trace[1722751143] linearizableReadLoop","detail":"{readStateIndex:5576; appliedIndex:5575; }","duration":"195.852272ms","start":"2026-07-08T21:43:54.369123Z","end":"2026-07-08T21:43:54.564976Z","steps":["trace[1722751143] 'read index received' (duration: 195.684509ms)","trace[1722751143] 'applied index is now lower than readState.Index' (duration: 166.873µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:43:54.565124Z","caller":"traceutil/trace.go:171","msg":"trace[1631239599] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"282.985836ms","start":"2026-07-08T21:43:54.282108Z","end":"2026-07-08T21:43:54.565094Z","steps":["trace[1631239599] 'process raft request' (duration: 282.71798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:43:54.565531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.521047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-08T21:43:54.565572Z","caller":"traceutil/trace.go:171","msg":"trace[64811195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5369; }","duration":"181.609709ms","start":"2026-07-08T21:43:54.383948Z","end":"2026-07-08T21:43:54.565558Z","steps":["trace[64811195] 'agreement among raft nodes before linearized reading' (duration: 181.351343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:43:54.565538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.816168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-08T21:43:54.565545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.399704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-08T21:43:54.565632Z","caller":"traceutil/trace.go:171","msg":"trace[513410363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5369; }","duration":"183.981101ms","start":"2026-07-08T21:43:54.381631Z","end":"2026-07-08T21:43:54.565612Z","steps":["trace[513410363] 'agreement among raft nodes before linearized reading' (duration: 183.672635ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:43:54.565656Z","caller":"traceutil/trace.go:171","msg":"trace[2139530096] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5369; }","duration":"196.587538ms","start":"2026-07-08T21:43:54.369039Z","end":"2026-07-08T21:43:54.565626Z","steps":["trace[2139530096] 'agreement among raft nodes before linearized reading' (duration: 196.069576ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:44:49.9319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2948} {"level":"info","ts":"2026-07-08T21:44:50.013897Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2948,"took":"78.737139ms","hash":3876218340,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":33595392,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-08T21:44:50.013993Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3876218340,"revision":2948,"compact-revision":-1} {"level":"info","ts":"2026-07-08T21:49:49.938906Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6007} {"level":"info","ts":"2026-07-08T21:49:50.043074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6007,"took":"101.287959ms","hash":1587742148,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":21757952,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-08T21:49:50.043145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1587742148,"revision":6007,"compact-revision":2948} {"level":"info","ts":"2026-07-08T21:50:20.912283Z","caller":"traceutil/trace.go:171","msg":"trace[1063924352] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"116.35415ms","start":"2026-07-08T21:50:20.795897Z","end":"2026-07-08T21:50:20.912251Z","steps":["trace[1063924352] 'process raft request' (duration: 116.150065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:50:21.236785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.933716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-07-08T21:50:21.236877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.736231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T21:50:21.236866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.498681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-08T21:50:21.236955Z","caller":"traceutil/trace.go:171","msg":"trace[1118493309] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8420; }","duration":"209.621294ms","start":"2026-07-08T21:50:21.027317Z","end":"2026-07-08T21:50:21.236938Z","steps":["trace[1118493309] 'range keys from in-memory index tree' (duration: 209.359158ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:50:21.236898Z","caller":"traceutil/trace.go:171","msg":"trace[1399863394] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8420; }","duration":"218.08378ms","start":"2026-07-08T21:50:21.018788Z","end":"2026-07-08T21:50:21.236871Z","steps":["trace[1399863394] 'range keys from in-memory index tree' (duration: 217.727932ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:50:21.237045Z","caller":"traceutil/trace.go:171","msg":"trace[451114449] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"139.357503ms","start":"2026-07-08T21:50:21.097676Z","end":"2026-07-08T21:50:21.237034Z","steps":["trace[451114449] 'process raft request' (duration: 122.497583ms)","trace[451114449] 'compare' (duration: 16.4116ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:50:21.236907Z","caller":"traceutil/trace.go:171","msg":"trace[542508187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8420; }","duration":"175.778882ms","start":"2026-07-08T21:50:21.061116Z","end":"2026-07-08T21:50:21.236895Z","steps":["trace[542508187] 'range keys from in-memory index tree' (duration: 175.683499ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:50:21.236826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.516327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-07-08T21:50:21.237305Z","caller":"traceutil/trace.go:171","msg":"trace[392217611] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8420; }","duration":"244.035759ms","start":"2026-07-08T21:50:20.993252Z","end":"2026-07-08T21:50:21.237287Z","steps":["trace[392217611] 'range keys from in-memory index tree' (duration: 243.314123ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:01.165303Z","caller":"traceutil/trace.go:171","msg":"trace[53639413] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"153.602074ms","start":"2026-07-08T21:51:01.01168Z","end":"2026-07-08T21:51:01.165282Z","steps":["trace[53639413] 'process raft request' (duration: 153.426699ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:01.26779Z","caller":"traceutil/trace.go:171","msg":"trace[1734213982] transaction","detail":"{read_only:false; response_revision:8731; number_of_response:1; }","duration":"254.353732ms","start":"2026-07-08T21:51:01.013398Z","end":"2026-07-08T21:51:01.267751Z","steps":["trace[1734213982] 'process raft request' (duration: 239.132819ms)","trace[1734213982] 'compare' (duration: 14.870105ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:51:01.267997Z","caller":"traceutil/trace.go:171","msg":"trace[603785958] linearizableReadLoop","detail":"{readStateIndex:9052; appliedIndex:9049; }","duration":"207.093746ms","start":"2026-07-08T21:51:01.060878Z","end":"2026-07-08T21:51:01.267972Z","steps":["trace[603785958] 'read index received' (duration: 104.353166ms)","trace[603785958] 'applied index is now lower than readState.Index' (duration: 102.73921ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:51:01.268089Z","caller":"traceutil/trace.go:171","msg":"trace[1443963270] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"254.304701ms","start":"2026-07-08T21:51:01.013772Z","end":"2026-07-08T21:51:01.268077Z","steps":["trace[1443963270] 'process raft request' (duration: 253.896622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:51:01.268165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.299711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:51:01.268212Z","caller":"traceutil/trace.go:171","msg":"trace[1264712283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8733; }","duration":"207.431044ms","start":"2026-07-08T21:51:01.060767Z","end":"2026-07-08T21:51:01.268198Z","steps":["trace[1264712283] 'agreement among raft nodes before linearized reading' (duration: 207.294951ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:01.268337Z","caller":"traceutil/trace.go:171","msg":"trace[1689218382] transaction","detail":"{read_only:false; response_revision:8733; number_of_response:1; }","duration":"198.15803ms","start":"2026-07-08T21:51:01.07013Z","end":"2026-07-08T21:51:01.268288Z","steps":["trace[1689218382] 'process raft request' (duration: 197.782852ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:02.185367Z","caller":"traceutil/trace.go:171","msg":"trace[1169096161] linearizableReadLoop","detail":"{readStateIndex:9058; appliedIndex:9057; }","duration":"222.384961ms","start":"2026-07-08T21:51:01.962961Z","end":"2026-07-08T21:51:02.185346Z","steps":["trace[1169096161] 'read index received' (duration: 221.716416ms)","trace[1169096161] 'applied index is now lower than readState.Index' (duration: 667.115µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T21:51:02.185436Z","caller":"traceutil/trace.go:171","msg":"trace[1057683867] transaction","detail":"{read_only:false; response_revision:8738; number_of_response:1; }","duration":"259.217568ms","start":"2026-07-08T21:51:01.926164Z","end":"2026-07-08T21:51:02.185382Z","steps":["trace[1057683867] 'process raft request' (duration: 258.41795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:51:02.185647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.688548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-08T21:51:02.185712Z","caller":"traceutil/trace.go:171","msg":"trace[1264529796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8738; }","duration":"222.833161ms","start":"2026-07-08T21:51:01.962868Z","end":"2026-07-08T21:51:02.185701Z","steps":["trace[1264529796] 'agreement among raft nodes before linearized reading' (duration: 222.646737ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:02.206687Z","caller":"traceutil/trace.go:171","msg":"trace[1445887011] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"142.683926ms","start":"2026-07-08T21:51:02.063983Z","end":"2026-07-08T21:51:02.206667Z","steps":["trace[1445887011] 'process raft request' (duration: 142.460971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:51:02.206834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.95138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:51:02.206942Z","caller":"traceutil/trace.go:171","msg":"trace[472187183] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:8739; }","duration":"158.211425ms","start":"2026-07-08T21:51:02.048706Z","end":"2026-07-08T21:51:02.206918Z","steps":["trace[472187183] 'agreement among raft nodes before linearized reading' (duration: 157.894178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T21:51:02.206953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.98738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9zzxz\" ","response":"range_response_count:1 size:6522"} {"level":"warn","ts":"2026-07-08T21:51:02.207077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.649551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T21:51:02.207163Z","caller":"traceutil/trace.go:171","msg":"trace[102834299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8739; }","duration":"145.758023ms","start":"2026-07-08T21:51:02.061384Z","end":"2026-07-08T21:51:02.207142Z","steps":["trace[102834299] 'agreement among raft nodes before linearized reading' (duration: 145.582699ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:02.207187Z","caller":"traceutil/trace.go:171","msg":"trace[238030318] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9zzxz; range_end:; response_count:1; response_revision:8739; }","duration":"121.239686ms","start":"2026-07-08T21:51:02.085902Z","end":"2026-07-08T21:51:02.207142Z","steps":["trace[238030318] 'agreement among raft nodes before linearized reading' (duration: 120.96469ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T21:51:16.988387Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ec.wal"} {"level":"info","ts":"2026-07-08T21:52:40.259502Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6244e483e416226f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T21:52:40.266154Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-08T21:52:40.266268Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-08T21:54:49.945555Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8096} {"level":"info","ts":"2026-07-08T21:54:50.020219Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8096,"took":"72.797065ms","hash":1200865273,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":29126656,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-08T21:54:50.020312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1200865273,"revision":8096,"compact-revision":6007} {"level":"info","ts":"2026-07-08T21:59:49.95339Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10637} {"level":"info","ts":"2026-07-08T21:59:50.036214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10637,"took":"79.982742ms","hash":3330726315,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":27025408,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-08T21:59:50.036298Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3330726315,"revision":10637,"compact-revision":8096} {"level":"info","ts":"2026-07-08T22:02:32.740578Z","caller":"traceutil/trace.go:171","msg":"trace[1917866511] transaction","detail":"{read_only:false; response_revision:13934; number_of_response:1; }","duration":"102.586588ms","start":"2026-07-08T22:02:32.637959Z","end":"2026-07-08T22:02:32.740545Z","steps":["trace[1917866511] 'process raft request' (duration: 102.333832ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:02:50.110137Z","caller":"traceutil/trace.go:171","msg":"trace[1601976248] linearizableReadLoop","detail":"{readStateIndex:14657; appliedIndex:14655; }","duration":"140.229421ms","start":"2026-07-08T22:02:49.969882Z","end":"2026-07-08T22:02:50.110111Z","steps":["trace[1601976248] 'read index received' (duration: 22.147505ms)","trace[1601976248] 'applied index is now lower than readState.Index' (duration: 118.080656ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:02:50.110255Z","caller":"traceutil/trace.go:171","msg":"trace[1934396644] transaction","detail":"{read_only:false; response_revision:14163; number_of_response:1; }","duration":"143.8662ms","start":"2026-07-08T22:02:49.966357Z","end":"2026-07-08T22:02:50.110223Z","steps":["trace[1934396644] 'process raft request' (duration: 143.577544ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:02:50.110511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.60058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-08T22:02:50.110614Z","caller":"traceutil/trace.go:171","msg":"trace[2003905652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14163; }","duration":"140.772753ms","start":"2026-07-08T22:02:49.969816Z","end":"2026-07-08T22:02:50.110588Z","steps":["trace[2003905652] 'agreement among raft nodes before linearized reading' (duration: 140.430326ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:02:50.111149Z","caller":"traceutil/trace.go:171","msg":"trace[569657601] transaction","detail":"{read_only:false; response_revision:14164; number_of_response:1; }","duration":"115.295256ms","start":"2026-07-08T22:02:49.995829Z","end":"2026-07-08T22:02:50.111124Z","steps":["trace[569657601] 'process raft request' (duration: 115.073091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:02:50.111234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.432443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:02:50.111356Z","caller":"traceutil/trace.go:171","msg":"trace[1565892665] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:14164; }","duration":"128.643937ms","start":"2026-07-08T22:02:49.982686Z","end":"2026-07-08T22:02:50.11133Z","steps":["trace[1565892665] 'agreement among raft nodes before linearized reading' (duration: 128.414812ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:03:55.477268Z","caller":"traceutil/trace.go:171","msg":"trace[1683443351] transaction","detail":"{read_only:false; response_revision:15068; number_of_response:1; }","duration":"101.136625ms","start":"2026-07-08T22:03:55.376103Z","end":"2026-07-08T22:03:55.47724Z","steps":["trace[1683443351] 'process raft request' (duration: 100.980821ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:03:55.479743Z","caller":"traceutil/trace.go:171","msg":"trace[709596047] transaction","detail":"{read_only:false; response_revision:15069; number_of_response:1; }","duration":"102.815792ms","start":"2026-07-08T22:03:55.376902Z","end":"2026-07-08T22:03:55.479718Z","steps":["trace[709596047] 'process raft request' (duration: 102.492795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:29.169434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.191968ms","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-07-08T22:04:29.169572Z","caller":"traceutil/trace.go:171","msg":"trace[324498856] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:15244; }","duration":"144.343541ms","start":"2026-07-08T22:04:29.025211Z","end":"2026-07-08T22:04:29.169554Z","steps":["trace[324498856] 'range keys from in-memory index tree' (duration: 144.176898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.169409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.505108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T22:04:30.169548Z","caller":"traceutil/trace.go:171","msg":"trace[1779555453] linearizableReadLoop","detail":"{readStateIndex:15779; appliedIndex:15778; }","duration":"246.500849ms","start":"2026-07-08T22:04:29.923025Z","end":"2026-07-08T22:04:30.169526Z","steps":["trace[1779555453] 'read index received' (duration: 89.363128ms)","trace[1779555453] 'applied index is now lower than readState.Index' (duration: 157.135191ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:04:30.169619Z","caller":"traceutil/trace.go:171","msg":"trace[1894850552] transaction","detail":"{read_only:false; response_revision:15250; number_of_response:1; }","duration":"283.390787ms","start":"2026-07-08T22:04:29.886173Z","end":"2026-07-08T22:04:30.169564Z","steps":["trace[1894850552] 'process raft request' (duration: 126.166974ms)","trace[1894850552] 'compare' (duration: 156.275813ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:04:30.169792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.787745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-g2lfx\" ","response":"range_response_count:1 size:22124"} {"level":"info","ts":"2026-07-08T22:04:30.169844Z","caller":"traceutil/trace.go:171","msg":"trace[1941016661] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-g2lfx; range_end:; response_count:1; response_revision:15250; }","duration":"246.919728ms","start":"2026-07-08T22:04:29.922911Z","end":"2026-07-08T22:04:30.169831Z","steps":["trace[1941016661] 'agreement among raft nodes before linearized reading' (duration: 246.708103ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:04:30.360798Z","caller":"traceutil/trace.go:171","msg":"trace[1823562658] linearizableReadLoop","detail":"{readStateIndex:15780; appliedIndex:15779; }","duration":"191.188078ms","start":"2026-07-08T22:04:30.169583Z","end":"2026-07-08T22:04:30.360771Z","steps":["trace[1823562658] 'read index received' (duration: 157.796657ms)","trace[1823562658] 'applied index is now lower than readState.Index' (duration: 33.390201ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:04:30.361045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.32245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-07-08T22:04:30.361075Z","caller":"traceutil/trace.go:171","msg":"trace[944858469] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15251; }","duration":"380.397742ms","start":"2026-07-08T22:04:29.980669Z","end":"2026-07-08T22:04:30.361067Z","steps":["trace[944858469] 'agreement among raft nodes before linearized reading' (duration: 380.231019ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.3611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:04:29.980661Z","time spent":"380.434733ms","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5545,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-07-08T22:04:30.361134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.61629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.361213Z","caller":"traceutil/trace.go:171","msg":"trace[405916462] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15251; }","duration":"392.763793ms","start":"2026-07-08T22:04:29.968432Z","end":"2026-07-08T22:04:30.361196Z","steps":["trace[405916462] 'agreement among raft nodes before linearized reading' (duration: 392.60863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.361263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.523365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T22:04:30.361263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:04:29.968406Z","time spent":"392.848155ms","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"info","ts":"2026-07-08T22:04:30.361289Z","caller":"traceutil/trace.go:171","msg":"trace[1373885781] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15251; }","duration":"185.570865ms","start":"2026-07-08T22:04:30.175712Z","end":"2026-07-08T22:04:30.361283Z","steps":["trace[1373885781] 'agreement among raft nodes before linearized reading' (duration: 185.532564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.361106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.183292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.361383Z","caller":"traceutil/trace.go:171","msg":"trace[1059781579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15251; }","duration":"298.53648ms","start":"2026-07-08T22:04:30.062821Z","end":"2026-07-08T22:04:30.361357Z","steps":["trace[1059781579] 'agreement among raft nodes before linearized reading' (duration: 297.963647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.361527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.917854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.361573Z","caller":"traceutil/trace.go:171","msg":"trace[1177067706] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15251; }","duration":"392.001546ms","start":"2026-07-08T22:04:29.969556Z","end":"2026-07-08T22:04:30.361558Z","steps":["trace[1177067706] 'agreement among raft nodes before linearized reading' (duration: 391.942275ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.36161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:04:29.969538Z","time spent":"392.065447ms","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-07-08T22:04:30.361779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.295313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.361813Z","caller":"traceutil/trace.go:171","msg":"trace[1436337637] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15251; }","duration":"392.348213ms","start":"2026-07-08T22:04:29.969457Z","end":"2026-07-08T22:04:30.361805Z","steps":["trace[1436337637] 'agreement among raft nodes before linearized reading' (duration: 392.294452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.361848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.304627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-08T22:04:30.361877Z","caller":"traceutil/trace.go:171","msg":"trace[881980333] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15251; }","duration":"179.344549ms","start":"2026-07-08T22:04:30.182525Z","end":"2026-07-08T22:04:30.36187Z","steps":["trace[881980333] 'agreement among raft nodes before linearized reading' (duration: 179.273787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.362002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.034135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-07-08T22:04:30.362025Z","caller":"traceutil/trace.go:171","msg":"trace[694281419] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15251; }","duration":"181.069466ms","start":"2026-07-08T22:04:30.180949Z","end":"2026-07-08T22:04:30.362019Z","steps":["trace[694281419] 'agreement among raft nodes before linearized reading' (duration: 181.005245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.362083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.211711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.362103Z","caller":"traceutil/trace.go:171","msg":"trace[174418516] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15251; }","duration":"182.231182ms","start":"2026-07-08T22:04:30.179867Z","end":"2026-07-08T22:04:30.362098Z","steps":["trace[174418516] 'agreement among raft nodes before linearized reading' (duration: 182.201461ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:04:30.362146Z","caller":"traceutil/trace.go:171","msg":"trace[2080582159] transaction","detail":"{read_only:false; response_revision:15251; number_of_response:1; }","duration":"383.215144ms","start":"2026-07-08T22:04:29.978916Z","end":"2026-07-08T22:04:30.362131Z","steps":["trace[2080582159] 'process raft request' (duration: 348.474164ms)","trace[2080582159] 'compare' (duration: 33.193656ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:04:30.362326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:04:29.978893Z","time spent":"383.302156ms","remote":"127.0.0.1:45020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18710,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:04:30.362769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.951741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769835"} {"level":"info","ts":"2026-07-08T22:04:30.362797Z","caller":"traceutil/trace.go:171","msg":"trace[1037211835] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15251; }","duration":"184.993802ms","start":"2026-07-08T22:04:30.177797Z","end":"2026-07-08T22:04:30.362791Z","steps":["trace[1037211835] 'agreement among raft nodes before linearized reading' (duration: 184.345278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.362891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.951394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-07-08T22:04:30.362985Z","caller":"traceutil/trace.go:171","msg":"trace[980291967] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15251; }","duration":"187.103617ms","start":"2026-07-08T22:04:30.17586Z","end":"2026-07-08T22:04:30.362963Z","steps":["trace[980291967] 'agreement among raft nodes before linearized reading' (duration: 186.798611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.361845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:04:29.969443Z","time spent":"392.392764ms","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"warn","ts":"2026-07-08T22:04:30.36323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.321862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.363278Z","caller":"traceutil/trace.go:171","msg":"trace[1586489558] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15251; }","duration":"187.380873ms","start":"2026-07-08T22:04:30.175889Z","end":"2026-07-08T22:04:30.363269Z","steps":["trace[1586489558] 'agreement among raft nodes before linearized reading' (duration: 187.314702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:04:30.363445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.60658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T22:04:30.36348Z","caller":"traceutil/trace.go:171","msg":"trace[158405946] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15251; }","duration":"187.693871ms","start":"2026-07-08T22:04:30.175778Z","end":"2026-07-08T22:04:30.363472Z","steps":["trace[158405946] 'agreement among raft nodes before linearized reading' (duration: 187.63817ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:04:49.964324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12809} {"level":"info","ts":"2026-07-08T22:04:50.058128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12809,"took":"91.30494ms","hash":259225339,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":30646272,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-08T22:04:50.058207Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":259225339,"revision":12809,"compact-revision":10637} {"level":"info","ts":"2026-07-08T22:09:49.971619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15354} {"level":"info","ts":"2026-07-08T22:09:50.075305Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15354,"took":"101.023821ms","hash":3888147358,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":32526336,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T22:09:50.075399Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3888147358,"revision":15354,"compact-revision":12809} {"level":"info","ts":"2026-07-08T22:10:12.085111Z","caller":"traceutil/trace.go:171","msg":"trace[498994315] transaction","detail":"{read_only:false; response_revision:17911; number_of_response:1; }","duration":"101.002498ms","start":"2026-07-08T22:10:11.984077Z","end":"2026-07-08T22:10:12.08508Z","steps":["trace[498994315] 'process raft request' (duration: 100.698222ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:10:12.205536Z","caller":"traceutil/trace.go:171","msg":"trace[1897308899] transaction","detail":"{read_only:false; response_revision:17912; number_of_response:1; }","duration":"111.801134ms","start":"2026-07-08T22:10:12.093696Z","end":"2026-07-08T22:10:12.205497Z","steps":["trace[1897308899] 'process raft request' (duration: 79.09832ms)","trace[1897308899] 'compare' (duration: 32.548021ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:10:13.139021Z","caller":"traceutil/trace.go:171","msg":"trace[371167670] linearizableReadLoop","detail":"{readStateIndex:18539; appliedIndex:18538; }","duration":"125.859092ms","start":"2026-07-08T22:10:13.013107Z","end":"2026-07-08T22:10:13.138966Z","steps":["trace[371167670] 'read index received' (duration: 125.651077ms)","trace[371167670] 'applied index is now lower than readState.Index' (duration: 207.065µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:10:13.1391Z","caller":"traceutil/trace.go:171","msg":"trace[1398838140] transaction","detail":"{read_only:false; response_revision:17923; number_of_response:1; }","duration":"148.109457ms","start":"2026-07-08T22:10:12.990968Z","end":"2026-07-08T22:10:13.139077Z","steps":["trace[1398838140] 'process raft request' (duration: 147.812701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:10:13.139399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.253001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-07-08T22:10:13.139495Z","caller":"traceutil/trace.go:171","msg":"trace[12778093] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:17923; }","duration":"126.378734ms","start":"2026-07-08T22:10:13.013071Z","end":"2026-07-08T22:10:13.139449Z","steps":["trace[12778093] 'agreement among raft nodes before linearized reading' (duration: 126.040046ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:13:06.906078Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6244e483e416226f","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T22:13:06.912165Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-08T22:13:06.912316Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-08T22:14:49.978347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17736} {"level":"info","ts":"2026-07-08T22:14:50.073363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17736,"took":"91.405555ms","hash":3982199149,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":34680832,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-08T22:14:50.073425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3982199149,"revision":17736,"compact-revision":15354} {"level":"info","ts":"2026-07-08T22:15:24.912943Z","caller":"traceutil/trace.go:171","msg":"trace[1190085274] transaction","detail":"{read_only:false; response_revision:20323; number_of_response:1; }","duration":"148.45506ms","start":"2026-07-08T22:15:24.764452Z","end":"2026-07-08T22:15:24.912907Z","steps":["trace[1190085274] 'process raft request' (duration: 148.253686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:15:25.116472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.233881ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:15:25.116764Z","caller":"traceutil/trace.go:171","msg":"trace[848129009] transaction","detail":"{read_only:false; response_revision:20324; number_of_response:1; }","duration":"277.640372ms","start":"2026-07-08T22:15:24.839042Z","end":"2026-07-08T22:15:25.116682Z","steps":["trace[848129009] 'process raft request' (duration: 137.083963ms)","trace[848129009] 'compare' (duration: 140.079488ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:15:25.116961Z","caller":"traceutil/trace.go:171","msg":"trace[15431095] transaction","detail":"{read_only:false; response_revision:20325; number_of_response:1; }","duration":"118.635561ms","start":"2026-07-08T22:15:24.998302Z","end":"2026-07-08T22:15:25.116938Z","steps":["trace[15431095] 'process raft request' (duration: 118.287952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:15:25.361722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.568007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T22:15:25.361831Z","caller":"traceutil/trace.go:171","msg":"trace[1377038459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20325; }","duration":"123.714881ms","start":"2026-07-08T22:15:25.238089Z","end":"2026-07-08T22:15:25.361804Z","steps":["trace[1377038459] 'range keys from in-memory index tree' (duration: 123.279281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:15:25.361719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.876582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T22:15:25.361993Z","caller":"traceutil/trace.go:171","msg":"trace[152957684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20325; }","duration":"106.237839ms","start":"2026-07-08T22:15:25.255741Z","end":"2026-07-08T22:15:25.361979Z","steps":["trace[152957684] 'range keys from in-memory index tree' (duration: 105.658977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:15:25.362344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.406591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-08T22:15:25.36241Z","caller":"traceutil/trace.go:171","msg":"trace[1166745727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20325; }","duration":"106.243139ms","start":"2026-07-08T22:15:25.256154Z","end":"2026-07-08T22:15:25.362397Z","steps":["trace[1166745727] 'range keys from in-memory index tree' (duration: 105.137346ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:15:25.538592Z","caller":"traceutil/trace.go:171","msg":"trace[1637009538] transaction","detail":"{read_only:false; response_revision:20326; number_of_response:1; }","duration":"171.738129ms","start":"2026-07-08T22:15:25.366819Z","end":"2026-07-08T22:15:25.538558Z","steps":["trace[1637009538] 'process raft request' (duration: 171.539684ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:15:25.766227Z","caller":"traceutil/trace.go:171","msg":"trace[1863537359] linearizableReadLoop","detail":"{readStateIndex:21026; appliedIndex:21024; }","duration":"221.539375ms","start":"2026-07-08T22:15:25.544658Z","end":"2026-07-08T22:15:25.766197Z","steps":["trace[1863537359] 'read index received' (duration: 131.344067ms)","trace[1863537359] 'applied index is now lower than readState.Index' (duration: 90.194328ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:15:25.766348Z","caller":"traceutil/trace.go:171","msg":"trace[776284234] transaction","detail":"{read_only:false; response_revision:20327; number_of_response:1; }","duration":"399.355107ms","start":"2026-07-08T22:15:25.366942Z","end":"2026-07-08T22:15:25.766297Z","steps":["trace[776284234] 'process raft request' (duration: 309.175359ms)","trace[776284234] 'compare' (duration: 89.873931ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:15:25.766533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:15:25.366912Z","time spent":"399.522871ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:15:25.766532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.817672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T22:15:25.766582Z","caller":"traceutil/trace.go:171","msg":"trace[1102986518] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:20328; }","duration":"221.972815ms","start":"2026-07-08T22:15:25.544597Z","end":"2026-07-08T22:15:25.766569Z","steps":["trace[1102986518] 'agreement among raft nodes before linearized reading' (duration: 221.71289ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:15:25.767101Z","caller":"traceutil/trace.go:171","msg":"trace[747683688] transaction","detail":"{read_only:false; response_revision:20328; number_of_response:1; }","duration":"399.712525ms","start":"2026-07-08T22:15:25.367346Z","end":"2026-07-08T22:15:25.767059Z","steps":["trace[747683688] 'process raft request' (duration: 398.799794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:15:25.767356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:15:25.36732Z","time spent":"399.91761ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:15:26.083232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.396044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:15:26.083556Z","caller":"traceutil/trace.go:171","msg":"trace[423665116] transaction","detail":"{read_only:false; response_revision:20330; number_of_response:1; }","duration":"222.661871ms","start":"2026-07-08T22:15:25.860868Z","end":"2026-07-08T22:15:26.08353Z","steps":["trace[423665116] 'process raft request' (duration: 222.467657ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:15:26.083633Z","caller":"traceutil/trace.go:171","msg":"trace[1350858985] transaction","detail":"{read_only:false; response_revision:20331; number_of_response:1; }","duration":"178.306703ms","start":"2026-07-08T22:15:25.90529Z","end":"2026-07-08T22:15:26.083597Z","steps":["trace[1350858985] 'process raft request' (duration: 178.087538ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:15:26.083586Z","caller":"traceutil/trace.go:171","msg":"trace[1999395276] transaction","detail":"{read_only:false; response_revision:20329; number_of_response:1; }","duration":"230.702856ms","start":"2026-07-08T22:15:25.852866Z","end":"2026-07-08T22:15:26.083569Z","steps":["trace[1999395276] 'process raft request' (duration: 117.862953ms)","trace[1999395276] 'compare' (duration: 112.245179ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:19:14.243159Z","caller":"traceutil/trace.go:171","msg":"trace[1835500981] transaction","detail":"{read_only:false; response_revision:22710; number_of_response:1; }","duration":"149.163206ms","start":"2026-07-08T22:19:14.093953Z","end":"2026-07-08T22:19:14.243116Z","steps":["trace[1835500981] 'process raft request' (duration: 149.086294ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:19:14.243359Z","caller":"traceutil/trace.go:171","msg":"trace[36011647] linearizableReadLoop","detail":"{readStateIndex:23481; appliedIndex:23480; }","duration":"235.202764ms","start":"2026-07-08T22:19:14.008126Z","end":"2026-07-08T22:19:14.243329Z","steps":["trace[36011647] 'read index received' (duration: 199.801802ms)","trace[36011647] 'applied index is now lower than readState.Index' (duration: 35.398582ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:19:14.243638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.489061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-07-08T22:19:14.243684Z","caller":"traceutil/trace.go:171","msg":"trace[329372119] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:22710; }","duration":"235.585733ms","start":"2026-07-08T22:19:14.008085Z","end":"2026-07-08T22:19:14.243671Z","steps":["trace[329372119] 'agreement among raft nodes before linearized reading' (duration: 235.415289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:19:14.243914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.611572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-08T22:19:14.243981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.430371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:19:14.243999Z","caller":"traceutil/trace.go:171","msg":"trace[1975600489] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:22710; }","duration":"125.747155ms","start":"2026-07-08T22:19:14.11823Z","end":"2026-07-08T22:19:14.243977Z","steps":["trace[1975600489] 'agreement among raft nodes before linearized reading' (duration: 125.587192ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:19:14.244038Z","caller":"traceutil/trace.go:171","msg":"trace[389750804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22710; }","duration":"181.505443ms","start":"2026-07-08T22:19:14.062512Z","end":"2026-07-08T22:19:14.244018Z","steps":["trace[389750804] 'agreement among raft nodes before linearized reading' (duration: 181.410571ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:19:14.244069Z","caller":"traceutil/trace.go:171","msg":"trace[291452862] transaction","detail":"{read_only:false; response_revision:22708; number_of_response:1; }","duration":"238.939627ms","start":"2026-07-08T22:19:14.004602Z","end":"2026-07-08T22:19:14.243542Z","steps":["trace[291452862] 'process raft request' (duration: 203.312049ms)","trace[291452862] 'compare' (duration: 34.666846ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:19:14.243441Z","caller":"traceutil/trace.go:171","msg":"trace[1956689513] transaction","detail":"{read_only:false; response_revision:22709; number_of_response:1; }","duration":"232.761881ms","start":"2026-07-08T22:19:14.010651Z","end":"2026-07-08T22:19:14.243413Z","steps":["trace[1956689513] 'process raft request' (duration: 232.293881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:19:14.244075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.709686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-08T22:19:14.24446Z","caller":"traceutil/trace.go:171","msg":"trace[715943313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22710; }","duration":"198.147256ms","start":"2026-07-08T22:19:14.046294Z","end":"2026-07-08T22:19:14.244441Z","steps":["trace[715943313] 'agreement among raft nodes before linearized reading' (duration: 197.520773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:19:14.243921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.81218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-07-08T22:19:14.244611Z","caller":"traceutil/trace.go:171","msg":"trace[535004578] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:22710; }","duration":"161.504235ms","start":"2026-07-08T22:19:14.083048Z","end":"2026-07-08T22:19:14.244552Z","steps":["trace[535004578] 'agreement among raft nodes before linearized reading' (duration: 160.763119ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:19:49.986596Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20117} {"level":"info","ts":"2026-07-08T22:19:50.103588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20117,"took":"113.388955ms","hash":2097772431,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":42328064,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-07-08T22:19:50.103644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2097772431,"revision":20117,"compact-revision":17736} {"level":"warn","ts":"2026-07-08T22:22:39.574762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.332007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:22:39.574848Z","caller":"traceutil/trace.go:171","msg":"trace[484359608] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:24809; }","duration":"131.47085ms","start":"2026-07-08T22:22:39.443358Z","end":"2026-07-08T22:22:39.574829Z","steps":["trace[484359608] 'count revisions from in-memory index tree' (duration: 131.231095ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:40.108145Z","caller":"traceutil/trace.go:171","msg":"trace[675720875] linearizableReadLoop","detail":"{readStateIndex:25636; appliedIndex:25635; }","duration":"142.661484ms","start":"2026-07-08T22:22:39.965467Z","end":"2026-07-08T22:22:40.108129Z","steps":["trace[675720875] 'read index received' (duration: 142.425689ms)","trace[675720875] 'applied index is now lower than readState.Index' (duration: 235.155µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:40.108407Z","caller":"traceutil/trace.go:171","msg":"trace[193716995] transaction","detail":"{read_only:false; response_revision:24810; number_of_response:1; }","duration":"215.3084ms","start":"2026-07-08T22:22:39.893079Z","end":"2026-07-08T22:22:40.108388Z","steps":["trace[193716995] 'process raft request' (duration: 214.882601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:40.108716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.230436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-08T22:22:40.108762Z","caller":"traceutil/trace.go:171","msg":"trace[357363078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24810; }","duration":"143.325969ms","start":"2026-07-08T22:22:39.965428Z","end":"2026-07-08T22:22:40.108754Z","steps":["trace[357363078] 'agreement among raft nodes before linearized reading' (duration: 143.175996ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:45.459677Z","caller":"traceutil/trace.go:171","msg":"trace[978439394] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"105.638177ms","start":"2026-07-08T22:22:45.354008Z","end":"2026-07-08T22:22:45.459646Z","steps":["trace[978439394] 'process raft request' (duration: 105.356241ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.190374Z","caller":"traceutil/trace.go:171","msg":"trace[1547499105] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"144.460874ms","start":"2026-07-08T22:22:46.045878Z","end":"2026-07-08T22:22:46.190339Z","steps":["trace[1547499105] 'process raft request' (duration: 143.987713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:46.479824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.254859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:22:46.47999Z","caller":"traceutil/trace.go:171","msg":"trace[1978054261] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"272.327804ms","start":"2026-07-08T22:22:46.207633Z","end":"2026-07-08T22:22:46.479961Z","steps":["trace[1978054261] 'process raft request' (duration: 127.81993ms)","trace[1978054261] 'compare' (duration: 143.85135ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:46.480211Z","caller":"traceutil/trace.go:171","msg":"trace[51391034] linearizableReadLoop","detail":"{readStateIndex:25685; appliedIndex:25684; }","duration":"250.986988ms","start":"2026-07-08T22:22:46.229196Z","end":"2026-07-08T22:22:46.480183Z","steps":["trace[51391034] 'read index received' (duration: 106.27266ms)","trace[51391034] 'applied index is now lower than readState.Index' (duration: 144.712398ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:46.480248Z","caller":"traceutil/trace.go:171","msg":"trace[1084629302] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"250.967037ms","start":"2026-07-08T22:22:46.229227Z","end":"2026-07-08T22:22:46.480194Z","steps":["trace[1084629302] 'process raft request' (duration: 250.711472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:46.480391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.745626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T22:22:46.480423Z","caller":"traceutil/trace.go:171","msg":"trace[1664005629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24860; }","duration":"246.823698ms","start":"2026-07-08T22:22:46.233588Z","end":"2026-07-08T22:22:46.480412Z","steps":["trace[1664005629] 'agreement among raft nodes before linearized reading' (duration: 246.711636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:46.480426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.517033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-08T22:22:46.480426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.220503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-08T22:22:46.480471Z","caller":"traceutil/trace.go:171","msg":"trace[1848840578] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24860; }","duration":"143.611645ms","start":"2026-07-08T22:22:46.336847Z","end":"2026-07-08T22:22:46.480459Z","steps":["trace[1848840578] 'agreement among raft nodes before linearized reading' (duration: 143.542564ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.480497Z","caller":"traceutil/trace.go:171","msg":"trace[1202850760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24860; }","duration":"251.313605ms","start":"2026-07-08T22:22:46.229162Z","end":"2026-07-08T22:22:46.480475Z","steps":["trace[1202850760] 'agreement among raft nodes before linearized reading' (duration: 251.122131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:46.480609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.540792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T22:22:46.480669Z","caller":"traceutil/trace.go:171","msg":"trace[1811878624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24860; }","duration":"246.615413ms","start":"2026-07-08T22:22:46.234037Z","end":"2026-07-08T22:22:46.480653Z","steps":["trace[1811878624] 'agreement among raft nodes before linearized reading' (duration: 246.46766ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.48091Z","caller":"traceutil/trace.go:171","msg":"trace[1293166838] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"247.079473ms","start":"2026-07-08T22:22:46.232966Z","end":"2026-07-08T22:22:46.480046Z","steps":["trace[1293166838] 'process raft request' (duration: 247.036822ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.618486Z","caller":"traceutil/trace.go:171","msg":"trace[1818275945] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"134.669029ms","start":"2026-07-08T22:22:46.48379Z","end":"2026-07-08T22:22:46.618459Z","steps":["trace[1818275945] 'process raft request' (duration: 134.517536ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.774437Z","caller":"traceutil/trace.go:171","msg":"trace[1245037599] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"290.087952ms","start":"2026-07-08T22:22:46.484322Z","end":"2026-07-08T22:22:46.77441Z","steps":["trace[1245037599] 'process raft request' (duration: 289.891178ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.774645Z","caller":"traceutil/trace.go:171","msg":"trace[652527307] linearizableReadLoop","detail":"{readStateIndex:25690; appliedIndex:25687; }","duration":"183.038985ms","start":"2026-07-08T22:22:46.591591Z","end":"2026-07-08T22:22:46.77463Z","steps":["trace[652527307] 'read index received' (duration: 26.743784ms)","trace[652527307] 'applied index is now lower than readState.Index' (duration: 156.293971ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:46.7749Z","caller":"traceutil/trace.go:171","msg":"trace[1550855952] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"290.352517ms","start":"2026-07-08T22:22:46.484537Z","end":"2026-07-08T22:22:46.77489Z","steps":["trace[1550855952] 'process raft request' (duration: 289.808565ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:46.77496Z","caller":"traceutil/trace.go:171","msg":"trace[1471182581] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"135.448046ms","start":"2026-07-08T22:22:46.639481Z","end":"2026-07-08T22:22:46.774929Z","steps":["trace[1471182581] 'process raft request' (duration: 135.317953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:46.775154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.541267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-08T22:22:46.775295Z","caller":"traceutil/trace.go:171","msg":"trace[1609968697] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24864; }","duration":"183.748561ms","start":"2026-07-08T22:22:46.591524Z","end":"2026-07-08T22:22:46.775273Z","steps":["trace[1609968697] 'agreement among raft nodes before linearized reading' (duration: 183.488445ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.069289Z","caller":"traceutil/trace.go:171","msg":"trace[1356582529] linearizableReadLoop","detail":"{readStateIndex:25694; appliedIndex:25693; }","duration":"210.467755ms","start":"2026-07-08T22:22:46.8588Z","end":"2026-07-08T22:22:47.069268Z","steps":["trace[1356582529] 'read index received' (duration: 210.336651ms)","trace[1356582529] 'applied index is now lower than readState.Index' (duration: 130.024µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:47.069305Z","caller":"traceutil/trace.go:171","msg":"trace[437868730] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"210.869763ms","start":"2026-07-08T22:22:46.858413Z","end":"2026-07-08T22:22:47.069283Z","steps":["trace[437868730] 'process raft request' (duration: 210.704339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:47.069506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.689279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-08T22:22:47.069553Z","caller":"traceutil/trace.go:171","msg":"trace[209463261] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24867; }","duration":"210.797252ms","start":"2026-07-08T22:22:46.858746Z","end":"2026-07-08T22:22:47.069543Z","steps":["trace[209463261] 'agreement among raft nodes before linearized reading' (duration: 210.610828ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.082515Z","caller":"traceutil/trace.go:171","msg":"trace[563811380] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"223.588151ms","start":"2026-07-08T22:22:46.858889Z","end":"2026-07-08T22:22:47.082477Z","steps":["trace[563811380] 'process raft request' (duration: 223.389007ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.307059Z","caller":"traceutil/trace.go:171","msg":"trace[410158509] linearizableReadLoop","detail":"{readStateIndex:25699; appliedIndex:25697; }","duration":"145.702051ms","start":"2026-07-08T22:22:47.161333Z","end":"2026-07-08T22:22:47.307035Z","steps":["trace[410158509] 'read index received' (duration: 145.424925ms)","trace[410158509] 'applied index is now lower than readState.Index' (duration: 275.965µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:22:47.307358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.000657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18c070af5bd1ed3c\" ","response":"range_response_count:1 size:722"} {"level":"info","ts":"2026-07-08T22:22:47.307408Z","caller":"traceutil/trace.go:171","msg":"trace[1210043695] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18c070af5bd1ed3c; range_end:; response_count:1; response_revision:24872; }","duration":"146.10118ms","start":"2026-07-08T22:22:47.161291Z","end":"2026-07-08T22:22:47.307392Z","steps":["trace[1210043695] 'agreement among raft nodes before linearized reading' (duration: 145.883875ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.307762Z","caller":"traceutil/trace.go:171","msg":"trace[1306012738] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"196.677064ms","start":"2026-07-08T22:22:47.111066Z","end":"2026-07-08T22:22:47.307743Z","steps":["trace[1306012738] 'process raft request' (duration: 195.758193ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.307767Z","caller":"traceutil/trace.go:171","msg":"trace[655845610] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"195.385225ms","start":"2026-07-08T22:22:47.112315Z","end":"2026-07-08T22:22:47.307701Z","steps":["trace[655845610] 'process raft request' (duration: 194.668128ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:47.45456Z","caller":"traceutil/trace.go:171","msg":"trace[457713644] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"143.702727ms","start":"2026-07-08T22:22:47.310824Z","end":"2026-07-08T22:22:47.454527Z","steps":["trace[457713644] 'process raft request' (duration: 140.848494ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:48.302923Z","caller":"traceutil/trace.go:171","msg":"trace[522650551] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"102.251653ms","start":"2026-07-08T22:22:48.200651Z","end":"2026-07-08T22:22:48.302903Z","steps":["trace[522650551] 'process raft request' (duration: 102.10025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:48.74161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.03158ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-08T22:22:48.747323Z","caller":"traceutil/trace.go:171","msg":"trace[1830761906] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"262.215445ms","start":"2026-07-08T22:22:48.48507Z","end":"2026-07-08T22:22:48.747285Z","steps":["trace[1830761906] 'process raft request' (duration: 261.987439ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:48.781402Z","caller":"traceutil/trace.go:171","msg":"trace[268922506] linearizableReadLoop","detail":"{readStateIndex:25705; appliedIndex:25703; }","duration":"251.577152ms","start":"2026-07-08T22:22:48.529803Z","end":"2026-07-08T22:22:48.78138Z","steps":["trace[268922506] 'read index received' (duration: 217.231211ms)","trace[268922506] 'applied index is now lower than readState.Index' (duration: 34.344751ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:48.781519Z","caller":"traceutil/trace.go:171","msg":"trace[1272357675] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"293.920856ms","start":"2026-07-08T22:22:48.487587Z","end":"2026-07-08T22:22:48.781508Z","steps":["trace[1272357675] 'process raft request' (duration: 293.6404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:48.781631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.080905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:22:48.781698Z","caller":"traceutil/trace.go:171","msg":"trace[615956561] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:24877; }","duration":"231.197818ms","start":"2026-07-08T22:22:48.550482Z","end":"2026-07-08T22:22:48.78168Z","steps":["trace[615956561] 'agreement among raft nodes before linearized reading' (duration: 231.088565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:48.781902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.485581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T22:22:48.781932Z","caller":"traceutil/trace.go:171","msg":"trace[543807825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24877; }","duration":"159.556203ms","start":"2026-07-08T22:22:48.622369Z","end":"2026-07-08T22:22:48.781925Z","steps":["trace[543807825] 'agreement among raft nodes before linearized reading' (duration: 159.476891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:22:48.781868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.996331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:22:48.782033Z","caller":"traceutil/trace.go:171","msg":"trace[631783272] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:24877; }","duration":"252.240637ms","start":"2026-07-08T22:22:48.529762Z","end":"2026-07-08T22:22:48.782003Z","steps":["trace[631783272] 'agreement among raft nodes before linearized reading' (duration: 251.93104ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:49.10305Z","caller":"traceutil/trace.go:171","msg":"trace[22851443] linearizableReadLoop","detail":"{readStateIndex:25710; appliedIndex:25709; }","duration":"248.870011ms","start":"2026-07-08T22:22:48.854148Z","end":"2026-07-08T22:22:49.103018Z","steps":["trace[22851443] 'read index received' (duration: 230.121823ms)","trace[22851443] 'applied index is now lower than readState.Index' (duration: 18.746358ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:49.103107Z","caller":"traceutil/trace.go:171","msg":"trace[1195431254] transaction","detail":"{read_only:false; response_revision:24882; number_of_response:1; }","duration":"299.947958ms","start":"2026-07-08T22:22:48.803113Z","end":"2026-07-08T22:22:49.103061Z","steps":["trace[1195431254] 'process raft request' (duration: 281.344022ms)","trace[1195431254] 'compare' (duration: 17.9077ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:22:49.103302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:22:48.8031Z","time spent":"300.097352ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:22:49.103348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.18333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-08T22:22:49.103392Z","caller":"traceutil/trace.go:171","msg":"trace[1565218384] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24882; }","duration":"249.276371ms","start":"2026-07-08T22:22:48.854098Z","end":"2026-07-08T22:22:49.103375Z","steps":["trace[1565218384] 'agreement among raft nodes before linearized reading' (duration: 249.076827ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:49.307236Z","caller":"traceutil/trace.go:171","msg":"trace[1099079537] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"159.063262ms","start":"2026-07-08T22:22:49.148148Z","end":"2026-07-08T22:22:49.307212Z","steps":["trace[1099079537] 'process raft request' (duration: 158.98075ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:49.307687Z","caller":"traceutil/trace.go:171","msg":"trace[1586126152] transaction","detail":"{read_only:false; response_revision:24883; number_of_response:1; }","duration":"198.198656ms","start":"2026-07-08T22:22:49.109458Z","end":"2026-07-08T22:22:49.307657Z","steps":["trace[1586126152] 'process raft request' (duration: 135.271652ms)","trace[1586126152] 'compare' (duration: 61.691187ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:22:49.748606Z","caller":"traceutil/trace.go:171","msg":"trace[1673100722] transaction","detail":"{read_only:false; response_revision:24887; number_of_response:1; }","duration":"173.562258ms","start":"2026-07-08T22:22:49.574836Z","end":"2026-07-08T22:22:49.748398Z","steps":["trace[1673100722] 'process raft request' (duration: 173.410925ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:22:49.916956Z","caller":"traceutil/trace.go:171","msg":"trace[1494104728] transaction","detail":"{read_only:false; response_revision:24888; number_of_response:1; }","duration":"269.098904ms","start":"2026-07-08T22:22:49.647828Z","end":"2026-07-08T22:22:49.916927Z","steps":["trace[1494104728] 'process raft request' (duration: 231.184746ms)","trace[1494104728] 'compare' (duration: 37.431637ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:04.541773Z","caller":"traceutil/trace.go:171","msg":"trace[47655409] linearizableReadLoop","detail":"{readStateIndex:25881; appliedIndex:25880; }","duration":"101.519653ms","start":"2026-07-08T22:23:04.440229Z","end":"2026-07-08T22:23:04.541749Z","steps":["trace[47655409] 'read index received' (duration: 101.361ms)","trace[47655409] 'applied index is now lower than readState.Index' (duration: 157.263µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:04.542035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.787569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f4e63511-57b4-4e19-b812-57cd05241eee\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-07-08T22:23:04.542088Z","caller":"traceutil/trace.go:171","msg":"trace[2108799765] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f4e63511-57b4-4e19-b812-57cd05241eee; range_end:; response_count:1; response_revision:25050; }","duration":"101.889871ms","start":"2026-07-08T22:23:04.440175Z","end":"2026-07-08T22:23:04.542065Z","steps":["trace[2108799765] 'agreement among raft nodes before linearized reading' (duration: 101.681177ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:04.542084Z","caller":"traceutil/trace.go:171","msg":"trace[501016178] transaction","detail":"{read_only:false; response_revision:25050; number_of_response:1; }","duration":"146.189435ms","start":"2026-07-08T22:23:04.3958Z","end":"2026-07-08T22:23:04.54199Z","steps":["trace[501016178] 'process raft request' (duration: 145.809316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:04.992245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.733772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:04.992336Z","caller":"traceutil/trace.go:171","msg":"trace[1053765496] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25050; }","duration":"300.873605ms","start":"2026-07-08T22:23:04.69144Z","end":"2026-07-08T22:23:04.992314Z","steps":["trace[1053765496] 'count revisions from in-memory index tree' (duration: 300.63978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:04.992388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:04.691421Z","time spent":"300.954977ms","remote":"127.0.0.1:58372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-08T22:23:04.993591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.488043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:23:04.993764Z","caller":"traceutil/trace.go:171","msg":"trace[372263193] transaction","detail":"{read_only:false; response_revision:25051; number_of_response:1; }","duration":"185.731796ms","start":"2026-07-08T22:23:04.808013Z","end":"2026-07-08T22:23:04.993745Z","steps":["trace[372263193] 'process raft request' (duration: 32.992928ms)","trace[372263193] 'compare' (duration: 152.37783ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:04.993939Z","caller":"traceutil/trace.go:171","msg":"trace[374177372] transaction","detail":"{read_only:false; response_revision:25052; number_of_response:1; }","duration":"159.211149ms","start":"2026-07-08T22:23:04.834696Z","end":"2026-07-08T22:23:04.993907Z","steps":["trace[374177372] 'process raft request' (duration: 158.993355ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.07962Z","caller":"traceutil/trace.go:171","msg":"trace[650378516] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"201.326427ms","start":"2026-07-08T22:23:04.878233Z","end":"2026-07-08T22:23:05.079559Z","steps":["trace[650378516] 'process raft request' (duration: 201.198314ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.079705Z","caller":"traceutil/trace.go:171","msg":"trace[1109248652] linearizableReadLoop","detail":"{readStateIndex:25884; appliedIndex:25884; }","duration":"169.855111ms","start":"2026-07-08T22:23:04.90984Z","end":"2026-07-08T22:23:05.079695Z","steps":["trace[1109248652] 'read index received' (duration: 169.846491ms)","trace[1109248652] 'applied index is now lower than readState.Index' (duration: 7.25µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:05.079821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.976184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-08T22:23:05.080024Z","caller":"traceutil/trace.go:171","msg":"trace[718086209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25053; }","duration":"170.220009ms","start":"2026-07-08T22:23:04.909773Z","end":"2026-07-08T22:23:05.079993Z","steps":["trace[718086209] 'agreement among raft nodes before linearized reading' (duration: 169.950223ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.180677Z","caller":"traceutil/trace.go:171","msg":"trace[198665208] linearizableReadLoop","detail":"{readStateIndex:25885; appliedIndex:25884; }","duration":"100.679413ms","start":"2026-07-08T22:23:05.079962Z","end":"2026-07-08T22:23:05.180642Z","steps":["trace[198665208] 'read index received' (duration: 99.66351ms)","trace[198665208] 'applied index is now lower than readState.Index' (duration: 1.014563ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:05.180897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.915453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.180959Z","caller":"traceutil/trace.go:171","msg":"trace[1555481493] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:25054; }","duration":"176.033676ms","start":"2026-07-08T22:23:05.004909Z","end":"2026-07-08T22:23:05.180942Z","steps":["trace[1555481493] 'agreement among raft nodes before linearized reading' (duration: 175.930323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.180962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.712713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-08T22:23:05.181005Z","caller":"traceutil/trace.go:171","msg":"trace[616227844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25054; }","duration":"267.824076ms","start":"2026-07-08T22:23:04.913167Z","end":"2026-07-08T22:23:05.180992Z","steps":["trace[616227844] 'agreement among raft nodes before linearized reading' (duration: 267.588631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.180978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.670572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.18109Z","caller":"traceutil/trace.go:171","msg":"trace[586336886] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:25054; }","duration":"256.850896ms","start":"2026-07-08T22:23:04.924214Z","end":"2026-07-08T22:23:05.181065Z","steps":["trace[586336886] 'agreement among raft nodes before linearized reading' (duration: 256.632092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.181083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.144301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T22:23:05.181153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.495434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.181182Z","caller":"traceutil/trace.go:171","msg":"trace[1433429510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25054; }","duration":"267.263343ms","start":"2026-07-08T22:23:04.913892Z","end":"2026-07-08T22:23:05.181156Z","steps":["trace[1433429510] 'agreement among raft nodes before linearized reading' (duration: 267.002048ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.181214Z","caller":"traceutil/trace.go:171","msg":"trace[189093285] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"252.996412ms","start":"2026-07-08T22:23:04.928206Z","end":"2026-07-08T22:23:05.181202Z","steps":["trace[189093285] 'process raft request' (duration: 251.410447ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.181241Z","caller":"traceutil/trace.go:171","msg":"trace[420344182] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:25054; }","duration":"236.674468ms","start":"2026-07-08T22:23:04.944544Z","end":"2026-07-08T22:23:05.181219Z","steps":["trace[420344182] 'agreement among raft nodes before linearized reading' (duration: 236.477123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.181324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.388042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.181358Z","caller":"traceutil/trace.go:171","msg":"trace[1746447962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25054; }","duration":"119.458813ms","start":"2026-07-08T22:23:05.06189Z","end":"2026-07-08T22:23:05.181349Z","steps":["trace[1746447962] 'agreement among raft nodes before linearized reading' (duration: 119.402532ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.347355Z","caller":"traceutil/trace.go:171","msg":"trace[891322521] transaction","detail":"{read_only:false; response_revision:25055; number_of_response:1; }","duration":"262.798176ms","start":"2026-07-08T22:23:05.084519Z","end":"2026-07-08T22:23:05.347317Z","steps":["trace[891322521] 'process raft request' (duration: 245.806596ms)","trace[891322521] 'compare' (duration: 16.643193ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:05.3476Z","caller":"traceutil/trace.go:171","msg":"trace[107156282] linearizableReadLoop","detail":"{readStateIndex:25886; appliedIndex:25885; }","duration":"164.818332ms","start":"2026-07-08T22:23:05.18275Z","end":"2026-07-08T22:23:05.347568Z","steps":["trace[107156282] 'read index received' (duration: 147.590816ms)","trace[107156282] 'applied index is now lower than readState.Index' (duration: 17.223955ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:05.347826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.055296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.347924Z","caller":"traceutil/trace.go:171","msg":"trace[324561236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25055; }","duration":"165.1985ms","start":"2026-07-08T22:23:05.182702Z","end":"2026-07-08T22:23:05.3479Z","steps":["trace[324561236] 'agreement among raft nodes before linearized reading' (duration: 164.995305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.348179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.649826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T22:23:05.348254Z","caller":"traceutil/trace.go:171","msg":"trace[1160547662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25057; }","duration":"147.761919ms","start":"2026-07-08T22:23:05.200455Z","end":"2026-07-08T22:23:05.348217Z","steps":["trace[1160547662] 'agreement among raft nodes before linearized reading' (duration: 147.565384ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.348291Z","caller":"traceutil/trace.go:171","msg":"trace[874479888] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"162.324487ms","start":"2026-07-08T22:23:05.185952Z","end":"2026-07-08T22:23:05.348277Z","steps":["trace[874479888] 'process raft request' (duration: 161.867576ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.348435Z","caller":"traceutil/trace.go:171","msg":"trace[1821439080] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"160.981478ms","start":"2026-07-08T22:23:05.187441Z","end":"2026-07-08T22:23:05.348423Z","steps":["trace[1821439080] 'process raft request' (duration: 160.526867ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.622119Z","caller":"traceutil/trace.go:171","msg":"trace[1095580291] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"244.574108ms","start":"2026-07-08T22:23:05.377513Z","end":"2026-07-08T22:23:05.622088Z","steps":["trace[1095580291] 'process raft request' (duration: 212.098562ms)","trace[1095580291] 'compare' (duration: 32.18043ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:05.62281Z","caller":"traceutil/trace.go:171","msg":"trace[1774783706] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"239.335445ms","start":"2026-07-08T22:23:05.383449Z","end":"2026-07-08T22:23:05.622785Z","steps":["trace[1774783706] 'process raft request' (duration: 239.174121ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:05.62292Z","caller":"traceutil/trace.go:171","msg":"trace[1809059028] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25889; }","duration":"231.535945ms","start":"2026-07-08T22:23:05.391364Z","end":"2026-07-08T22:23:05.6229Z","steps":["trace[1809059028] 'read index received' (duration: 13.849352ms)","trace[1809059028] 'applied index is now lower than readState.Index' (duration: 217.684633ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:05.622963Z","caller":"traceutil/trace.go:171","msg":"trace[869621070] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"238.530978ms","start":"2026-07-08T22:23:05.384399Z","end":"2026-07-08T22:23:05.62293Z","steps":["trace[869621070] 'process raft request' (duration: 238.332843ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.623156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.77917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-08T22:23:05.623199Z","caller":"traceutil/trace.go:171","msg":"trace[843571282] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25062; }","duration":"231.873482ms","start":"2026-07-08T22:23:05.391314Z","end":"2026-07-08T22:23:05.623187Z","steps":["trace[843571282] 'agreement among raft nodes before linearized reading' (duration: 231.709049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.623186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.838535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.623271Z","caller":"traceutil/trace.go:171","msg":"trace[636719349] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25062; }","duration":"227.980527ms","start":"2026-07-08T22:23:05.395268Z","end":"2026-07-08T22:23:05.623249Z","steps":["trace[636719349] 'agreement among raft nodes before linearized reading' (duration: 227.796693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:05.623674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.214784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:05.623788Z","caller":"traceutil/trace.go:171","msg":"trace[552723210] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:25062; }","duration":"168.388978ms","start":"2026-07-08T22:23:05.455372Z","end":"2026-07-08T22:23:05.623761Z","steps":["trace[552723210] 'agreement among raft nodes before linearized reading' (duration: 168.188514ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:06.711202Z","caller":"traceutil/trace.go:171","msg":"trace[2076474935] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"163.496511ms","start":"2026-07-08T22:23:06.54768Z","end":"2026-07-08T22:23:06.711177Z","steps":["trace[2076474935] 'process raft request' (duration: 163.136033ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.231086Z","caller":"traceutil/trace.go:171","msg":"trace[143309053] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"232.23657ms","start":"2026-07-08T22:23:06.998828Z","end":"2026-07-08T22:23:07.231064Z","steps":["trace[143309053] 'process raft request' (duration: 232.081276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.675018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.467462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:23:07.67527Z","caller":"traceutil/trace.go:171","msg":"trace[1918853247] linearizableReadLoop","detail":"{readStateIndex:25899; appliedIndex:25897; }","duration":"614.298614ms","start":"2026-07-08T22:23:07.060953Z","end":"2026-07-08T22:23:07.675252Z","steps":["trace[1918853247] 'read index received' (duration: 170.019625ms)","trace[1918853247] 'applied index is now lower than readState.Index' (duration: 444.277809ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:07.675273Z","caller":"traceutil/trace.go:171","msg":"trace[1406739693] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"676.321715ms","start":"2026-07-08T22:23:06.998914Z","end":"2026-07-08T22:23:07.675236Z","steps":["trace[1406739693] 'process raft request' (duration: 338.581577ms)","trace[1406739693] 'compare' (duration: 337.125525ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:07.675293Z","caller":"traceutil/trace.go:171","msg":"trace[1385005049] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"590.401684ms","start":"2026-07-08T22:23:07.084869Z","end":"2026-07-08T22:23:07.675271Z","steps":["trace[1385005049] 'process raft request' (duration: 590.281461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.675377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.427947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T22:23:07.675407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.084844Z","time spent":"590.497486ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:07.675414Z","caller":"traceutil/trace.go:171","msg":"trace[287364795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25069; }","duration":"614.502458ms","start":"2026-07-08T22:23:07.060902Z","end":"2026-07-08T22:23:07.675405Z","steps":["trace[287364795] 'agreement among raft nodes before linearized reading' (duration: 614.437997ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.675419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:06.998889Z","time spent":"676.447678ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:23:07.675453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.060881Z","time spent":"614.564389ms","remote":"127.0.0.1:44830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T22:23:07.7589Z","caller":"traceutil/trace.go:171","msg":"trace[1735014848] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"128.917209ms","start":"2026-07-08T22:23:07.629965Z","end":"2026-07-08T22:23:07.758882Z","steps":["trace[1735014848] 'process raft request' (duration: 128.751436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.759298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.827977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-07-08T22:23:07.759319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.810997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-08T22:23:07.759386Z","caller":"traceutil/trace.go:171","msg":"trace[1611899676] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25072; }","duration":"268.92773ms","start":"2026-07-08T22:23:07.49044Z","end":"2026-07-08T22:23:07.759367Z","steps":["trace[1611899676] 'agreement among raft nodes before linearized reading' (duration: 268.713535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.759527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.998007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-07-08T22:23:07.759606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.802224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-08T22:23:07.75961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.749522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-08T22:23:07.759629Z","caller":"traceutil/trace.go:171","msg":"trace[232849038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25072; }","duration":"407.142801ms","start":"2026-07-08T22:23:07.352462Z","end":"2026-07-08T22:23:07.759604Z","steps":["trace[232849038] 'agreement among raft nodes before linearized reading' (duration: 406.859475ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.759661Z","caller":"traceutil/trace.go:171","msg":"trace[872720509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25072; }","duration":"406.868525ms","start":"2026-07-08T22:23:07.352775Z","end":"2026-07-08T22:23:07.759644Z","steps":["trace[872720509] 'agreement among raft nodes before linearized reading' (duration: 406.721572ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.759663Z","caller":"traceutil/trace.go:171","msg":"trace[354674314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25072; }","duration":"406.824114ms","start":"2026-07-08T22:23:07.352826Z","end":"2026-07-08T22:23:07.75965Z","steps":["trace[354674314] 'agreement among raft nodes before linearized reading' (duration: 406.66291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.75969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.40781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-07-08T22:23:07.759708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.352823Z","time spent":"406.876185ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T22:23:07.759709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.35277Z","time spent":"406.929386ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T22:23:07.759712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.352434Z","time spent":"407.263973ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T22:23:07.759728Z","caller":"traceutil/trace.go:171","msg":"trace[739344008] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25072; }","duration":"113.445951ms","start":"2026-07-08T22:23:07.64627Z","end":"2026-07-08T22:23:07.759716Z","steps":["trace[739344008] 'agreement among raft nodes before linearized reading' (duration: 113.347459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.75971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.768738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:07.759812Z","caller":"traceutil/trace.go:171","msg":"trace[1661508812] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25072; }","duration":"202.907071ms","start":"2026-07-08T22:23:07.556892Z","end":"2026-07-08T22:23:07.759799Z","steps":["trace[1661508812] 'agreement among raft nodes before linearized reading' (duration: 202.776458ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.759822Z","caller":"traceutil/trace.go:171","msg":"trace[896040811] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"129.514391ms","start":"2026-07-08T22:23:07.630298Z","end":"2026-07-08T22:23:07.759812Z","steps":["trace[896040811] 'process raft request' (duration: 128.54424ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.759348Z","caller":"traceutil/trace.go:171","msg":"trace[792530365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25072; }","duration":"385.928769ms","start":"2026-07-08T22:23:07.373406Z","end":"2026-07-08T22:23:07.759334Z","steps":["trace[792530365] 'agreement among raft nodes before linearized reading' (duration: 385.763595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.760056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:07.373381Z","time spent":"386.661574ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-08T22:23:07.916617Z","caller":"traceutil/trace.go:171","msg":"trace[103450696] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"150.538819ms","start":"2026-07-08T22:23:07.766042Z","end":"2026-07-08T22:23:07.916581Z","steps":["trace[103450696] 'process raft request' (duration: 127.308673ms)","trace[103450696] 'compare' (duration: 22.661024ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:07.91666Z","caller":"traceutil/trace.go:171","msg":"trace[2133507915] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"149.256312ms","start":"2026-07-08T22:23:07.767379Z","end":"2026-07-08T22:23:07.916635Z","steps":["trace[2133507915] 'process raft request' (duration: 149.209371ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.916921Z","caller":"traceutil/trace.go:171","msg":"trace[966733751] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"149.62466ms","start":"2026-07-08T22:23:07.767285Z","end":"2026-07-08T22:23:07.916909Z","steps":["trace[966733751] 'process raft request' (duration: 149.18252ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.91696Z","caller":"traceutil/trace.go:171","msg":"trace[928127301] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"149.569759ms","start":"2026-07-08T22:23:07.767378Z","end":"2026-07-08T22:23:07.916948Z","steps":["trace[928127301] 'process raft request' (duration: 149.136699ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.917127Z","caller":"traceutil/trace.go:171","msg":"trace[1614802069] linearizableReadLoop","detail":"{readStateIndex:25904; appliedIndex:25903; }","duration":"149.954347ms","start":"2026-07-08T22:23:07.767163Z","end":"2026-07-08T22:23:07.917117Z","steps":["trace[1614802069] 'read index received' (duration: 126.126988ms)","trace[1614802069] 'applied index is now lower than readState.Index' (duration: 23.826489ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:07.917192Z","caller":"traceutil/trace.go:171","msg":"trace[1174274935] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"150.007929ms","start":"2026-07-08T22:23:07.767174Z","end":"2026-07-08T22:23:07.917182Z","steps":["trace[1174274935] 'process raft request' (duration: 149.1889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:07.917448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.272735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"} {"level":"warn","ts":"2026-07-08T22:23:07.917437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.632811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:07.917508Z","caller":"traceutil/trace.go:171","msg":"trace[486731391] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25077; }","duration":"150.356506ms","start":"2026-07-08T22:23:07.767133Z","end":"2026-07-08T22:23:07.917489Z","steps":["trace[486731391] 'agreement among raft nodes before linearized reading' (duration: 150.159622ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:07.917512Z","caller":"traceutil/trace.go:171","msg":"trace[2131710077] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25077; }","duration":"149.735283ms","start":"2026-07-08T22:23:07.76776Z","end":"2026-07-08T22:23:07.917496Z","steps":["trace[2131710077] 'agreement among raft nodes before linearized reading' (duration: 149.605651ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:12.877429Z","caller":"traceutil/trace.go:171","msg":"trace[657002932] transaction","detail":"{read_only:false; response_revision:25130; number_of_response:1; }","duration":"188.849534ms","start":"2026-07-08T22:23:12.68855Z","end":"2026-07-08T22:23:12.877399Z","steps":["trace[657002932] 'process raft request' (duration: 187.841722ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:12.885283Z","caller":"traceutil/trace.go:171","msg":"trace[1191955353] transaction","detail":"{read_only:false; response_revision:25131; number_of_response:1; }","duration":"154.623318ms","start":"2026-07-08T22:23:12.730639Z","end":"2026-07-08T22:23:12.885263Z","steps":["trace[1191955353] 'process raft request' (duration: 154.500556ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:13.161089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.497447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T22:23:13.16118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.713747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-08T22:23:13.16125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.126142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:13.161256Z","caller":"traceutil/trace.go:171","msg":"trace[888363103] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:25131; }","duration":"163.84101ms","start":"2026-07-08T22:23:12.997396Z","end":"2026-07-08T22:23:13.161237Z","steps":["trace[888363103] 'count revisions from in-memory index tree' (duration: 163.616044ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:13.161278Z","caller":"traceutil/trace.go:171","msg":"trace[1825771494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25131; }","duration":"100.187373ms","start":"2026-07-08T22:23:13.061083Z","end":"2026-07-08T22:23:13.16127Z","steps":["trace[1825771494] 'range keys from in-memory index tree' (duration: 100.008629ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:13.161192Z","caller":"traceutil/trace.go:171","msg":"trace[839017445] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25131; }","duration":"121.622439ms","start":"2026-07-08T22:23:13.039548Z","end":"2026-07-08T22:23:13.161171Z","steps":["trace[839017445] 'count revisions from in-memory index tree' (duration: 121.413074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:13.161604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.483058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-08T22:23:13.161682Z","caller":"traceutil/trace.go:171","msg":"trace[1950933441] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25131; }","duration":"155.613391ms","start":"2026-07-08T22:23:13.006049Z","end":"2026-07-08T22:23:13.161662Z","steps":["trace[1950933441] 'range keys from in-memory index tree' (duration: 155.276143ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:27.513806Z","caller":"traceutil/trace.go:171","msg":"trace[1762687464] transaction","detail":"{read_only:false; response_revision:25244; number_of_response:1; }","duration":"154.647399ms","start":"2026-07-08T22:23:27.359122Z","end":"2026-07-08T22:23:27.51377Z","steps":["trace[1762687464] 'process raft request' (duration: 154.394633ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:27.95103Z","caller":"traceutil/trace.go:171","msg":"trace[1916569114] transaction","detail":"{read_only:false; response_revision:25245; number_of_response:1; }","duration":"157.236536ms","start":"2026-07-08T22:23:27.793773Z","end":"2026-07-08T22:23:27.951009Z","steps":["trace[1916569114] 'process raft request' (duration: 157.111964ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.097843Z","caller":"traceutil/trace.go:171","msg":"trace[878282405] transaction","detail":"{read_only:false; response_revision:25248; number_of_response:1; }","duration":"252.486441ms","start":"2026-07-08T22:23:27.845335Z","end":"2026-07-08T22:23:28.097822Z","steps":["trace[878282405] 'process raft request' (duration: 252.4247ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.097914Z","caller":"traceutil/trace.go:171","msg":"trace[1535480358] transaction","detail":"{read_only:false; response_revision:25247; number_of_response:1; }","duration":"255.636409ms","start":"2026-07-08T22:23:27.842217Z","end":"2026-07-08T22:23:28.097853Z","steps":["trace[1535480358] 'process raft request' (duration: 255.502086ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.097856Z","caller":"traceutil/trace.go:171","msg":"trace[74084188] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"256.222862ms","start":"2026-07-08T22:23:27.841593Z","end":"2026-07-08T22:23:28.097816Z","steps":["trace[74084188] 'process raft request' (duration: 255.965127ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.098234Z","caller":"traceutil/trace.go:171","msg":"trace[877779738] transaction","detail":"{read_only:false; response_revision:25250; number_of_response:1; }","duration":"208.182967ms","start":"2026-07-08T22:23:27.89004Z","end":"2026-07-08T22:23:28.098223Z","steps":["trace[877779738] 'process raft request' (duration: 207.957741ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.09823Z","caller":"traceutil/trace.go:171","msg":"trace[1420844664] linearizableReadLoop","detail":"{readStateIndex:26085; appliedIndex:26080; }","duration":"132.62973ms","start":"2026-07-08T22:23:27.965572Z","end":"2026-07-08T22:23:28.098202Z","steps":["trace[1420844664] 'read index received' (duration: 131.979285ms)","trace[1420844664] 'applied index is now lower than readState.Index' (duration: 646.945µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:28.098068Z","caller":"traceutil/trace.go:171","msg":"trace[1730802478] transaction","detail":"{read_only:false; response_revision:25249; number_of_response:1; }","duration":"247.798618ms","start":"2026-07-08T22:23:27.850249Z","end":"2026-07-08T22:23:28.098048Z","steps":["trace[1730802478] 'process raft request' (duration: 247.533932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:28.098398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.878546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:28.098452Z","caller":"traceutil/trace.go:171","msg":"trace[1645571914] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25250; }","duration":"133.085559ms","start":"2026-07-08T22:23:27.965351Z","end":"2026-07-08T22:23:28.098436Z","steps":["trace[1645571914] 'agreement among raft nodes before linearized reading' (duration: 132.963527ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.248064Z","caller":"traceutil/trace.go:171","msg":"trace[2091356001] transaction","detail":"{read_only:false; response_revision:25251; number_of_response:1; }","duration":"145.267155ms","start":"2026-07-08T22:23:28.102767Z","end":"2026-07-08T22:23:28.248034Z","steps":["trace[2091356001] 'process raft request' (duration: 145.084822ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.258092Z","caller":"traceutil/trace.go:171","msg":"trace[1298325300] linearizableReadLoop","detail":"{readStateIndex:26090; appliedIndex:26086; }","duration":"153.634698ms","start":"2026-07-08T22:23:28.104439Z","end":"2026-07-08T22:23:28.258074Z","steps":["trace[1298325300] 'read index received' (duration: 143.982047ms)","trace[1298325300] 'applied index is now lower than readState.Index' (duration: 9.65174ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:28.258157Z","caller":"traceutil/trace.go:171","msg":"trace[2115008676] transaction","detail":"{read_only:false; response_revision:25254; number_of_response:1; }","duration":"154.319972ms","start":"2026-07-08T22:23:28.103801Z","end":"2026-07-08T22:23:28.258121Z","steps":["trace[2115008676] 'process raft request' (duration: 154.20913ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:28.258253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.795521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:28.258224Z","caller":"traceutil/trace.go:171","msg":"trace[1908388668] transaction","detail":"{read_only:false; response_revision:25255; number_of_response:1; }","duration":"153.786851ms","start":"2026-07-08T22:23:28.104395Z","end":"2026-07-08T22:23:28.258182Z","steps":["trace[1908388668] 'process raft request' (duration: 153.645178ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.258286Z","caller":"traceutil/trace.go:171","msg":"trace[638896938] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25255; }","duration":"153.864262ms","start":"2026-07-08T22:23:28.104411Z","end":"2026-07-08T22:23:28.258275Z","steps":["trace[638896938] 'agreement among raft nodes before linearized reading' (duration: 153.7723ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.258238Z","caller":"traceutil/trace.go:171","msg":"trace[496945712] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"154.907986ms","start":"2026-07-08T22:23:28.103225Z","end":"2026-07-08T22:23:28.258133Z","steps":["trace[496945712] 'process raft request' (duration: 154.62005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:28.258484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.037743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-08T22:23:28.258536Z","caller":"traceutil/trace.go:171","msg":"trace[1224335419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25255; }","duration":"141.126595ms","start":"2026-07-08T22:23:28.117392Z","end":"2026-07-08T22:23:28.258519Z","steps":["trace[1224335419] 'agreement among raft nodes before linearized reading' (duration: 140.993182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:28.25857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.697403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:521"} {"level":"info","ts":"2026-07-08T22:23:28.258603Z","caller":"traceutil/trace.go:171","msg":"trace[370685673] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:25255; }","duration":"116.767425ms","start":"2026-07-08T22:23:28.141826Z","end":"2026-07-08T22:23:28.258594Z","steps":["trace[370685673] 'agreement among raft nodes before linearized reading' (duration: 116.599501ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.258503Z","caller":"traceutil/trace.go:171","msg":"trace[218051644] transaction","detail":"{read_only:false; response_revision:25253; number_of_response:1; }","duration":"155.186931ms","start":"2026-07-08T22:23:28.103292Z","end":"2026-07-08T22:23:28.258447Z","steps":["trace[218051644] 'process raft request' (duration: 154.68408ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.42976Z","caller":"traceutil/trace.go:171","msg":"trace[267664157] linearizableReadLoop","detail":"{readStateIndex:26091; appliedIndex:26090; }","duration":"164.070606ms","start":"2026-07-08T22:23:28.265665Z","end":"2026-07-08T22:23:28.429736Z","steps":["trace[267664157] 'read index received' (duration: 146.83009ms)","trace[267664157] 'applied index is now lower than readState.Index' (duration: 17.239636ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:28.42991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.220509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:28.429931Z","caller":"traceutil/trace.go:171","msg":"trace[780323009] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25256; }","duration":"164.316811ms","start":"2026-07-08T22:23:28.265607Z","end":"2026-07-08T22:23:28.429924Z","steps":["trace[780323009] 'agreement among raft nodes before linearized reading' (duration: 164.217308ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:28.43007Z","caller":"traceutil/trace.go:171","msg":"trace[741226276] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"164.78145ms","start":"2026-07-08T22:23:28.265254Z","end":"2026-07-08T22:23:28.430036Z","steps":["trace[741226276] 'process raft request' (duration: 147.252508ms)","trace[741226276] 'compare' (duration: 17.101813ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:31.617057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.42729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-08T22:23:31.617145Z","caller":"traceutil/trace.go:171","msg":"trace[1396328843] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25272; }","duration":"112.587904ms","start":"2026-07-08T22:23:31.504535Z","end":"2026-07-08T22:23:31.617122Z","steps":["trace[1396328843] 'range keys from in-memory index tree' (duration: 112.220065ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:31.685646Z","caller":"traceutil/trace.go:171","msg":"trace[1738801144] transaction","detail":"{read_only:false; response_revision:25273; number_of_response:1; }","duration":"156.707054ms","start":"2026-07-08T22:23:31.528905Z","end":"2026-07-08T22:23:31.685612Z","steps":["trace[1738801144] 'process raft request' (duration: 156.502549ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:31.704005Z","caller":"traceutil/trace.go:171","msg":"trace[815347524] transaction","detail":"{read_only:false; response_revision:25274; number_of_response:1; }","duration":"101.379969ms","start":"2026-07-08T22:23:31.602581Z","end":"2026-07-08T22:23:31.703961Z","steps":["trace[815347524] 'process raft request' (duration: 101.014811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:31.912219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.605941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-08T22:23:31.912348Z","caller":"traceutil/trace.go:171","msg":"trace[300537325] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25275; }","duration":"172.796565ms","start":"2026-07-08T22:23:31.739521Z","end":"2026-07-08T22:23:31.912318Z","steps":["trace[300537325] 'range keys from in-memory index tree' (duration: 172.360426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:31.912843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.895361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10854"} {"level":"info","ts":"2026-07-08T22:23:31.91297Z","caller":"traceutil/trace.go:171","msg":"trace[576312733] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25275; }","duration":"181.106645ms","start":"2026-07-08T22:23:31.731837Z","end":"2026-07-08T22:23:31.912944Z","steps":["trace[576312733] 'range keys from in-memory index tree' (duration: 180.669676ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.190005Z","caller":"traceutil/trace.go:171","msg":"trace[1961022346] transaction","detail":"{read_only:false; response_revision:25276; number_of_response:1; }","duration":"264.855639ms","start":"2026-07-08T22:23:31.925112Z","end":"2026-07-08T22:23:32.189968Z","steps":["trace[1961022346] 'process raft request' (duration: 264.614264ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.488903Z","caller":"traceutil/trace.go:171","msg":"trace[1554119426] transaction","detail":"{read_only:false; response_revision:25277; number_of_response:1; }","duration":"525.470219ms","start":"2026-07-08T22:23:31.963385Z","end":"2026-07-08T22:23:32.488855Z","steps":["trace[1554119426] 'process raft request' (duration: 525.145972ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.488907Z","caller":"traceutil/trace.go:171","msg":"trace[1733615902] transaction","detail":"{read_only:false; response_revision:25278; number_of_response:1; }","duration":"379.417027ms","start":"2026-07-08T22:23:32.109455Z","end":"2026-07-08T22:23:32.488872Z","steps":["trace[1733615902] 'process raft request' (duration: 379.313765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.489099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:31.963357Z","time spent":"525.632163ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.48918Z","caller":"traceutil/trace.go:171","msg":"trace[1653773558] transaction","detail":"{read_only:false; response_revision:25279; number_of_response:1; }","duration":"375.656065ms","start":"2026-07-08T22:23:32.113494Z","end":"2026-07-08T22:23:32.489151Z","steps":["trace[1653773558] 'process raft request' (duration: 375.324358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.48931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.113477Z","time spent":"375.767387ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:23:32.489334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.109424Z","time spent":"379.747304ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.489631Z","caller":"traceutil/trace.go:171","msg":"trace[1314293346] linearizableReadLoop","detail":"{readStateIndex:26113; appliedIndex:26111; }","duration":"427.257659ms","start":"2026-07-08T22:23:32.062341Z","end":"2026-07-08T22:23:32.489599Z","steps":["trace[1314293346] 'read index received' (duration: 127.449407ms)","trace[1314293346] 'applied index is now lower than readState.Index' (duration: 299.807172ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:32.489774Z","caller":"traceutil/trace.go:171","msg":"trace[656997400] transaction","detail":"{read_only:false; response_revision:25281; number_of_response:1; }","duration":"376.013452ms","start":"2026-07-08T22:23:32.113748Z","end":"2026-07-08T22:23:32.489762Z","steps":["trace[656997400] 'process raft request' (duration: 375.572263ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.489767Z","caller":"traceutil/trace.go:171","msg":"trace[534336328] transaction","detail":"{read_only:false; response_revision:25280; number_of_response:1; }","duration":"376.137815ms","start":"2026-07-08T22:23:32.113612Z","end":"2026-07-08T22:23:32.48975Z","steps":["trace[534336328] 'process raft request' (duration: 375.43566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.489853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.113583Z","time spent":"376.228687ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:23:32.489862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.532284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:32.489967Z","caller":"traceutil/trace.go:171","msg":"trace[925673827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25281; }","duration":"427.719058ms","start":"2026-07-08T22:23:32.062233Z","end":"2026-07-08T22:23:32.489952Z","steps":["trace[925673827] 'agreement among raft nodes before linearized reading' (duration: 427.547374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.490016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.062201Z","time spent":"427.80606ms","remote":"127.0.0.1:44832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T22:23:32.490892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.113719Z","time spent":"376.093064ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.618329Z","caller":"traceutil/trace.go:171","msg":"trace[1201790744] transaction","detail":"{read_only:false; response_revision:25282; number_of_response:1; }","duration":"420.41832ms","start":"2026-07-08T22:23:32.19787Z","end":"2026-07-08T22:23:32.618289Z","steps":["trace[1201790744] 'process raft request' (duration: 404.852551ms)","trace[1201790744] 'compare' (duration: 15.266992ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T22:23:32.618562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.197847Z","time spent":"420.584274ms","remote":"127.0.0.1:45016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.618685Z","caller":"traceutil/trace.go:171","msg":"trace[657126329] transaction","detail":"{read_only:false; response_revision:25283; number_of_response:1; }","duration":"420.549573ms","start":"2026-07-08T22:23:32.19807Z","end":"2026-07-08T22:23:32.61862Z","steps":["trace[657126329] 'process raft request' (duration: 420.159954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.618883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.19806Z","time spent":"420.706026ms","remote":"127.0.0.1:45144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.618874Z","caller":"traceutil/trace.go:171","msg":"trace[1780953483] linearizableReadLoop","detail":"{readStateIndex:26121; appliedIndex:26117; }","duration":"129.117973ms","start":"2026-07-08T22:23:32.489714Z","end":"2026-07-08T22:23:32.618832Z","steps":["trace[1780953483] 'read index received' (duration: 112.993162ms)","trace[1780953483] 'applied index is now lower than readState.Index' (duration: 16.123231ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:32.61907Z","caller":"traceutil/trace.go:171","msg":"trace[1495784076] transaction","detail":"{read_only:false; response_revision:25284; number_of_response:1; }","duration":"419.468899ms","start":"2026-07-08T22:23:32.199567Z","end":"2026-07-08T22:23:32.619036Z","steps":["trace[1495784076] 'process raft request' (duration: 418.947837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.571302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T22:23:32.619172Z","caller":"traceutil/trace.go:171","msg":"trace[1399970568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25285; }","duration":"341.635903ms","start":"2026-07-08T22:23:32.277524Z","end":"2026-07-08T22:23:32.61916Z","steps":["trace[1399970568] 'agreement among raft nodes before linearized reading' (duration: 341.4605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.277514Z","time spent":"341.698324ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T22:23:32.619245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.19954Z","time spent":"419.618252ms","remote":"127.0.0.1:45144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T22:23:32.619262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.886869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T22:23:32.619293Z","caller":"traceutil/trace.go:171","msg":"trace[831961105] transaction","detail":"{read_only:false; response_revision:25285; number_of_response:1; }","duration":"413.426567ms","start":"2026-07-08T22:23:32.205839Z","end":"2026-07-08T22:23:32.619265Z","steps":["trace[831961105] 'process raft request' (duration: 412.867885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.366507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-07-08T22:23:32.619324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.0932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:32.619381Z","caller":"traceutil/trace.go:171","msg":"trace[1221874760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25285; }","duration":"173.462089ms","start":"2026-07-08T22:23:32.445905Z","end":"2026-07-08T22:23:32.619367Z","steps":["trace[1221874760] 'agreement among raft nodes before linearized reading' (duration: 173.268375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.205802Z","time spent":"413.550139ms","remote":"127.0.0.1:45346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9630,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T22:23:32.619411Z","caller":"traceutil/trace.go:171","msg":"trace[2008257029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25285; }","duration":"128.210913ms","start":"2026-07-08T22:23:32.491174Z","end":"2026-07-08T22:23:32.619385Z","steps":["trace[2008257029] 'agreement among raft nodes before linearized reading' (duration: 128.05844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.305651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-07-08T22:23:32.619488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.11844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T22:23:32.619327Z","caller":"traceutil/trace.go:171","msg":"trace[940960472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25285; }","duration":"341.97765ms","start":"2026-07-08T22:23:32.277331Z","end":"2026-07-08T22:23:32.619308Z","steps":["trace[940960472] 'agreement among raft nodes before linearized reading' (duration: 341.733625ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.61955Z","caller":"traceutil/trace.go:171","msg":"trace[704559741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25285; }","duration":"357.203553ms","start":"2026-07-08T22:23:32.26233Z","end":"2026-07-08T22:23:32.619534Z","steps":["trace[704559741] 'agreement among raft nodes before linearized reading' (duration: 357.054179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.277316Z","time spent":"342.234838ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T22:23:32.619599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.262321Z","time spent":"357.267544ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T22:23:32.619263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.492144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:32.619503Z","caller":"traceutil/trace.go:171","msg":"trace[1102325484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25285; }","duration":"344.426743ms","start":"2026-07-08T22:23:32.27506Z","end":"2026-07-08T22:23:32.619486Z","steps":["trace[1102325484] 'agreement among raft nodes before linearized reading' (duration: 344.243059ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.619692Z","caller":"traceutil/trace.go:171","msg":"trace[901962662] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/endpoints/; range_end:/registry/openstack.k-orc.cloud/endpoints0; response_count:0; response_revision:25285; }","duration":"439.998288ms","start":"2026-07-08T22:23:32.179664Z","end":"2026-07-08T22:23:32.619662Z","steps":["trace[901962662] 'agreement among raft nodes before linearized reading' (duration: 439.498616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.275038Z","time spent":"344.65975ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T22:23:32.619775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.179635Z","time spent":"440.10327ms","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-08T22:23:32.619424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.780924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-07-08T22:23:32.619857Z","caller":"traceutil/trace.go:171","msg":"trace[1013152901] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25285; }","duration":"341.246635ms","start":"2026-07-08T22:23:32.278586Z","end":"2026-07-08T22:23:32.619833Z","steps":["trace[1013152901] 'agreement among raft nodes before linearized reading' (duration: 340.691052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.619922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:32.278574Z","time spent":"341.331147ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-07-08T22:23:32.781526Z","caller":"traceutil/trace.go:171","msg":"trace[226653033] transaction","detail":"{read_only:false; response_revision:25287; number_of_response:1; }","duration":"155.915536ms","start":"2026-07-08T22:23:32.62558Z","end":"2026-07-08T22:23:32.781496Z","steps":["trace[226653033] 'process raft request' (duration: 155.088129ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.781607Z","caller":"traceutil/trace.go:171","msg":"trace[1054054323] transaction","detail":"{read_only:false; response_revision:25288; number_of_response:1; }","duration":"155.291123ms","start":"2026-07-08T22:23:32.626288Z","end":"2026-07-08T22:23:32.781579Z","steps":["trace[1054054323] 'process raft request' (duration: 155.088499ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.781795Z","caller":"traceutil/trace.go:171","msg":"trace[2113636110] transaction","detail":"{read_only:false; response_revision:25290; number_of_response:1; }","duration":"154.328322ms","start":"2026-07-08T22:23:32.627451Z","end":"2026-07-08T22:23:32.781779Z","steps":["trace[2113636110] 'process raft request' (duration: 154.120658ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.781797Z","caller":"traceutil/trace.go:171","msg":"trace[1663327710] linearizableReadLoop","detail":"{readStateIndex:26127; appliedIndex:26121; }","duration":"151.136663ms","start":"2026-07-08T22:23:32.630641Z","end":"2026-07-08T22:23:32.781778Z","steps":["trace[1663327710] 'read index received' (duration: 66.113431ms)","trace[1663327710] 'applied index is now lower than readState.Index' (duration: 85.021872ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:32.781849Z","caller":"traceutil/trace.go:171","msg":"trace[1923654416] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"154.19697ms","start":"2026-07-08T22:23:32.627638Z","end":"2026-07-08T22:23:32.781835Z","steps":["trace[1923654416] 'process raft request' (duration: 154.057537ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:32.781804Z","caller":"traceutil/trace.go:171","msg":"trace[785941406] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"154.303322ms","start":"2026-07-08T22:23:32.627327Z","end":"2026-07-08T22:23:32.781631Z","steps":["trace[785941406] 'process raft request' (duration: 154.18842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:32.781978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.314357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-07-08T22:23:32.782184Z","caller":"traceutil/trace.go:171","msg":"trace[208053023] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25291; }","duration":"151.506443ms","start":"2026-07-08T22:23:32.63061Z","end":"2026-07-08T22:23:32.782117Z","steps":["trace[208053023] 'agreement among raft nodes before linearized reading' (duration: 151.233136ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:40.959779Z","caller":"traceutil/trace.go:171","msg":"trace[1614596618] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"122.822976ms","start":"2026-07-08T22:23:40.836918Z","end":"2026-07-08T22:23:40.95974Z","steps":["trace[1614596618] 'process raft request' (duration: 74.248887ms)","trace[1614596618] 'compare' (duration: 48.197641ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:40.960196Z","caller":"traceutil/trace.go:171","msg":"trace[166219951] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"123.245365ms","start":"2026-07-08T22:23:40.83692Z","end":"2026-07-08T22:23:40.960165Z","steps":["trace[166219951] 'process raft request' (duration: 122.742414ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:40.961737Z","caller":"traceutil/trace.go:171","msg":"trace[1905948061] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"124.784588ms","start":"2026-07-08T22:23:40.836933Z","end":"2026-07-08T22:23:40.961718Z","steps":["trace[1905948061] 'process raft request' (duration: 122.950539ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:40.961894Z","caller":"traceutil/trace.go:171","msg":"trace[1317795140] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"124.986993ms","start":"2026-07-08T22:23:40.836896Z","end":"2026-07-08T22:23:40.961883Z","steps":["trace[1317795140] 'process raft request' (duration: 124.39847ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:40.962016Z","caller":"traceutil/trace.go:171","msg":"trace[127977165] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"124.950921ms","start":"2026-07-08T22:23:40.837056Z","end":"2026-07-08T22:23:40.962007Z","steps":["trace[127977165] 'process raft request' (duration: 124.284677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:45.864221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.462298ms","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:6"} {"level":"info","ts":"2026-07-08T22:23:45.864315Z","caller":"traceutil/trace.go:171","msg":"trace[1098331327] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"115.20224ms","start":"2026-07-08T22:23:45.749071Z","end":"2026-07-08T22:23:45.864273Z","steps":["trace[1098331327] 'process raft request' (duration: 102.396161ms)","trace[1098331327] 'compare' (duration: 12.365759ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:45.864371Z","caller":"traceutil/trace.go:171","msg":"trace[1067829879] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:25391; }","duration":"122.669302ms","start":"2026-07-08T22:23:45.741665Z","end":"2026-07-08T22:23:45.864334Z","steps":["trace[1067829879] 'count revisions from in-memory index tree' (duration: 122.344415ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.554606Z","caller":"traceutil/trace.go:171","msg":"trace[907315133] transaction","detail":"{read_only:false; response_revision:25393; number_of_response:1; }","duration":"146.846759ms","start":"2026-07-08T22:23:46.40774Z","end":"2026-07-08T22:23:46.554586Z","steps":["trace[907315133] 'process raft request' (duration: 146.696296ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.682532Z","caller":"traceutil/trace.go:171","msg":"trace[844634048] transaction","detail":"{read_only:false; response_revision:25394; number_of_response:1; }","duration":"142.156968ms","start":"2026-07-08T22:23:46.540345Z","end":"2026-07-08T22:23:46.682502Z","steps":["trace[844634048] 'process raft request' (duration: 141.84963ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.682552Z","caller":"traceutil/trace.go:171","msg":"trace[1295762241] transaction","detail":"{read_only:false; response_revision:25395; number_of_response:1; }","duration":"139.186253ms","start":"2026-07-08T22:23:46.543324Z","end":"2026-07-08T22:23:46.68251Z","steps":["trace[1295762241] 'process raft request' (duration: 139.07881ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.682864Z","caller":"traceutil/trace.go:171","msg":"trace[1922600261] transaction","detail":"{read_only:false; response_revision:25396; number_of_response:1; }","duration":"137.913035ms","start":"2026-07-08T22:23:46.544926Z","end":"2026-07-08T22:23:46.682839Z","steps":["trace[1922600261] 'process raft request' (duration: 137.519397ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.682908Z","caller":"traceutil/trace.go:171","msg":"trace[104258692] transaction","detail":"{read_only:false; response_revision:25397; number_of_response:1; }","duration":"136.503724ms","start":"2026-07-08T22:23:46.546378Z","end":"2026-07-08T22:23:46.682882Z","steps":["trace[104258692] 'process raft request' (duration: 136.32931ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:46.683012Z","caller":"traceutil/trace.go:171","msg":"trace[775607243] transaction","detail":"{read_only:false; response_revision:25398; number_of_response:1; }","duration":"136.477073ms","start":"2026-07-08T22:23:46.546515Z","end":"2026-07-08T22:23:46.682992Z","steps":["trace[775607243] 'process raft request' (duration: 136.32032ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:49.363436Z","caller":"traceutil/trace.go:171","msg":"trace[1448841352] linearizableReadLoop","detail":"{readStateIndex:26257; appliedIndex:26254; }","duration":"276.810891ms","start":"2026-07-08T22:23:49.0866Z","end":"2026-07-08T22:23:49.363411Z","steps":["trace[1448841352] 'read index received' (duration: 68.445391ms)","trace[1448841352] 'applied index is now lower than readState.Index' (duration: 208.36442ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:49.363496Z","caller":"traceutil/trace.go:171","msg":"trace[2135717678] transaction","detail":"{read_only:false; response_revision:25415; number_of_response:1; }","duration":"278.638091ms","start":"2026-07-08T22:23:49.084811Z","end":"2026-07-08T22:23:49.363449Z","steps":["trace[2135717678] 'process raft request' (duration: 278.408415ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:49.363545Z","caller":"traceutil/trace.go:171","msg":"trace[192247530] transaction","detail":"{read_only:false; response_revision:25416; number_of_response:1; }","duration":"277.668471ms","start":"2026-07-08T22:23:49.085818Z","end":"2026-07-08T22:23:49.363486Z","steps":["trace[192247530] 'process raft request' (duration: 277.547188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:49.363743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.107827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-08T22:23:49.363835Z","caller":"traceutil/trace.go:171","msg":"trace[217870591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25416; }","duration":"277.23709ms","start":"2026-07-08T22:23:49.086578Z","end":"2026-07-08T22:23:49.363815Z","steps":["trace[217870591] 'agreement among raft nodes before linearized reading' (duration: 276.929863ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:49.411829Z","caller":"traceutil/trace.go:171","msg":"trace[1502246127] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"240.609283ms","start":"2026-07-08T22:23:49.171157Z","end":"2026-07-08T22:23:49.411766Z","steps":["trace[1502246127] 'process raft request' (duration: 240.325426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:49.411875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.183125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-08T22:23:49.411978Z","caller":"traceutil/trace.go:171","msg":"trace[1847210383] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25417; }","duration":"325.316338ms","start":"2026-07-08T22:23:49.086636Z","end":"2026-07-08T22:23:49.411953Z","steps":["trace[1847210383] 'agreement among raft nodes before linearized reading' (duration: 325.037722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:49.412042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T22:23:49.086632Z","time spent":"325.394179ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-07-08T22:23:49.631187Z","caller":"traceutil/trace.go:171","msg":"trace[998483547] transaction","detail":"{read_only:false; response_revision:25418; number_of_response:1; }","duration":"261.934596ms","start":"2026-07-08T22:23:49.36921Z","end":"2026-07-08T22:23:49.631145Z","steps":["trace[998483547] 'process raft request' (duration: 219.544203ms)","trace[998483547] 'compare' (duration: 41.739939ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:49.657748Z","caller":"traceutil/trace.go:171","msg":"trace[910590814] linearizableReadLoop","detail":"{readStateIndex:26260; appliedIndex:26258; }","duration":"178.768695ms","start":"2026-07-08T22:23:49.47895Z","end":"2026-07-08T22:23:49.657719Z","steps":["trace[910590814] 'read index received' (duration: 109.838483ms)","trace[910590814] 'applied index is now lower than readState.Index' (duration: 68.929102ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:49.657811Z","caller":"traceutil/trace.go:171","msg":"trace[1596114823] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"239.978089ms","start":"2026-07-08T22:23:49.417804Z","end":"2026-07-08T22:23:49.657782Z","steps":["trace[1596114823] 'process raft request' (duration: 239.757034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:49.657897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.921988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T22:23:49.65793Z","caller":"traceutil/trace.go:171","msg":"trace[1984862565] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:25419; }","duration":"179.037191ms","start":"2026-07-08T22:23:49.478881Z","end":"2026-07-08T22:23:49.657918Z","steps":["trace[1984862565] 'agreement among raft nodes before linearized reading' (duration: 178.945579ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:50.82503Z","caller":"traceutil/trace.go:171","msg":"trace[1006191972] transaction","detail":"{read_only:false; response_revision:25422; number_of_response:1; }","duration":"127.778993ms","start":"2026-07-08T22:23:50.69722Z","end":"2026-07-08T22:23:50.824999Z","steps":["trace[1006191972] 'process raft request' (duration: 127.559548ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:50.850698Z","caller":"traceutil/trace.go:171","msg":"trace[829320960] transaction","detail":"{read_only:false; response_revision:25424; number_of_response:1; }","duration":"150.252633ms","start":"2026-07-08T22:23:50.700398Z","end":"2026-07-08T22:23:50.850651Z","steps":["trace[829320960] 'process raft request' (duration: 150.175541ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:50.850763Z","caller":"traceutil/trace.go:171","msg":"trace[1528986894] transaction","detail":"{read_only:false; response_revision:25423; number_of_response:1; }","duration":"151.432479ms","start":"2026-07-08T22:23:50.699289Z","end":"2026-07-08T22:23:50.850721Z","steps":["trace[1528986894] 'process raft request' (duration: 151.099942ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:50.850992Z","caller":"traceutil/trace.go:171","msg":"trace[1648281388] transaction","detail":"{read_only:false; response_revision:25425; number_of_response:1; }","duration":"150.107291ms","start":"2026-07-08T22:23:50.700858Z","end":"2026-07-08T22:23:50.850965Z","steps":["trace[1648281388] 'process raft request' (duration: 149.755443ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:50.851253Z","caller":"traceutil/trace.go:171","msg":"trace[1149396993] transaction","detail":"{read_only:false; response_revision:25426; number_of_response:1; }","duration":"149.458357ms","start":"2026-07-08T22:23:50.701758Z","end":"2026-07-08T22:23:50.851217Z","steps":["trace[1149396993] 'process raft request' (duration: 149.100059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T22:23:53.926063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.021531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T22:23:53.926237Z","caller":"traceutil/trace.go:171","msg":"trace[794703384] transaction","detail":"{read_only:false; response_revision:25449; number_of_response:1; }","duration":"225.530743ms","start":"2026-07-08T22:23:53.700667Z","end":"2026-07-08T22:23:53.926197Z","steps":["trace[794703384] 'process raft request' (duration: 85.267417ms)","trace[794703384] 'compare' (duration: 139.650403ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:54.155992Z","caller":"traceutil/trace.go:171","msg":"trace[943516224] transaction","detail":"{read_only:false; response_revision:25450; number_of_response:1; }","duration":"258.624554ms","start":"2026-07-08T22:23:53.897336Z","end":"2026-07-08T22:23:54.155961Z","steps":["trace[943516224] 'process raft request' (duration: 193.24476ms)","trace[943516224] 'compare' (duration: 65.078658ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T22:23:55.553544Z","caller":"traceutil/trace.go:171","msg":"trace[392220747] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"162.47327ms","start":"2026-07-08T22:23:55.391042Z","end":"2026-07-08T22:23:55.553515Z","steps":["trace[392220747] 'process raft request' (duration: 162.289826ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:55.565891Z","caller":"traceutil/trace.go:171","msg":"trace[1580251939] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"173.50392ms","start":"2026-07-08T22:23:55.392364Z","end":"2026-07-08T22:23:55.565868Z","steps":["trace[1580251939] 'process raft request' (duration: 173.341517ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:55.566219Z","caller":"traceutil/trace.go:171","msg":"trace[726969646] transaction","detail":"{read_only:false; response_revision:25460; number_of_response:1; }","duration":"127.154291ms","start":"2026-07-08T22:23:55.439011Z","end":"2026-07-08T22:23:55.566165Z","steps":["trace[726969646] 'process raft request' (duration: 126.817144ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:23:59.231309Z","caller":"traceutil/trace.go:171","msg":"trace[1587006099] transaction","detail":"{read_only:false; response_revision:25485; number_of_response:1; }","duration":"134.238535ms","start":"2026-07-08T22:23:59.097031Z","end":"2026-07-08T22:23:59.23127Z","steps":["trace[1587006099] 'process raft request' (duration: 133.976059ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T22:24:24.141627Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067d7.wal"} {"level":"info","ts":"2026-07-08T22:24:49.992845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23060} {"level":"info","ts":"2026-07-08T22:24:50.149566Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23060,"took":"149.329813ms","hash":1023472659,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":36618240,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-08T22:24:50.149637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1023472659,"revision":23060,"compact-revision":20117} {"level":"info","ts":"2026-07-08T22:29:50.001701Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26044} {"level":"info","ts":"2026-07-08T22:29:50.166834Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26044,"took":"156.778426ms","hash":216024596,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":35053568,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-08T22:29:50.166888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":216024596,"revision":26044,"compact-revision":23060} {"level":"info","ts":"2026-07-08T22:30:30.55454Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6244e483e416226f","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T22:30:30.559393Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-08T22:30:30.559544Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-08T22:34:50.012174Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28735} {"level":"info","ts":"2026-07-08T22:34:50.158023Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28735,"took":"139.602614ms","hash":3835210083,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":30347264,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-08T22:34:50.158125Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3835210083,"revision":28735,"compact-revision":26044} {"level":"info","ts":"2026-07-08T22:39:50.019837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30954} {"level":"info","ts":"2026-07-08T22:39:50.152949Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30954,"took":"127.924201ms","hash":3190962833,"current-db-size-bytes":58884096,"current-db-size":"59 MB","current-db-size-in-use-bytes":30408704,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-08T22:39:50.153022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3190962833,"revision":30954,"compact-revision":28735} {"level":"info","ts":"2026-07-08T22:44:50.025768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33217} {"level":"info","ts":"2026-07-08T22:44:50.191747Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33217,"took":"160.153ms","hash":875787419,"current-db-size-bytes":59928576,"current-db-size":"60 MB","current-db-size-in-use-bytes":31887360,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T22:44:50.191821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":875787419,"revision":33217,"compact-revision":30954} {"level":"info","ts":"2026-07-08T22:49:50.033589Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35514} {"level":"info","ts":"2026-07-08T22:49:50.196146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35514,"took":"156.782773ms","hash":1539879389,"current-db-size-bytes":60407808,"current-db-size":"60 MB","current-db-size-in-use-bytes":31207424,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-08T22:49:50.196241Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1539879389,"revision":35514,"compact-revision":33217} {"level":"info","ts":"2026-07-08T22:52:01.568847Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6244e483e416226f","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T22:52:01.574545Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-08T22:52:01.574775Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-08T22:54:50.041307Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37740} {"level":"info","ts":"2026-07-08T22:54:50.160341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37740,"took":"113.455118ms","hash":2563720518,"current-db-size-bytes":60407808,"current-db-size":"60 MB","current-db-size-in-use-bytes":32059392,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T22:54:50.16041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2563720518,"revision":37740,"compact-revision":35514}