{"level":"warn","ts":"2026-05-05T22:14:22.212076Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T22:14:22.212165Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-05-05T22:14:22.212225Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T22:14:22.212239Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-05T22:14:22.212259Z","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-05-05T22:14:22.212904Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-05-05T22:14:22.213178Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-05-05T22:14:22.21644Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.061296ms"} {"level":"info","ts":"2026-05-05T22:14:22.222539Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-05-05T22:14:22.222653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T22:14:22.222682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-05-05T22:14:22.222697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T22:14:22.222708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-05-05T22:14:22.222755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-05-05T22:14:22.232517Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T22:14:22.233834Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T22:14:22.234959Z","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-05-05T22:14:22.237087Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T22:14:22.237227Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T22:14:22.237416Z","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-05-05T22:14:22.237519Z","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-05-05T22:14:22.237535Z","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-05-05T22:14:22.238701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-05-05T22:14:22.239398Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-05T22:14:22.241106Z","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-05-05T22:14:22.241217Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-05T22:14:22.241262Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-05T22:14:22.241626Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T22:14:22.241727Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T22:14:22.82372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T22:14:22.823786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T22:14:22.823814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-05-05T22:14:22.82383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-05-05T22:14:22.823838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-05T22:14:22.823852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-05-05T22:14:22.823861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-05T22:14:22.825103Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T22:14:22.825196Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:14:22.825263Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:14:22.825208Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:14:22.8254Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T22:14:22.825475Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T22:14:22.826331Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:14:22.826521Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:14:22.826609Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:14:22.827356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T22:14:22.82991Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-05-05T22:15:01.122688Z","caller":"traceutil/trace.go:171","msg":"trace[466543860] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"130.111521ms","start":"2026-05-05T22:15:00.992545Z","end":"2026-05-05T22:15:01.122657Z","steps":["trace[466543860] 'read index received' (duration: 129.348852ms)","trace[466543860] 'applied index is now lower than readState.Index' (duration: 761.449µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:15:01.122833Z","caller":"traceutil/trace.go:171","msg":"trace[1682760684] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"141.173314ms","start":"2026-05-05T22:15:00.98163Z","end":"2026-05-05T22:15:01.122803Z","steps":["trace[1682760684] 'process raft request' (duration: 140.444745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:15:01.12299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.415758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mqcdw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-05T22:15:01.123103Z","caller":"traceutil/trace.go:171","msg":"trace[1351757459] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mqcdw; range_end:; response_count:1; response_revision:625; }","duration":"130.584303ms","start":"2026-05-05T22:15:00.992497Z","end":"2026-05-05T22:15:01.123081Z","steps":["trace[1351757459] 'agreement among raft nodes before linearized reading' (duration: 130.402448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:15:01.377839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.960723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:15:01.37795Z","caller":"traceutil/trace.go:171","msg":"trace[1349681549] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"246.571081ms","start":"2026-05-05T22:15:01.131363Z","end":"2026-05-05T22:15:01.377934Z","steps":["trace[1349681549] 'process raft request' (duration: 87.94243ms)","trace[1349681549] 'compare' (duration: 157.82432ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:15:01.414434Z","caller":"traceutil/trace.go:171","msg":"trace[1429316719] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"275.569913ms","start":"2026-05-05T22:15:01.138833Z","end":"2026-05-05T22:15:01.414403Z","steps":["trace[1429316719] 'process raft request' (duration: 275.344147ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:15:01.414618Z","caller":"traceutil/trace.go:171","msg":"trace[839245340] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"233.065185ms","start":"2026-05-05T22:15:01.181512Z","end":"2026-05-05T22:15:01.414577Z","steps":["trace[839245340] 'process raft request' (duration: 232.817609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:15:01.799816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.297934ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T22:15:01.799936Z","caller":"traceutil/trace.go:171","msg":"trace[1988717311] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"372.420942ms","start":"2026-05-05T22:15:01.427495Z","end":"2026-05-05T22:15:01.799916Z","steps":["trace[1988717311] 'read index received' (duration: 96.892µs)","trace[1988717311] 'applied index is now lower than readState.Index' (duration: 372.32255ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:15:01.800076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.571046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T22:15:01.800109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.738028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:15:01.800157Z","caller":"traceutil/trace.go:171","msg":"trace[205988958] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:628; }","duration":"372.710839ms","start":"2026-05-05T22:15:01.427427Z","end":"2026-05-05T22:15:01.800138Z","steps":["trace[205988958] 'agreement among raft nodes before linearized reading' (duration: 372.583586ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:15:01.800181Z","caller":"traceutil/trace.go:171","msg":"trace[386651725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"350.833521ms","start":"2026-05-05T22:15:01.449328Z","end":"2026-05-05T22:15:01.800161Z","steps":["trace[386651725] 'agreement among raft nodes before linearized reading' (duration: 350.697508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:15:01.800192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:15:01.427397Z","time spent":"372.788442ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-05T22:15:01.800241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:15:01.449248Z","time spent":"350.983945ms","remote":"127.0.0.1:38406","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-05-05T22:16:31.303539Z","caller":"traceutil/trace.go:171","msg":"trace[1610195925] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"121.642845ms","start":"2026-05-05T22:16:31.181825Z","end":"2026-05-05T22:16:31.303468Z","steps":["trace[1610195925] 'process raft request' (duration: 121.367269ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:31.54563Z","caller":"traceutil/trace.go:171","msg":"trace[1818829574] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"236.900068ms","start":"2026-05-05T22:16:31.308685Z","end":"2026-05-05T22:16:31.545585Z","steps":["trace[1818829574] 'process raft request' (duration: 230.969436ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:31.554472Z","caller":"traceutil/trace.go:171","msg":"trace[1280538720] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1930; }","duration":"105.278283ms","start":"2026-05-05T22:16:31.449167Z","end":"2026-05-05T22:16:31.554445Z","steps":["trace[1280538720] 'read index received' (duration: 90.501218ms)","trace[1280538720] 'applied index is now lower than readState.Index' (duration: 14.775665ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:16:31.554643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.454487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:16:31.554709Z","caller":"traceutil/trace.go:171","msg":"trace[857946799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1858; }","duration":"105.58555ms","start":"2026-05-05T22:16:31.449108Z","end":"2026-05-05T22:16:31.554693Z","steps":["trace[857946799] 'agreement among raft nodes before linearized reading' (duration: 105.456157ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:44.635728Z","caller":"traceutil/trace.go:171","msg":"trace[1454691067] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"143.517763ms","start":"2026-05-05T22:16:44.492183Z","end":"2026-05-05T22:16:44.635701Z","steps":["trace[1454691067] 'process raft request' (duration: 143.317067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:17:22.334155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.253346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:17:22.33442Z","caller":"traceutil/trace.go:171","msg":"trace[1358258005] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"157.36393ms","start":"2026-05-05T22:17:22.177035Z","end":"2026-05-05T22:17:22.334399Z","steps":["trace[1358258005] 'process raft request' (duration: 157.284038ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:17:22.334465Z","caller":"traceutil/trace.go:171","msg":"trace[1789345263] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"158.537528ms","start":"2026-05-05T22:17:22.175881Z","end":"2026-05-05T22:17:22.334418Z","steps":["trace[1789345263] 'process raft request' (duration: 43.871702ms)","trace[1789345263] 'compare' (duration: 114.036571ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:17:22.575798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.150395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:17:22.575999Z","caller":"traceutil/trace.go:171","msg":"trace[374522086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2193; }","duration":"126.421942ms","start":"2026-05-05T22:17:22.449553Z","end":"2026-05-05T22:17:22.575975Z","steps":["trace[374522086] 'range keys from in-memory index tree' (duration: 125.947561ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:18:18.255614Z","caller":"traceutil/trace.go:171","msg":"trace[790797115] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"139.853596ms","start":"2026-05-05T22:18:18.11573Z","end":"2026-05-05T22:18:18.255583Z","steps":["trace[790797115] 'process raft request' (duration: 139.668022ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:18:52.263485Z","caller":"traceutil/trace.go:171","msg":"trace[236074715] linearizableReadLoop","detail":"{readStateIndex:2979; appliedIndex:2978; }","duration":"124.282754ms","start":"2026-05-05T22:18:52.13917Z","end":"2026-05-05T22:18:52.263453Z","steps":["trace[236074715] 'read index received' (duration: 60.878687ms)","trace[236074715] 'applied index is now lower than readState.Index' (duration: 63.396397ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:18:52.263713Z","caller":"traceutil/trace.go:171","msg":"trace[1004270367] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"199.442092ms","start":"2026-05-05T22:18:52.064172Z","end":"2026-05-05T22:18:52.263614Z","steps":["trace[1004270367] 'process raft request' (duration: 135.953123ms)","trace[1004270367] 'compare' (duration: 63.14977ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:18:52.263825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.643133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-05T22:18:52.263875Z","caller":"traceutil/trace.go:171","msg":"trace[902346822] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2868; }","duration":"124.712975ms","start":"2026-05-05T22:18:52.13915Z","end":"2026-05-05T22:18:52.263863Z","steps":["trace[902346822] 'agreement among raft nodes before linearized reading' (duration: 124.52761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:23:00.886259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.20372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-w8lfs\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-05-05T22:23:00.886373Z","caller":"traceutil/trace.go:171","msg":"trace[189190399] range","detail":"{range_begin:/registry/pods/openstack/keepalived-w8lfs; range_end:; response_count:1; response_revision:5120; }","duration":"146.380364ms","start":"2026-05-05T22:23:00.73997Z","end":"2026-05-05T22:23:00.88635Z","steps":["trace[189190399] 'range keys from in-memory index tree' (duration: 145.915974ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:10.795274Z","caller":"traceutil/trace.go:171","msg":"trace[768076164] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"109.159816ms","start":"2026-05-05T22:23:10.68608Z","end":"2026-05-05T22:23:10.79524Z","steps":["trace[768076164] 'process raft request' (duration: 39.736199ms)","trace[768076164] 'compare' (duration: 68.655099ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:23:11.205777Z","caller":"traceutil/trace.go:171","msg":"trace[108516702] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"251.517303ms","start":"2026-05-05T22:23:10.954226Z","end":"2026-05-05T22:23:11.205743Z","steps":["trace[108516702] 'process raft request' (duration: 173.026269ms)","trace[108516702] 'compare' (duration: 78.287199ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:23:11.206025Z","caller":"traceutil/trace.go:171","msg":"trace[108157472] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"251.746079ms","start":"2026-05-05T22:23:10.954258Z","end":"2026-05-05T22:23:11.206004Z","steps":["trace[108157472] 'process raft request' (duration: 251.422901ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:11.20601Z","caller":"traceutil/trace.go:171","msg":"trace[1252295942] linearizableReadLoop","detail":"{readStateIndex:5537; appliedIndex:5535; }","duration":"251.574956ms","start":"2026-05-05T22:23:10.954377Z","end":"2026-05-05T22:23:11.205951Z","steps":["trace[1252295942] 'read index received' (duration: 26.487312ms)","trace[1252295942] 'applied index is now lower than readState.Index' (duration: 225.083044ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:23:11.206425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.022076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:71036"} {"level":"info","ts":"2026-05-05T22:23:11.206525Z","caller":"traceutil/trace.go:171","msg":"trace[39323534] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5334; }","duration":"252.17043ms","start":"2026-05-05T22:23:10.954334Z","end":"2026-05-05T22:23:11.206505Z","steps":["trace[39323534] 'agreement among raft nodes before linearized reading' (duration: 251.767851ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:19.1582Z","caller":"traceutil/trace.go:171","msg":"trace[689184568] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"152.750705ms","start":"2026-05-05T22:23:19.00542Z","end":"2026-05-05T22:23:19.158171Z","steps":["trace[689184568] 'process raft request' (duration: 94.544486ms)","trace[689184568] 'compare' (duration: 58.003165ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:23:19.268093Z","caller":"traceutil/trace.go:171","msg":"trace[554948377] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"261.740618ms","start":"2026-05-05T22:23:19.006324Z","end":"2026-05-05T22:23:19.268064Z","steps":["trace[554948377] 'process raft request' (duration: 259.148267ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:19.268484Z","caller":"traceutil/trace.go:171","msg":"trace[429796479] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"261.603335ms","start":"2026-05-05T22:23:19.006827Z","end":"2026-05-05T22:23:19.268431Z","steps":["trace[429796479] 'process raft request' (duration: 261.146714ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:19.268639Z","caller":"traceutil/trace.go:171","msg":"trace[1486570704] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"261.296289ms","start":"2026-05-05T22:23:19.007313Z","end":"2026-05-05T22:23:19.268609Z","steps":["trace[1486570704] 'process raft request' (duration: 260.985071ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:19.268796Z","caller":"traceutil/trace.go:171","msg":"trace[1302761526] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"261.078382ms","start":"2026-05-05T22:23:19.007707Z","end":"2026-05-05T22:23:19.268786Z","steps":["trace[1302761526] 'process raft request' (duration: 260.814166ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:23:19.26881Z","caller":"traceutil/trace.go:171","msg":"trace[185852524] linearizableReadLoop","detail":"{readStateIndex:5710; appliedIndex:5704; }","duration":"260.320205ms","start":"2026-05-05T22:23:19.008468Z","end":"2026-05-05T22:23:19.268788Z","steps":["trace[185852524] 'read index received' (duration: 91.567746ms)","trace[185852524] 'applied index is now lower than readState.Index' (duration: 168.751229ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:23:19.268836Z","caller":"traceutil/trace.go:171","msg":"trace[1165200737] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"260.98229ms","start":"2026-05-05T22:23:19.007824Z","end":"2026-05-05T22:23:19.268806Z","steps":["trace[1165200737] 'process raft request' (duration: 260.880198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:23:19.269046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.55129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bf529a07-5b0d-49aa-a9b1-f7719b099700\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-05T22:23:19.269087Z","caller":"traceutil/trace.go:171","msg":"trace[704097314] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bf529a07-5b0d-49aa-a9b1-f7719b099700; range_end:; response_count:1; response_revision:5503; }","duration":"260.656433ms","start":"2026-05-05T22:23:19.008418Z","end":"2026-05-05T22:23:19.269074Z","steps":["trace[704097314] 'agreement among raft nodes before linearized reading' (duration: 260.471198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:23:19.26916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.518731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T22:23:19.269264Z","caller":"traceutil/trace.go:171","msg":"trace[1615685647] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5503; }","duration":"139.709815ms","start":"2026-05-05T22:23:19.12953Z","end":"2026-05-05T22:23:19.26924Z","steps":["trace[1615685647] 'agreement among raft nodes before linearized reading' (duration: 139.428309ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:24:22.860459Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3039} {"level":"info","ts":"2026-05-05T22:24:22.952623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3039,"took":"89.674371ms","hash":3852572922,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-05T22:24:22.95268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3852572922,"revision":3039,"compact-revision":-1} {"level":"info","ts":"2026-05-05T22:29:22.871557Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6092} {"level":"info","ts":"2026-05-05T22:29:22.961446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6092,"took":"87.779441ms","hash":558483929,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":21663744,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-05T22:29:22.961521Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":558483929,"revision":6092,"compact-revision":3039} {"level":"info","ts":"2026-05-05T22:29:33.258576Z","caller":"traceutil/trace.go:171","msg":"trace[383029261] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"115.504892ms","start":"2026-05-05T22:29:33.143051Z","end":"2026-05-05T22:29:33.258556Z","steps":["trace[383029261] 'process raft request' (duration: 115.380649ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:18.26896Z","caller":"traceutil/trace.go:171","msg":"trace[131676649] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"234.864058ms","start":"2026-05-05T22:30:18.034049Z","end":"2026-05-05T22:30:18.268914Z","steps":["trace[131676649] 'process raft request' (duration: 208.668835ms)","trace[131676649] 'compare' (duration: 26.060899ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:30:18.421538Z","caller":"traceutil/trace.go:171","msg":"trace[1178128337] linearizableReadLoop","detail":"{readStateIndex:8972; appliedIndex:8970; }","duration":"264.467764ms","start":"2026-05-05T22:30:18.157031Z","end":"2026-05-05T22:30:18.421499Z","steps":["trace[1178128337] 'read index received' (duration: 85.701512ms)","trace[1178128337] 'applied index is now lower than readState.Index' (duration: 178.764802ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:30:18.421607Z","caller":"traceutil/trace.go:171","msg":"trace[216819278] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"342.813727ms","start":"2026-05-05T22:30:18.078735Z","end":"2026-05-05T22:30:18.421548Z","steps":["trace[216819278] 'process raft request' (duration: 297.183863ms)","trace[216819278] 'compare' (duration: 45.403297ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:30:18.42185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:30:18.0787Z","time spent":"343.021562ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:30:18.421927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.777001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-05T22:30:18.421955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.834453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-05T22:30:18.42189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.834862ms","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-05-05T22:30:18.422049Z","caller":"traceutil/trace.go:171","msg":"trace[218510984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8662; }","duration":"265.074168ms","start":"2026-05-05T22:30:18.156963Z","end":"2026-05-05T22:30:18.422037Z","steps":["trace[218510984] 'agreement among raft nodes before linearized reading' (duration: 264.691748ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:18.422Z","caller":"traceutil/trace.go:171","msg":"trace[1107503174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8662; }","duration":"149.927255ms","start":"2026-05-05T22:30:18.272054Z","end":"2026-05-05T22:30:18.421981Z","steps":["trace[1107503174] 'agreement among raft nodes before linearized reading' (duration: 149.665099ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:18.422055Z","caller":"traceutil/trace.go:171","msg":"trace[1576119815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8662; }","duration":"130.980406ms","start":"2026-05-05T22:30:18.291052Z","end":"2026-05-05T22:30:18.422032Z","steps":["trace[1576119815] 'agreement among raft nodes before linearized reading' (duration: 130.73251ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:28.177911Z","caller":"traceutil/trace.go:171","msg":"trace[1614671945] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"140.826964ms","start":"2026-05-05T22:30:28.037032Z","end":"2026-05-05T22:30:28.177858Z","steps":["trace[1614671945] 'process raft request' (duration: 140.499806ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:28.500522Z","caller":"traceutil/trace.go:171","msg":"trace[1956958267] transaction","detail":"{read_only:false; response_revision:8758; number_of_response:1; }","duration":"191.751144ms","start":"2026-05-05T22:30:28.308744Z","end":"2026-05-05T22:30:28.500495Z","steps":["trace[1956958267] 'process raft request' (duration: 115.200254ms)","trace[1956958267] 'compare' (duration: 76.288824ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:30:28.500618Z","caller":"traceutil/trace.go:171","msg":"trace[1926650359] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"151.005919ms","start":"2026-05-05T22:30:28.34957Z","end":"2026-05-05T22:30:28.500575Z","steps":["trace[1926650359] 'process raft request' (duration: 150.817085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:30:28.937107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.591796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2212891"} {"level":"info","ts":"2026-05-05T22:30:28.937217Z","caller":"traceutil/trace.go:171","msg":"trace[559498333] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8766; }","duration":"130.75416ms","start":"2026-05-05T22:30:28.806438Z","end":"2026-05-05T22:30:28.937192Z","steps":["trace[559498333] 'range keys from in-memory index tree' (duration: 129.549801ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:30:43.575356Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002401.wal"} {"level":"info","ts":"2026-05-05T22:32:03.94617Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T22:32:03.95492Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-05T22:32:03.955084Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-05T22:34:22.884151Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8175} {"level":"info","ts":"2026-05-05T22:34:22.951672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8175,"took":"65.075825ms","hash":2767349567,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":28078080,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-05T22:34:22.951734Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2767349567,"revision":8175,"compact-revision":6092} {"level":"info","ts":"2026-05-05T22:37:20.846071Z","caller":"traceutil/trace.go:171","msg":"trace[1593718310] transaction","detail":"{read_only:false; response_revision:11928; number_of_response:1; }","duration":"135.709965ms","start":"2026-05-05T22:37:20.710332Z","end":"2026-05-05T22:37:20.846042Z","steps":["trace[1593718310] 'process raft request' (duration: 108.251287ms)","trace[1593718310] 'compare' (duration: 27.315185ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:37:20.862595Z","caller":"traceutil/trace.go:171","msg":"trace[1630441162] transaction","detail":"{read_only:false; response_revision:11929; number_of_response:1; }","duration":"151.800641ms","start":"2026-05-05T22:37:20.710744Z","end":"2026-05-05T22:37:20.862544Z","steps":["trace[1630441162] 'process raft request' (duration: 151.595157ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:37:20.862882Z","caller":"traceutil/trace.go:171","msg":"trace[1078992907] transaction","detail":"{read_only:false; response_revision:11930; number_of_response:1; }","duration":"151.788361ms","start":"2026-05-05T22:37:20.71103Z","end":"2026-05-05T22:37:20.862818Z","steps":["trace[1078992907] 'process raft request' (duration: 151.444023ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:37:22.16546Z","caller":"traceutil/trace.go:171","msg":"trace[733104827] transaction","detail":"{read_only:false; response_revision:11939; number_of_response:1; }","duration":"102.668312ms","start":"2026-05-05T22:37:22.062768Z","end":"2026-05-05T22:37:22.165436Z","steps":["trace[733104827] 'process raft request' (duration: 45.304966ms)","trace[733104827] 'compare' (duration: 56.815463ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:39:22.890707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10541} {"level":"info","ts":"2026-05-05T22:39:22.974031Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10541,"took":"80.89709ms","hash":2013604408,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":26320896,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-05T22:39:22.974094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2013604408,"revision":10541,"compact-revision":8175} {"level":"info","ts":"2026-05-05T22:43:41.669742Z","caller":"traceutil/trace.go:171","msg":"trace[637935193] transaction","detail":"{read_only:false; response_revision:14486; number_of_response:1; }","duration":"200.600934ms","start":"2026-05-05T22:43:41.469113Z","end":"2026-05-05T22:43:41.669714Z","steps":["trace[637935193] 'process raft request' (duration: 200.446221ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:43:41.708273Z","caller":"traceutil/trace.go:171","msg":"trace[1391398920] transaction","detail":"{read_only:false; response_revision:14487; number_of_response:1; }","duration":"193.483163ms","start":"2026-05-05T22:43:41.514766Z","end":"2026-05-05T22:43:41.70825Z","steps":["trace[1391398920] 'process raft request' (duration: 193.34878ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:43:56.730702Z","caller":"traceutil/trace.go:171","msg":"trace[2085060196] transaction","detail":"{read_only:false; response_revision:14562; number_of_response:1; }","duration":"111.69214ms","start":"2026-05-05T22:43:56.61898Z","end":"2026-05-05T22:43:56.730672Z","steps":["trace[2085060196] 'process raft request' (duration: 58.058039ms)","trace[2085060196] 'compare' (duration: 53.512178ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:43:56.732254Z","caller":"traceutil/trace.go:171","msg":"trace[287602142] transaction","detail":"{read_only:false; response_revision:14563; number_of_response:1; }","duration":"113.109485ms","start":"2026-05-05T22:43:56.619111Z","end":"2026-05-05T22:43:56.732221Z","steps":["trace[287602142] 'process raft request' (duration: 112.859669ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:44:03.280941Z","caller":"traceutil/trace.go:171","msg":"trace[1018646637] transaction","detail":"{read_only:false; response_revision:14626; number_of_response:1; }","duration":"133.596233ms","start":"2026-05-05T22:44:03.147315Z","end":"2026-05-05T22:44:03.280912Z","steps":["trace[1018646637] 'process raft request' (duration: 133.419119ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:44:22.896361Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12767} {"level":"info","ts":"2026-05-05T22:44:22.977957Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12767,"took":"78.824637ms","hash":911431703,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":28311552,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-05T22:44:22.978036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":911431703,"revision":12767,"compact-revision":10541} {"level":"warn","ts":"2026-05-05T22:45:11.77055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.420686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"warn","ts":"2026-05-05T22:45:11.770631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.659372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T22:45:11.770624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.727424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:45:11.770657Z","caller":"traceutil/trace.go:171","msg":"trace[2016538530] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15526; }","duration":"105.57896ms","start":"2026-05-05T22:45:11.665055Z","end":"2026-05-05T22:45:11.770634Z","steps":["trace[2016538530] 'range keys from in-memory index tree' (duration: 105.203311ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:45:11.77071Z","caller":"traceutil/trace.go:171","msg":"trace[328140930] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15526; }","duration":"105.781945ms","start":"2026-05-05T22:45:11.664908Z","end":"2026-05-05T22:45:11.77069Z","steps":["trace[328140930] 'range keys from in-memory index tree' (duration: 105.5651ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:45:11.770713Z","caller":"traceutil/trace.go:171","msg":"trace[2117407716] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15526; }","duration":"105.873307ms","start":"2026-05-05T22:45:11.664825Z","end":"2026-05-05T22:45:11.770698Z","steps":["trace[2117407716] 'range keys from in-memory index tree' (duration: 105.622061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:45:11.770785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.926739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"warn","ts":"2026-05-05T22:45:11.771008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.456982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-05T22:45:11.771132Z","caller":"traceutil/trace.go:171","msg":"trace[242194166] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15526; }","duration":"104.598545ms","start":"2026-05-05T22:45:11.666511Z","end":"2026-05-05T22:45:11.77111Z","steps":["trace[242194166] 'range keys from in-memory index tree' (duration: 104.184425ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:45:11.770911Z","caller":"traceutil/trace.go:171","msg":"trace[1418796410] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15526; }","duration":"106.124233ms","start":"2026-05-05T22:45:11.664761Z","end":"2026-05-05T22:45:11.770885Z","steps":["trace[1418796410] 'range keys from in-memory index tree' (duration: 105.705833ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:45:35.852474Z","caller":"traceutil/trace.go:171","msg":"trace[22999075] transaction","detail":"{read_only:false; response_revision:15650; number_of_response:1; }","duration":"217.159446ms","start":"2026-05-05T22:45:35.635283Z","end":"2026-05-05T22:45:35.852443Z","steps":["trace[22999075] 'process raft request' (duration: 216.804387ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:48:45.826Z","caller":"traceutil/trace.go:171","msg":"trace[664263201] transaction","detail":"{read_only:false; response_revision:17158; number_of_response:1; }","duration":"126.525382ms","start":"2026-05-05T22:48:45.69943Z","end":"2026-05-05T22:48:45.825956Z","steps":["trace[664263201] 'process raft request' (duration: 116.732882ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:48:46.546535Z","caller":"traceutil/trace.go:171","msg":"trace[1268058939] transaction","detail":"{read_only:false; response_revision:17163; number_of_response:1; }","duration":"137.10622ms","start":"2026-05-05T22:48:46.409398Z","end":"2026-05-05T22:48:46.546505Z","steps":["trace[1268058939] 'process raft request' (duration: 136.903585ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:48:46.546696Z","caller":"traceutil/trace.go:171","msg":"trace[1195769203] transaction","detail":"{read_only:false; response_revision:17164; number_of_response:1; }","duration":"136.969526ms","start":"2026-05-05T22:48:46.409712Z","end":"2026-05-05T22:48:46.546682Z","steps":["trace[1195769203] 'process raft request' (duration: 136.745421ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:48:46.546646Z","caller":"traceutil/trace.go:171","msg":"trace[207143103] linearizableReadLoop","detail":"{readStateIndex:17760; appliedIndex:17757; }","duration":"118.540456ms","start":"2026-05-05T22:48:46.428072Z","end":"2026-05-05T22:48:46.546612Z","steps":["trace[207143103] 'read index received' (duration: 62.774173ms)","trace[207143103] 'applied index is now lower than readState.Index' (duration: 55.764403ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:48:46.546967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.309788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-g55pp\" ","response":"range_response_count:1 size:22100"} {"level":"info","ts":"2026-05-05T22:48:46.547003Z","caller":"traceutil/trace.go:171","msg":"trace[1675161397] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-g55pp; range_end:; response_count:1; response_revision:17164; }","duration":"115.41189ms","start":"2026-05-05T22:48:46.43158Z","end":"2026-05-05T22:48:46.546992Z","steps":["trace[1675161397] 'agreement among raft nodes before linearized reading' (duration: 115.282477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:48:46.547002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.884823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T22:48:46.547106Z","caller":"traceutil/trace.go:171","msg":"trace[1264042977] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:17164; }","duration":"119.014307ms","start":"2026-05-05T22:48:46.428051Z","end":"2026-05-05T22:48:46.547065Z","steps":["trace[1264042977] 'agreement among raft nodes before linearized reading' (duration: 118.785532ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:49:22.90276Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14918} {"level":"info","ts":"2026-05-05T22:49:22.995667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14918,"took":"89.715142ms","hash":2810670408,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":30302208,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-05T22:49:22.995846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2810670408,"revision":14918,"compact-revision":12767} {"level":"info","ts":"2026-05-05T22:51:42.78632Z","caller":"traceutil/trace.go:171","msg":"trace[98167960] transaction","detail":"{read_only:false; response_revision:18326; number_of_response:1; }","duration":"347.226054ms","start":"2026-05-05T22:51:42.439064Z","end":"2026-05-05T22:51:42.78629Z","steps":["trace[98167960] 'process raft request' (duration: 347.016319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:42.786516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:51:42.43904Z","time spent":"347.378337ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20974,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:51:42.852944Z","caller":"traceutil/trace.go:171","msg":"trace[1356218981] transaction","detail":"{read_only:false; response_revision:18327; number_of_response:1; }","duration":"377.258818ms","start":"2026-05-05T22:51:42.475633Z","end":"2026-05-05T22:51:42.852892Z","steps":["trace[1356218981] 'process raft request' (duration: 376.951209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:42.853079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.845399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T22:51:42.853086Z","caller":"traceutil/trace.go:171","msg":"trace[355355499] linearizableReadLoop","detail":"{readStateIndex:18964; appliedIndex:18962; }","duration":"241.537712ms","start":"2026-05-05T22:51:42.611207Z","end":"2026-05-05T22:51:42.852744Z","steps":["trace[355355499] 'read index received' (duration: 174.870413ms)","trace[355355499] 'applied index is now lower than readState.Index' (duration: 66.666449ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:51:42.853174Z","caller":"traceutil/trace.go:171","msg":"trace[960399416] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:18327; }","duration":"241.998983ms","start":"2026-05-05T22:51:42.611151Z","end":"2026-05-05T22:51:42.85315Z","steps":["trace[960399416] 'agreement among raft nodes before linearized reading' (duration: 241.802298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:42.853527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.377652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-g55pp\" ","response":"range_response_count:1 size:22100"} {"level":"info","ts":"2026-05-05T22:51:42.853628Z","caller":"traceutil/trace.go:171","msg":"trace[398472153] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-g55pp; range_end:; response_count:1; response_revision:18327; }","duration":"118.492486ms","start":"2026-05-05T22:51:42.735072Z","end":"2026-05-05T22:51:42.853565Z","steps":["trace[398472153] 'agreement among raft nodes before linearized reading' (duration: 118.207669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:42.853857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:51:42.475615Z","time spent":"377.491694ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:51:51.557821Z","caller":"traceutil/trace.go:171","msg":"trace[601110287] linearizableReadLoop","detail":"{readStateIndex:19133; appliedIndex:19132; }","duration":"130.460718ms","start":"2026-05-05T22:51:51.427333Z","end":"2026-05-05T22:51:51.557794Z","steps":["trace[601110287] 'read index received' (duration: 130.174831ms)","trace[601110287] 'applied index is now lower than readState.Index' (duration: 284.937µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:51:51.558212Z","caller":"traceutil/trace.go:171","msg":"trace[1738986598] transaction","detail":"{read_only:false; response_revision:18491; number_of_response:1; }","duration":"131.659257ms","start":"2026-05-05T22:51:51.426537Z","end":"2026-05-05T22:51:51.558197Z","steps":["trace[1738986598] 'process raft request' (duration: 131.050042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:51.558853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.502073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111916"} {"level":"info","ts":"2026-05-05T22:51:51.558947Z","caller":"traceutil/trace.go:171","msg":"trace[1827893524] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:18491; }","duration":"131.614245ms","start":"2026-05-05T22:51:51.427315Z","end":"2026-05-05T22:51:51.55893Z","steps":["trace[1827893524] 'agreement among raft nodes before linearized reading' (duration: 131.124143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:51.582549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.213958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-05-05T22:51:51.582631Z","caller":"traceutil/trace.go:171","msg":"trace[1287711484] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:18492; }","duration":"154.34244ms","start":"2026-05-05T22:51:51.428272Z","end":"2026-05-05T22:51:51.582614Z","steps":["trace[1287711484] 'agreement among raft nodes before linearized reading' (duration: 154.135195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:51.582664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.725635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111916"} {"level":"info","ts":"2026-05-05T22:51:51.582729Z","caller":"traceutil/trace.go:171","msg":"trace[1785828585] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:18492; }","duration":"153.822908ms","start":"2026-05-05T22:51:51.428887Z","end":"2026-05-05T22:51:51.582709Z","steps":["trace[1785828585] 'agreement among raft nodes before linearized reading' (duration: 153.48324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:51.582548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.302514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T22:51:51.582799Z","caller":"traceutil/trace.go:171","msg":"trace[497578105] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:18492; }","duration":"103.601841ms","start":"2026-05-05T22:51:51.479164Z","end":"2026-05-05T22:51:51.582766Z","steps":["trace[497578105] 'agreement among raft nodes before linearized reading' (duration: 103.221272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:51:51.583075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.786504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T22:51:51.583117Z","caller":"traceutil/trace.go:171","msg":"trace[1783003386] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:18492; }","duration":"132.881036ms","start":"2026-05-05T22:51:51.450223Z","end":"2026-05-05T22:51:51.583104Z","steps":["trace[1783003386] 'agreement among raft nodes before linearized reading' (duration: 132.114318ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.399512Z","caller":"traceutil/trace.go:171","msg":"trace[374497899] transaction","detail":"{read_only:false; response_revision:18830; number_of_response:1; }","duration":"145.119395ms","start":"2026-05-05T22:52:24.254364Z","end":"2026-05-05T22:52:24.399484Z","steps":["trace[374497899] 'process raft request' (duration: 144.852779ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.399561Z","caller":"traceutil/trace.go:171","msg":"trace[847893110] linearizableReadLoop","detail":"{readStateIndex:19486; appliedIndex:19482; }","duration":"121.603231ms","start":"2026-05-05T22:52:24.277905Z","end":"2026-05-05T22:52:24.399508Z","steps":["trace[847893110] 'read index received' (duration: 121.370365ms)","trace[847893110] 'applied index is now lower than readState.Index' (duration: 231.756µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:52:24.399665Z","caller":"traceutil/trace.go:171","msg":"trace[437896929] transaction","detail":"{read_only:false; response_revision:18833; number_of_response:1; }","duration":"141.670831ms","start":"2026-05-05T22:52:24.257983Z","end":"2026-05-05T22:52:24.399653Z","steps":["trace[437896929] 'process raft request' (duration: 141.489207ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.399676Z","caller":"traceutil/trace.go:171","msg":"trace[685201999] transaction","detail":"{read_only:false; response_revision:18831; number_of_response:1; }","duration":"144.90733ms","start":"2026-05-05T22:52:24.254763Z","end":"2026-05-05T22:52:24.39967Z","steps":["trace[685201999] 'process raft request' (duration: 144.613033ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.399659Z","caller":"traceutil/trace.go:171","msg":"trace[341019635] transaction","detail":"{read_only:false; response_revision:18832; number_of_response:1; }","duration":"142.202714ms","start":"2026-05-05T22:52:24.257394Z","end":"2026-05-05T22:52:24.399597Z","steps":["trace[341019635] 'process raft request' (duration: 142.02526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:52:24.399939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.01798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1286"} {"level":"info","ts":"2026-05-05T22:52:24.40001Z","caller":"traceutil/trace.go:171","msg":"trace[952104479] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:18833; }","duration":"122.139944ms","start":"2026-05-05T22:52:24.277852Z","end":"2026-05-05T22:52:24.399992Z","steps":["trace[952104479] 'agreement among raft nodes before linearized reading' (duration: 121.852296ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.430478Z","caller":"traceutil/trace.go:171","msg":"trace[1513598087] transaction","detail":"{read_only:false; response_revision:18834; number_of_response:1; }","duration":"151.083742ms","start":"2026-05-05T22:52:24.279353Z","end":"2026-05-05T22:52:24.430437Z","steps":["trace[1513598087] 'process raft request' (duration: 150.846836ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:52:24.430579Z","caller":"traceutil/trace.go:171","msg":"trace[310947532] transaction","detail":"{read_only:false; response_revision:18835; number_of_response:1; }","duration":"149.0048ms","start":"2026-05-05T22:52:24.281548Z","end":"2026-05-05T22:52:24.430553Z","steps":["trace[310947532] 'process raft request' (duration: 148.753854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:52:24.430859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.910334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T22:52:24.430976Z","caller":"traceutil/trace.go:171","msg":"trace[1723933407] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:18835; }","duration":"150.067777ms","start":"2026-05-05T22:52:24.280892Z","end":"2026-05-05T22:52:24.430959Z","steps":["trace[1723933407] 'agreement among raft nodes before linearized reading' (duration: 149.839561ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:53:23.571598Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T22:53:23.578455Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-05T22:53:23.578559Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-05T22:54:22.907988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17383} {"level":"info","ts":"2026-05-05T22:54:23.004781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17383,"took":"93.968068ms","hash":3538859668,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":34476032,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-05T22:54:23.004893Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3538859668,"revision":17383,"compact-revision":14918} {"level":"info","ts":"2026-05-05T22:57:51.683836Z","caller":"traceutil/trace.go:171","msg":"trace[397872952] transaction","detail":"{read_only:false; response_revision:21132; number_of_response:1; }","duration":"127.765494ms","start":"2026-05-05T22:57:51.556026Z","end":"2026-05-05T22:57:51.683792Z","steps":["trace[397872952] 'process raft request' (duration: 127.349754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:52.000741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.65313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T22:57:52.000858Z","caller":"traceutil/trace.go:171","msg":"trace[1079725320] transaction","detail":"{read_only:false; response_revision:21133; number_of_response:1; }","duration":"312.234035ms","start":"2026-05-05T22:57:51.688605Z","end":"2026-05-05T22:57:52.000839Z","steps":["trace[1079725320] 'process raft request' (duration: 119.223537ms)","trace[1079725320] 'compare' (duration: 192.488825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:57:52.000938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:57:51.688575Z","time spent":"312.325567ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:57:52.027445Z","caller":"traceutil/trace.go:171","msg":"trace[553226351] linearizableReadLoop","detail":"{readStateIndex:21865; appliedIndex:21863; }","duration":"101.267124ms","start":"2026-05-05T22:57:51.926147Z","end":"2026-05-05T22:57:52.027414Z","steps":["trace[553226351] 'read index received' (duration: 100.939586ms)","trace[553226351] 'applied index is now lower than readState.Index' (duration: 325.658µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:57:52.027613Z","caller":"traceutil/trace.go:171","msg":"trace[398956562] transaction","detail":"{read_only:false; response_revision:21135; number_of_response:1; }","duration":"338.298455ms","start":"2026-05-05T22:57:51.689305Z","end":"2026-05-05T22:57:52.027603Z","steps":["trace[398956562] 'process raft request' (duration: 338.058509ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:57:52.027618Z","caller":"traceutil/trace.go:171","msg":"trace[1298834781] transaction","detail":"{read_only:false; response_revision:21134; number_of_response:1; }","duration":"338.324226ms","start":"2026-05-05T22:57:51.689259Z","end":"2026-05-05T22:57:52.027583Z","steps":["trace[1298834781] 'process raft request' (duration: 337.945147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:52.027729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:57:51.689284Z","time spent":"338.353066ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:57:52.027852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:57:51.689241Z","time spent":"338.496059ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:57:52.027974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.804247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-05-05T22:57:52.028071Z","caller":"traceutil/trace.go:171","msg":"trace[87415341] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:21135; }","duration":"101.962431ms","start":"2026-05-05T22:57:51.926084Z","end":"2026-05-05T22:57:52.028046Z","steps":["trace[87415341] 'agreement among raft nodes before linearized reading' (duration: 101.637823ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:57:52.18599Z","caller":"traceutil/trace.go:171","msg":"trace[928429442] linearizableReadLoop","detail":"{readStateIndex:21866; appliedIndex:21865; }","duration":"152.124671ms","start":"2026-05-05T22:57:52.033836Z","end":"2026-05-05T22:57:52.185961Z","steps":["trace[928429442] 'read index received' (duration: 131.643637ms)","trace[928429442] 'applied index is now lower than readState.Index' (duration: 20.479774ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:57:52.186103Z","caller":"traceutil/trace.go:171","msg":"trace[1905097011] transaction","detail":"{read_only:false; response_revision:21136; number_of_response:1; }","duration":"152.599512ms","start":"2026-05-05T22:57:52.033445Z","end":"2026-05-05T22:57:52.186045Z","steps":["trace[1905097011] 'process raft request' (duration: 132.095498ms)","trace[1905097011] 'compare' (duration: 20.281629ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:57:52.186219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.365697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18259"} {"level":"info","ts":"2026-05-05T22:57:52.186261Z","caller":"traceutil/trace.go:171","msg":"trace[1618301493] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21136; }","duration":"152.422678ms","start":"2026-05-05T22:57:52.033826Z","end":"2026-05-05T22:57:52.186249Z","steps":["trace[1618301493] 'agreement among raft nodes before linearized reading' (duration: 152.247184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:52.454008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.155288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T22:57:52.454128Z","caller":"traceutil/trace.go:171","msg":"trace[984013932] linearizableReadLoop","detail":"{readStateIndex:21867; appliedIndex:21866; }","duration":"201.952304ms","start":"2026-05-05T22:57:52.252159Z","end":"2026-05-05T22:57:52.454111Z","steps":["trace[984013932] 'read index received' (duration: 57.501759ms)","trace[984013932] 'applied index is now lower than readState.Index' (duration: 144.449175ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:57:52.454404Z","caller":"traceutil/trace.go:171","msg":"trace[1930807002] transaction","detail":"{read_only:false; response_revision:21137; number_of_response:1; }","duration":"210.997592ms","start":"2026-05-05T22:57:52.243361Z","end":"2026-05-05T22:57:52.454359Z","steps":["trace[1930807002] 'process raft request' (duration: 66.400943ms)","trace[1930807002] 'compare' (duration: 144.036806ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:57:52.454538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.505971ms","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":"info","ts":"2026-05-05T22:57:52.454669Z","caller":"traceutil/trace.go:171","msg":"trace[1901847773] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21137; }","duration":"157.686205ms","start":"2026-05-05T22:57:52.29697Z","end":"2026-05-05T22:57:52.454656Z","steps":["trace[1901847773] 'agreement among raft nodes before linearized reading' (duration: 157.537511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:52.454473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.313722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T22:57:52.454789Z","caller":"traceutil/trace.go:171","msg":"trace[293801022] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21137; }","duration":"202.667581ms","start":"2026-05-05T22:57:52.2521Z","end":"2026-05-05T22:57:52.454768Z","steps":["trace[293801022] 'agreement among raft nodes before linearized reading' (duration: 202.290112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:52.726137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.028273ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T22:57:52.726434Z","caller":"traceutil/trace.go:171","msg":"trace[1526628531] transaction","detail":"{read_only:false; response_revision:21138; number_of_response:1; }","duration":"131.415202ms","start":"2026-05-05T22:57:52.594976Z","end":"2026-05-05T22:57:52.726392Z","steps":["trace[1526628531] 'process raft request' (duration: 24.052771ms)","trace[1526628531] 'compare' (duration: 106.89964ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:57:53.303251Z","caller":"traceutil/trace.go:171","msg":"trace[2109615626] linearizableReadLoop","detail":"{readStateIndex:21870; appliedIndex:21869; }","duration":"238.742141ms","start":"2026-05-05T22:57:53.064478Z","end":"2026-05-05T22:57:53.30322Z","steps":["trace[2109615626] 'read index received' (duration: 238.541757ms)","trace[2109615626] 'applied index is now lower than readState.Index' (duration: 199.134µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:57:53.30334Z","caller":"traceutil/trace.go:171","msg":"trace[356164038] transaction","detail":"{read_only:false; response_revision:21140; number_of_response:1; }","duration":"312.013039ms","start":"2026-05-05T22:57:52.991288Z","end":"2026-05-05T22:57:53.303301Z","steps":["trace[356164038] 'process raft request' (duration: 311.721712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:53.303547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.592333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-05T22:57:53.303577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.08538ms","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-05-05T22:57:53.303607Z","caller":"traceutil/trace.go:171","msg":"trace[433967204] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21140; }","duration":"191.738337ms","start":"2026-05-05T22:57:53.111855Z","end":"2026-05-05T22:57:53.303593Z","steps":["trace[433967204] 'agreement among raft nodes before linearized reading' (duration: 191.580114ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:57:53.303622Z","caller":"traceutil/trace.go:171","msg":"trace[1184721418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21140; }","duration":"239.223694ms","start":"2026-05-05T22:57:53.064384Z","end":"2026-05-05T22:57:53.303608Z","steps":["trace[1184721418] 'agreement among raft nodes before linearized reading' (duration: 239.004258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:57:53.303611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:57:52.991264Z","time spent":"312.158223ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:59:22.914492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19727} {"level":"info","ts":"2026-05-05T22:59:23.025184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19727,"took":"107.467383ms","hash":2955672137,"current-db-size-bytes":57024512,"current-db-size":"57 MB","current-db-size-in-use-bytes":29630464,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-05T22:59:23.025249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2955672137,"revision":19727,"compact-revision":17383} {"level":"info","ts":"2026-05-05T23:01:34.015602Z","caller":"traceutil/trace.go:171","msg":"trace[904509763] linearizableReadLoop","detail":"{readStateIndex:23780; appliedIndex:23779; }","duration":"134.265161ms","start":"2026-05-05T23:01:33.881305Z","end":"2026-05-05T23:01:34.015571Z","steps":["trace[904509763] 'read index received' (duration: 134.046765ms)","trace[904509763] 'applied index is now lower than readState.Index' (duration: 216.676µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:01:34.015757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.440245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:01:34.015798Z","caller":"traceutil/trace.go:171","msg":"trace[808333604] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:22987; }","duration":"134.568618ms","start":"2026-05-05T23:01:33.881223Z","end":"2026-05-05T23:01:34.015792Z","steps":["trace[808333604] 'agreement among raft nodes before linearized reading' (duration: 134.462825ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:34.015654Z","caller":"traceutil/trace.go:171","msg":"trace[92646515] transaction","detail":"{read_only:false; response_revision:22987; number_of_response:1; }","duration":"163.313352ms","start":"2026-05-05T23:01:33.852317Z","end":"2026-05-05T23:01:34.01563Z","steps":["trace[92646515] 'process raft request' (duration: 163.023355ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:47.548336Z","caller":"traceutil/trace.go:171","msg":"trace[1838641275] transaction","detail":"{read_only:false; response_revision:23482; number_of_response:1; }","duration":"169.965003ms","start":"2026-05-05T23:01:47.378342Z","end":"2026-05-05T23:01:47.548307Z","steps":["trace[1838641275] 'process raft request' (duration: 169.87861ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:47.548477Z","caller":"traceutil/trace.go:171","msg":"trace[1082970321] transaction","detail":"{read_only:false; response_revision:23481; number_of_response:1; }","duration":"170.208269ms","start":"2026-05-05T23:01:47.37823Z","end":"2026-05-05T23:01:47.548438Z","steps":["trace[1082970321] 'process raft request' (duration: 169.84176ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:47.548624Z","caller":"traceutil/trace.go:171","msg":"trace[1820872637] transaction","detail":"{read_only:false; response_revision:23483; number_of_response:1; }","duration":"170.219149ms","start":"2026-05-05T23:01:47.378386Z","end":"2026-05-05T23:01:47.548605Z","steps":["trace[1820872637] 'process raft request' (duration: 169.878041ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:47.548887Z","caller":"traceutil/trace.go:171","msg":"trace[804425086] linearizableReadLoop","detail":"{readStateIndex:24286; appliedIndex:24283; }","duration":"170.465685ms","start":"2026-05-05T23:01:47.37839Z","end":"2026-05-05T23:01:47.548856Z","steps":["trace[804425086] 'read index received' (duration: 53.859811ms)","trace[804425086] 'applied index is now lower than readState.Index' (duration: 116.604884ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:01:47.548996Z","caller":"traceutil/trace.go:171","msg":"trace[504564026] transaction","detail":"{read_only:false; response_revision:23484; number_of_response:1; }","duration":"135.825367ms","start":"2026-05-05T23:01:47.41315Z","end":"2026-05-05T23:01:47.548975Z","steps":["trace[504564026] 'process raft request' (duration: 135.369887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:01:47.549225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.809983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3566"} {"level":"info","ts":"2026-05-05T23:01:47.549274Z","caller":"traceutil/trace.go:171","msg":"trace[1111879961] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:23484; }","duration":"170.902055ms","start":"2026-05-05T23:01:47.378359Z","end":"2026-05-05T23:01:47.549261Z","steps":["trace[1111879961] 'agreement among raft nodes before linearized reading' (duration: 170.634359ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:47.552278Z","caller":"traceutil/trace.go:171","msg":"trace[1838269133] transaction","detail":"{read_only:false; response_revision:23485; number_of_response:1; }","duration":"100.498386ms","start":"2026-05-05T23:01:47.45176Z","end":"2026-05-05T23:01:47.552258Z","steps":["trace[1838269133] 'process raft request' (duration: 100.25163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:01:47.552406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.14271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/capo-manager-rolebinding\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:01:47.552468Z","caller":"traceutil/trace.go:171","msg":"trace[826013151] range","detail":"{range_begin:/registry/clusterrolebindings/capo-manager-rolebinding; range_end:; response_count:0; response_revision:23487; }","duration":"103.272053ms","start":"2026-05-05T23:01:47.44918Z","end":"2026-05-05T23:01:47.552452Z","steps":["trace[826013151] 'agreement among raft nodes before linearized reading' (duration: 103.16204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:01:47.552666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.917678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18171"} {"level":"info","ts":"2026-05-05T23:01:47.552729Z","caller":"traceutil/trace.go:171","msg":"trace[1761041806] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:23487; }","duration":"174.002719ms","start":"2026-05-05T23:01:47.378712Z","end":"2026-05-05T23:01:47.552715Z","steps":["trace[1761041806] 'agreement among raft nodes before linearized reading' (duration: 173.561418ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:55.981525Z","caller":"traceutil/trace.go:171","msg":"trace[2053259253] transaction","detail":"{read_only:false; response_revision:23695; number_of_response:1; }","duration":"104.698686ms","start":"2026-05-05T23:01:55.876795Z","end":"2026-05-05T23:01:55.981493Z","steps":["trace[2053259253] 'process raft request' (duration: 104.464941ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:56.356656Z","caller":"traceutil/trace.go:171","msg":"trace[1861470112] transaction","detail":"{read_only:false; response_revision:23696; number_of_response:1; }","duration":"315.619607ms","start":"2026-05-05T23:01:56.040993Z","end":"2026-05-05T23:01:56.356612Z","steps":["trace[1861470112] 'process raft request' (duration: 302.07319ms)","trace[1861470112] 'compare' (duration: 13.22951ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:01:56.356863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:01:56.04096Z","time spent":"315.814432ms","remote":"127.0.0.1:38486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":973,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T23:01:56.396183Z","caller":"traceutil/trace.go:171","msg":"trace[279023726] linearizableReadLoop","detail":"{readStateIndex:24504; appliedIndex:24501; }","duration":"215.400148ms","start":"2026-05-05T23:01:56.180747Z","end":"2026-05-05T23:01:56.396147Z","steps":["trace[279023726] 'read index received' (duration: 162.333958ms)","trace[279023726] 'applied index is now lower than readState.Index' (duration: 53.06461ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:01:56.396259Z","caller":"traceutil/trace.go:171","msg":"trace[1733237645] transaction","detail":"{read_only:false; response_revision:23698; number_of_response:1; }","duration":"261.409899ms","start":"2026-05-05T23:01:56.134801Z","end":"2026-05-05T23:01:56.396211Z","steps":["trace[1733237645] 'process raft request' (duration: 261.253835ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:56.396299Z","caller":"traceutil/trace.go:171","msg":"trace[13818978] transaction","detail":"{read_only:false; response_revision:23699; number_of_response:1; }","duration":"101.407747ms","start":"2026-05-05T23:01:56.294851Z","end":"2026-05-05T23:01:56.396259Z","steps":["trace[13818978] 'process raft request' (duration: 101.247493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:01:56.396364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.281637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:01:56.396413Z","caller":"traceutil/trace.go:171","msg":"trace[263846949] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:23699; }","duration":"133.393931ms","start":"2026-05-05T23:01:56.263004Z","end":"2026-05-05T23:01:56.396398Z","steps":["trace[263846949] 'agreement among raft nodes before linearized reading' (duration: 133.297388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:01:56.396509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.738017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-05-05T23:01:56.396572Z","caller":"traceutil/trace.go:171","msg":"trace[935220717] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:23699; }","duration":"215.85872ms","start":"2026-05-05T23:01:56.180695Z","end":"2026-05-05T23:01:56.396554Z","steps":["trace[935220717] 'agreement among raft nodes before linearized reading' (duration: 215.604533ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:01:56.399415Z","caller":"traceutil/trace.go:171","msg":"trace[2061495817] transaction","detail":"{read_only:false; response_revision:23697; number_of_response:1; }","duration":"270.596042ms","start":"2026-05-05T23:01:56.126742Z","end":"2026-05-05T23:01:56.397338Z","steps":["trace[2061495817] 'process raft request' (duration: 269.133056ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:04:22.920793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21926} {"level":"info","ts":"2026-05-05T23:04:23.060136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21926,"took":"134.817004ms","hash":414142579,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":43220992,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-05-05T23:04:23.060193Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":414142579,"revision":21926,"compact-revision":19727} {"level":"info","ts":"2026-05-05T23:05:35.115531Z","caller":"traceutil/trace.go:171","msg":"trace[1187289457] transaction","detail":"{read_only:false; response_revision:25914; number_of_response:1; }","duration":"226.534878ms","start":"2026-05-05T23:05:34.888951Z","end":"2026-05-05T23:05:35.115485Z","steps":["trace[1187289457] 'process raft request' (duration: 212.751105ms)","trace[1187289457] 'compare' (duration: 13.199799ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:35.398131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.000051ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:05:35.39868Z","caller":"traceutil/trace.go:171","msg":"trace[149608959] transaction","detail":"{read_only:false; response_revision:25916; number_of_response:1; }","duration":"177.937404ms","start":"2026-05-05T23:05:35.220718Z","end":"2026-05-05T23:05:35.398656Z","steps":["trace[149608959] 'process raft request' (duration: 75.284317ms)","trace[149608959] 'compare' (duration: 101.635893ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:35.435352Z","caller":"traceutil/trace.go:171","msg":"trace[1127326394] linearizableReadLoop","detail":"{readStateIndex:26781; appliedIndex:26780; }","duration":"104.744888ms","start":"2026-05-05T23:05:35.330586Z","end":"2026-05-05T23:05:35.43533Z","steps":["trace[1127326394] 'read index received' (duration: 104.551684ms)","trace[1127326394] 'applied index is now lower than readState.Index' (duration: 191.684µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:35.435643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.038735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-05-05T23:05:35.435716Z","caller":"traceutil/trace.go:171","msg":"trace[1843851892] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25917; }","duration":"105.150518ms","start":"2026-05-05T23:05:35.33055Z","end":"2026-05-05T23:05:35.435701Z","steps":["trace[1843851892] 'agreement among raft nodes before linearized reading' (duration: 104.866331ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:35.435801Z","caller":"traceutil/trace.go:171","msg":"trace[308933562] transaction","detail":"{read_only:false; response_revision:25917; number_of_response:1; }","duration":"143.327189ms","start":"2026-05-05T23:05:35.292437Z","end":"2026-05-05T23:05:35.435764Z","steps":["trace[308933562] 'process raft request' (duration: 142.761656ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:35.69023Z","caller":"traceutil/trace.go:171","msg":"trace[1175024776] transaction","detail":"{read_only:false; response_revision:25918; number_of_response:1; }","duration":"176.807207ms","start":"2026-05-05T23:05:35.51339Z","end":"2026-05-05T23:05:35.690197Z","steps":["trace[1175024776] 'process raft request' (duration: 116.054291ms)","trace[1175024776] 'compare' (duration: 60.452959ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:40.688193Z","caller":"traceutil/trace.go:171","msg":"trace[141265671] transaction","detail":"{read_only:false; response_revision:25958; number_of_response:1; }","duration":"157.983412ms","start":"2026-05-05T23:05:40.530184Z","end":"2026-05-05T23:05:40.688168Z","steps":["trace[141265671] 'process raft request' (duration: 157.826198ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:41.032931Z","caller":"traceutil/trace.go:171","msg":"trace[880587570] transaction","detail":"{read_only:false; response_revision:25960; number_of_response:1; }","duration":"109.066362ms","start":"2026-05-05T23:05:40.923844Z","end":"2026-05-05T23:05:41.032911Z","steps":["trace[880587570] 'process raft request' (duration: 108.925409ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:41.055386Z","caller":"traceutil/trace.go:171","msg":"trace[798795279] transaction","detail":"{read_only:false; response_revision:25961; number_of_response:1; }","duration":"131.311768ms","start":"2026-05-05T23:05:40.924016Z","end":"2026-05-05T23:05:41.055328Z","steps":["trace[798795279] 'process raft request' (duration: 130.95877ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:41.055718Z","caller":"traceutil/trace.go:171","msg":"trace[1538804378] transaction","detail":"{read_only:false; response_revision:25962; number_of_response:1; }","duration":"131.689008ms","start":"2026-05-05T23:05:40.924012Z","end":"2026-05-05T23:05:41.055701Z","steps":["trace[1538804378] 'process raft request' (duration: 131.214806ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:41.446143Z","caller":"traceutil/trace.go:171","msg":"trace[1289261369] transaction","detail":"{read_only:false; response_revision:25964; number_of_response:1; }","duration":"319.808689ms","start":"2026-05-05T23:05:41.126312Z","end":"2026-05-05T23:05:41.44612Z","steps":["trace[1289261369] 'process raft request' (duration: 319.639015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:41.446286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:41.126281Z","time spent":"319.926692ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:41.468792Z","caller":"traceutil/trace.go:171","msg":"trace[302818474] linearizableReadLoop","detail":"{readStateIndex:26831; appliedIndex:26828; }","duration":"311.753195ms","start":"2026-05-05T23:05:41.157023Z","end":"2026-05-05T23:05:41.468776Z","steps":["trace[302818474] 'read index received' (duration: 288.977695ms)","trace[302818474] 'applied index is now lower than readState.Index' (duration: 22.77481ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:41.468868Z","caller":"traceutil/trace.go:171","msg":"trace[1352629680] transaction","detail":"{read_only:false; response_revision:25966; number_of_response:1; }","duration":"321.379317ms","start":"2026-05-05T23:05:41.147481Z","end":"2026-05-05T23:05:41.46886Z","steps":["trace[1352629680] 'process raft request' (duration: 321.252394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:41.46895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:41.147473Z","time spent":"321.410398ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:41.468889Z","caller":"traceutil/trace.go:171","msg":"trace[978839881] transaction","detail":"{read_only:false; response_revision:25965; number_of_response:1; }","duration":"323.341254ms","start":"2026-05-05T23:05:41.145491Z","end":"2026-05-05T23:05:41.468832Z","steps":["trace[978839881] 'process raft request' (duration: 323.125369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:41.469268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.253376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:41.469236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.965839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:41.469298Z","caller":"traceutil/trace.go:171","msg":"trace[39009096] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25967; }","duration":"312.323948ms","start":"2026-05-05T23:05:41.156966Z","end":"2026-05-05T23:05:41.46929Z","steps":["trace[39009096] 'agreement among raft nodes before linearized reading' (duration: 312.267127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:41.469318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:41.156944Z","time spent":"312.369229ms","remote":"127.0.0.1:59000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "} {"level":"info","ts":"2026-05-05T23:05:41.469326Z","caller":"traceutil/trace.go:171","msg":"trace[1368040076] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:25967; }","duration":"150.114232ms","start":"2026-05-05T23:05:41.31919Z","end":"2026-05-05T23:05:41.469304Z","steps":["trace[1368040076] 'agreement among raft nodes before linearized reading' (duration: 149.962759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:41.469343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:41.145461Z","time spent":"323.649912ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:05:41.811634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.379078ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-05T23:05:41.943317Z","caller":"traceutil/trace.go:171","msg":"trace[193371169] transaction","detail":"{read_only:false; response_revision:25969; number_of_response:1; }","duration":"230.098254ms","start":"2026-05-05T23:05:41.713196Z","end":"2026-05-05T23:05:41.943294Z","steps":["trace[193371169] 'process raft request' (duration: 229.695934ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:42.281782Z","caller":"traceutil/trace.go:171","msg":"trace[1643140693] linearizableReadLoop","detail":"{readStateIndex:26836; appliedIndex:26835; }","duration":"177.421562ms","start":"2026-05-05T23:05:42.104332Z","end":"2026-05-05T23:05:42.281754Z","steps":["trace[1643140693] 'read index received' (duration: 166.531329ms)","trace[1643140693] 'applied index is now lower than readState.Index' (duration: 10.888993ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:42.281828Z","caller":"traceutil/trace.go:171","msg":"trace[260123404] transaction","detail":"{read_only:false; response_revision:25970; number_of_response:1; }","duration":"275.476899ms","start":"2026-05-05T23:05:42.006312Z","end":"2026-05-05T23:05:42.281789Z","steps":["trace[260123404] 'process raft request' (duration: 264.542225ms)","trace[260123404] 'compare' (duration: 10.77513ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:42.282096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.699339ms","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-05-05T23:05:42.282195Z","caller":"traceutil/trace.go:171","msg":"trace[1853932038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25970; }","duration":"177.844762ms","start":"2026-05-05T23:05:42.104325Z","end":"2026-05-05T23:05:42.28217Z","steps":["trace[1853932038] 'agreement among raft nodes before linearized reading' (duration: 177.517404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:42.61955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.279013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:05:42.619741Z","caller":"traceutil/trace.go:171","msg":"trace[49692989] transaction","detail":"{read_only:false; response_revision:25973; number_of_response:1; }","duration":"223.356401ms","start":"2026-05-05T23:05:42.396369Z","end":"2026-05-05T23:05:42.619726Z","steps":["trace[49692989] 'process raft request' (duration: 223.32628ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:42.61974Z","caller":"traceutil/trace.go:171","msg":"trace[940382060] transaction","detail":"{read_only:false; response_revision:25971; number_of_response:1; }","duration":"331.438119ms","start":"2026-05-05T23:05:42.28827Z","end":"2026-05-05T23:05:42.619708Z","steps":["trace[940382060] 'process raft request' (duration: 135.90632ms)","trace[940382060] 'compare' (duration: 195.019427ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:42.619892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:42.288246Z","time spent":"331.566643ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:42.619875Z","caller":"traceutil/trace.go:171","msg":"trace[1287740961] transaction","detail":"{read_only:false; response_revision:25972; number_of_response:1; }","duration":"263.366546ms","start":"2026-05-05T23:05:42.356461Z","end":"2026-05-05T23:05:42.619827Z","steps":["trace[1287740961] 'process raft request' (duration: 263.187982ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:42.969805Z","caller":"traceutil/trace.go:171","msg":"trace[2139873050] transaction","detail":"{read_only:false; response_revision:25974; number_of_response:1; }","duration":"275.294194ms","start":"2026-05-05T23:05:42.694486Z","end":"2026-05-05T23:05:42.96978Z","steps":["trace[2139873050] 'process raft request' (duration: 275.12338ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:42.979839Z","caller":"traceutil/trace.go:171","msg":"trace[1746235044] linearizableReadLoop","detail":"{readStateIndex:26841; appliedIndex:26839; }","duration":"224.333354ms","start":"2026-05-05T23:05:42.755492Z","end":"2026-05-05T23:05:42.979825Z","steps":["trace[1746235044] 'read index received' (duration: 214.232931ms)","trace[1746235044] 'applied index is now lower than readState.Index' (duration: 10.099513ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:42.980062Z","caller":"traceutil/trace.go:171","msg":"trace[1372794537] transaction","detail":"{read_only:false; response_revision:25975; number_of_response:1; }","duration":"279.034634ms","start":"2026-05-05T23:05:42.700997Z","end":"2026-05-05T23:05:42.980032Z","steps":["trace[1372794537] 'process raft request' (duration: 278.760637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:42.980109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.422577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:42.980083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.583171ms","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-05-05T23:05:42.980227Z","caller":"traceutil/trace.go:171","msg":"trace[741365730] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25975; }","duration":"178.589541ms","start":"2026-05-05T23:05:42.801614Z","end":"2026-05-05T23:05:42.980203Z","steps":["trace[741365730] 'agreement among raft nodes before linearized reading' (duration: 178.408846ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:42.980246Z","caller":"traceutil/trace.go:171","msg":"trace[628786683] 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:25975; }","duration":"224.815777ms","start":"2026-05-05T23:05:42.755418Z","end":"2026-05-05T23:05:42.980234Z","steps":["trace[628786683] 'agreement among raft nodes before linearized reading' (duration: 224.617281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:43.256885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.461341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T23:05:43.256969Z","caller":"traceutil/trace.go:171","msg":"trace[382083556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25975; }","duration":"196.582915ms","start":"2026-05-05T23:05:43.060366Z","end":"2026-05-05T23:05:43.256949Z","steps":["trace[382083556] 'range keys from in-memory index tree' (duration: 196.314259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:43.257162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:43.257191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.640056ms","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-05-05T23:05:43.257251Z","caller":"traceutil/trace.go:171","msg":"trace[467723446] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:25975; }","duration":"197.771184ms","start":"2026-05-05T23:05:43.059456Z","end":"2026-05-05T23:05:43.257227Z","steps":["trace[467723446] 'count revisions from in-memory index tree' (duration: 197.501317ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.257274Z","caller":"traceutil/trace.go:171","msg":"trace[2141312695] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25975; }","duration":"196.766699ms","start":"2026-05-05T23:05:43.060482Z","end":"2026-05-05T23:05:43.257249Z","steps":["trace[2141312695] 'range keys from in-memory index tree' (duration: 196.478622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:43.257307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.468978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:43.257315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.091081ms","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-05-05T23:05:43.257427Z","caller":"traceutil/trace.go:171","msg":"trace[262051848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25975; }","duration":"220.274756ms","start":"2026-05-05T23:05:43.037122Z","end":"2026-05-05T23:05:43.257397Z","steps":["trace[262051848] 'range keys from in-memory index tree' (duration: 219.858036ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.257357Z","caller":"traceutil/trace.go:171","msg":"trace[1781239632] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25975; }","duration":"125.56822ms","start":"2026-05-05T23:05:43.131774Z","end":"2026-05-05T23:05:43.257342Z","steps":["trace[1781239632] 'count revisions from in-memory index tree' (duration: 125.350125ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.39267Z","caller":"traceutil/trace.go:171","msg":"trace[625502531] transaction","detail":"{read_only:false; response_revision:25976; number_of_response:1; }","duration":"129.293851ms","start":"2026-05-05T23:05:43.263343Z","end":"2026-05-05T23:05:43.392636Z","steps":["trace[625502531] 'process raft request' (duration: 129.080966ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.409145Z","caller":"traceutil/trace.go:171","msg":"trace[646574562] transaction","detail":"{read_only:false; response_revision:25977; number_of_response:1; }","duration":"145.670216ms","start":"2026-05-05T23:05:43.263452Z","end":"2026-05-05T23:05:43.409122Z","steps":["trace[646574562] 'process raft request' (duration: 145.509883ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.409337Z","caller":"traceutil/trace.go:171","msg":"trace[1843665349] transaction","detail":"{read_only:false; response_revision:25978; number_of_response:1; }","duration":"145.528363ms","start":"2026-05-05T23:05:43.263775Z","end":"2026-05-05T23:05:43.409303Z","steps":["trace[1843665349] 'process raft request' (duration: 145.311618ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.722243Z","caller":"traceutil/trace.go:171","msg":"trace[516633392] transaction","detail":"{read_only:false; response_revision:25980; number_of_response:1; }","duration":"244.256656ms","start":"2026-05-05T23:05:43.47795Z","end":"2026-05-05T23:05:43.722206Z","steps":["trace[516633392] 'process raft request' (duration: 222.929201ms)","trace[516633392] 'compare' (duration: 20.743381ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:43.722363Z","caller":"traceutil/trace.go:171","msg":"trace[981481677] transaction","detail":"{read_only:false; response_revision:25982; number_of_response:1; }","duration":"210.941172ms","start":"2026-05-05T23:05:43.511386Z","end":"2026-05-05T23:05:43.722328Z","steps":["trace[981481677] 'process raft request' (duration: 210.820469ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:43.722897Z","caller":"traceutil/trace.go:171","msg":"trace[563760982] transaction","detail":"{read_only:false; response_revision:25981; number_of_response:1; }","duration":"244.772279ms","start":"2026-05-05T23:05:43.478112Z","end":"2026-05-05T23:05:43.722884Z","steps":["trace[563760982] 'process raft request' (duration: 244.00672ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:44.056045Z","caller":"traceutil/trace.go:171","msg":"trace[108702987] transaction","detail":"{read_only:false; response_revision:25983; number_of_response:1; }","duration":"107.177168ms","start":"2026-05-05T23:05:43.948844Z","end":"2026-05-05T23:05:44.056022Z","steps":["trace[108702987] 'process raft request' (duration: 107.004564ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:44.72001Z","caller":"traceutil/trace.go:171","msg":"trace[1521983675] linearizableReadLoop","detail":"{readStateIndex:26851; appliedIndex:26850; }","duration":"270.475789ms","start":"2026-05-05T23:05:44.449505Z","end":"2026-05-05T23:05:44.719981Z","steps":["trace[1521983675] 'read index received' (duration: 270.382927ms)","trace[1521983675] 'applied index is now lower than readState.Index' (duration: 78.762µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:44.720039Z","caller":"traceutil/trace.go:171","msg":"trace[1592186046] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"385.69852ms","start":"2026-05-05T23:05:44.334295Z","end":"2026-05-05T23:05:44.719993Z","steps":["trace[1592186046] 'process raft request' (duration: 385.510745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:44.720211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.686254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:44.72023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:44.334271Z","time spent":"385.851864ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:44.720255Z","caller":"traceutil/trace.go:171","msg":"trace[816507400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25985; }","duration":"270.779057ms","start":"2026-05-05T23:05:44.449466Z","end":"2026-05-05T23:05:44.720245Z","steps":["trace[816507400] 'agreement among raft nodes before linearized reading' (duration: 270.658954ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:44.732934Z","caller":"traceutil/trace.go:171","msg":"trace[2121237805] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"107.269569ms","start":"2026-05-05T23:05:44.625641Z","end":"2026-05-05T23:05:44.732911Z","steps":["trace[2121237805] 'process raft request' (duration: 106.020749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:44.733058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.888148ms","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-05-05T23:05:44.733133Z","caller":"traceutil/trace.go:171","msg":"trace[1298438586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25986; }","duration":"108.980051ms","start":"2026-05-05T23:05:44.624112Z","end":"2026-05-05T23:05:44.733092Z","steps":["trace[1298438586] 'agreement among raft nodes before linearized reading' (duration: 108.803517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:44.733168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.124426ms","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":"info","ts":"2026-05-05T23:05:44.733227Z","caller":"traceutil/trace.go:171","msg":"trace[1763016933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25986; }","duration":"107.392932ms","start":"2026-05-05T23:05:44.625818Z","end":"2026-05-05T23:05:44.733211Z","steps":["trace[1763016933] 'agreement among raft nodes before linearized reading' (duration: 107.125726ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:45.238Z","caller":"traceutil/trace.go:171","msg":"trace[217057201] linearizableReadLoop","detail":"{readStateIndex:26855; appliedIndex:26854; }","duration":"166.074458ms","start":"2026-05-05T23:05:45.071897Z","end":"2026-05-05T23:05:45.237972Z","steps":["trace[217057201] 'read index received' (duration: 134.156998ms)","trace[217057201] 'applied index is now lower than readState.Index' (duration: 31.91605ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:45.23806Z","caller":"traceutil/trace.go:171","msg":"trace[2097585596] transaction","detail":"{read_only:false; response_revision:25989; number_of_response:1; }","duration":"251.561051ms","start":"2026-05-05T23:05:44.986443Z","end":"2026-05-05T23:05:45.238004Z","steps":["trace[2097585596] 'process raft request' (duration: 219.668431ms)","trace[2097585596] 'compare' (duration: 31.442759ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:45.238141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.216823ms","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-05-05T23:05:45.238188Z","caller":"traceutil/trace.go:171","msg":"trace[1462620753] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25989; }","duration":"166.322775ms","start":"2026-05-05T23:05:45.071848Z","end":"2026-05-05T23:05:45.238171Z","steps":["trace[1462620753] 'agreement among raft nodes before linearized reading' (duration: 166.221153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:45.511315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.278498ms","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-05-05T23:05:45.511484Z","caller":"traceutil/trace.go:171","msg":"trace[27277487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25989; }","duration":"114.484443ms","start":"2026-05-05T23:05:45.396945Z","end":"2026-05-05T23:05:45.511429Z","steps":["trace[27277487] 'range keys from in-memory index tree' (duration: 114.083834ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:45.645227Z","caller":"traceutil/trace.go:171","msg":"trace[1968012360] transaction","detail":"{read_only:false; response_revision:25990; number_of_response:1; }","duration":"129.617458ms","start":"2026-05-05T23:05:45.515577Z","end":"2026-05-05T23:05:45.645195Z","steps":["trace[1968012360] 'process raft request' (duration: 129.411494ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:45.845248Z","caller":"traceutil/trace.go:171","msg":"trace[237579279] transaction","detail":"{read_only:false; response_revision:25991; number_of_response:1; }","duration":"329.587404ms","start":"2026-05-05T23:05:45.515637Z","end":"2026-05-05T23:05:45.845225Z","steps":["trace[237579279] 'process raft request' (duration: 329.387169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:45.845392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:45.515607Z","time spent":"329.707557ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:45.84558Z","caller":"traceutil/trace.go:171","msg":"trace[1468236572] transaction","detail":"{read_only:false; response_revision:25992; number_of_response:1; }","duration":"328.303834ms","start":"2026-05-05T23:05:45.517246Z","end":"2026-05-05T23:05:45.84555Z","steps":["trace[1468236572] 'process raft request' (duration: 327.935345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:45.845827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:45.517234Z","time spent":"328.433247ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:45.84672Z","caller":"traceutil/trace.go:171","msg":"trace[2086761586] transaction","detail":"{read_only:false; response_revision:25993; number_of_response:1; }","duration":"272.14108ms","start":"2026-05-05T23:05:45.574003Z","end":"2026-05-05T23:05:45.846144Z","steps":["trace[2086761586] 'process raft request' (duration: 271.468353ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:46.136731Z","caller":"traceutil/trace.go:171","msg":"trace[18934277] transaction","detail":"{read_only:false; response_revision:25994; number_of_response:1; }","duration":"408.873619ms","start":"2026-05-05T23:05:45.727837Z","end":"2026-05-05T23:05:46.13671Z","steps":["trace[18934277] 'process raft request' (duration: 408.676015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.136873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:45.72781Z","time spent":"408.983321ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:46.137063Z","caller":"traceutil/trace.go:171","msg":"trace[835766024] transaction","detail":"{read_only:false; response_revision:25995; number_of_response:1; }","duration":"409.127114ms","start":"2026-05-05T23:05:45.727927Z","end":"2026-05-05T23:05:46.137054Z","steps":["trace[835766024] 'process raft request' (duration: 408.745385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.137108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:45.727876Z","time spent":"409.209007ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:46.137161Z","caller":"traceutil/trace.go:171","msg":"trace[1544028221] transaction","detail":"{read_only:false; response_revision:25996; number_of_response:1; }","duration":"408.724914ms","start":"2026-05-05T23:05:45.728409Z","end":"2026-05-05T23:05:46.137134Z","steps":["trace[1544028221] 'process raft request' (duration: 408.566111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.137329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:45.728394Z","time spent":"408.848088ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:05:46.426899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.986066ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-05-05T23:05:46.427007Z","caller":"traceutil/trace.go:171","msg":"trace[745052998] linearizableReadLoop","detail":"{readStateIndex:26864; appliedIndex:26863; }","duration":"176.415848ms","start":"2026-05-05T23:05:46.250571Z","end":"2026-05-05T23:05:46.426987Z","steps":["trace[745052998] 'read index received' (duration: 39.209846ms)","trace[745052998] 'applied index is now lower than readState.Index' (duration: 137.204302ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:46.427167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.583923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:46.427198Z","caller":"traceutil/trace.go:171","msg":"trace[1500698947] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25997; }","duration":"176.664444ms","start":"2026-05-05T23:05:46.250522Z","end":"2026-05-05T23:05:46.427187Z","steps":["trace[1500698947] 'agreement among raft nodes before linearized reading' (duration: 176.577472ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:46.645756Z","caller":"traceutil/trace.go:171","msg":"trace[1543501570] transaction","detail":"{read_only:false; response_revision:25999; number_of_response:1; }","duration":"194.263479ms","start":"2026-05-05T23:05:46.451462Z","end":"2026-05-05T23:05:46.645726Z","steps":["trace[1543501570] 'process raft request' (duration: 194.174516ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:46.645775Z","caller":"traceutil/trace.go:171","msg":"trace[730783009] transaction","detail":"{read_only:false; response_revision:25998; number_of_response:1; }","duration":"217.334316ms","start":"2026-05-05T23:05:46.428389Z","end":"2026-05-05T23:05:46.645724Z","steps":["trace[730783009] 'process raft request' (duration: 129.983558ms)","trace[730783009] 'compare' (duration: 87.03591ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:46.646163Z","caller":"traceutil/trace.go:171","msg":"trace[1107317389] linearizableReadLoop","detail":"{readStateIndex:26865; appliedIndex:26864; }","duration":"196.021201ms","start":"2026-05-05T23:05:46.450105Z","end":"2026-05-05T23:05:46.646126Z","steps":["trace[1107317389] 'read index received' (duration: 108.377596ms)","trace[1107317389] 'applied index is now lower than readState.Index' (duration: 87.640075ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:46.646543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.427921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:46.646685Z","caller":"traceutil/trace.go:171","msg":"trace[1075810799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25999; }","duration":"196.622505ms","start":"2026-05-05T23:05:46.450048Z","end":"2026-05-05T23:05:46.646671Z","steps":["trace[1075810799] 'agreement among raft nodes before linearized reading' (duration: 196.4135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.646773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.093453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:05:46.646844Z","caller":"traceutil/trace.go:171","msg":"trace[766665438] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25999; }","duration":"109.202196ms","start":"2026-05-05T23:05:46.537618Z","end":"2026-05-05T23:05:46.646821Z","steps":["trace[766665438] 'agreement among raft nodes before linearized reading' (duration: 109.078613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.90924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.388156ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:05:46.909434Z","caller":"traceutil/trace.go:171","msg":"trace[2087353062] linearizableReadLoop","detail":"{readStateIndex:26868; appliedIndex:26866; }","duration":"150.112422ms","start":"2026-05-05T23:05:46.759306Z","end":"2026-05-05T23:05:46.909418Z","steps":["trace[2087353062] 'read index received' (duration: 44.031072ms)","trace[2087353062] 'applied index is now lower than readState.Index' (duration: 106.08025ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:46.909487Z","caller":"traceutil/trace.go:171","msg":"trace[476229543] transaction","detail":"{read_only:false; response_revision:26000; number_of_response:1; }","duration":"180.000384ms","start":"2026-05-05T23:05:46.729429Z","end":"2026-05-05T23:05:46.90943Z","steps":["trace[476229543] 'process raft request' (duration: 17.997214ms)","trace[476229543] 'compare' (duration: 161.12602ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:46.909575Z","caller":"traceutil/trace.go:171","msg":"trace[506859972] transaction","detail":"{read_only:false; response_revision:26001; number_of_response:1; }","duration":"172.391451ms","start":"2026-05-05T23:05:46.737141Z","end":"2026-05-05T23:05:46.909532Z","steps":["trace[506859972] 'process raft request' (duration: 172.198026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.909666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.349679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-05-05T23:05:46.909718Z","caller":"traceutil/trace.go:171","msg":"trace[1164885820] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:26001; }","duration":"150.42176ms","start":"2026-05-05T23:05:46.759273Z","end":"2026-05-05T23:05:46.909695Z","steps":["trace[1164885820] 'agreement among raft nodes before linearized reading' (duration: 150.252366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:46.910191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.02671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-05T23:05:46.910232Z","caller":"traceutil/trace.go:171","msg":"trace[360655853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26001; }","duration":"150.087672ms","start":"2026-05-05T23:05:46.760135Z","end":"2026-05-05T23:05:46.910223Z","steps":["trace[360655853] 'agreement among raft nodes before linearized reading' (duration: 149.960579ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:47.048018Z","caller":"traceutil/trace.go:171","msg":"trace[291546763] transaction","detail":"{read_only:false; response_revision:26002; number_of_response:1; }","duration":"133.479253ms","start":"2026-05-05T23:05:46.914516Z","end":"2026-05-05T23:05:47.047995Z","steps":["trace[291546763] 'process raft request' (duration: 133.129393ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:51.912479Z","caller":"traceutil/trace.go:171","msg":"trace[1123871475] linearizableReadLoop","detail":"{readStateIndex:26904; appliedIndex:26903; }","duration":"245.161787ms","start":"2026-05-05T23:05:51.667289Z","end":"2026-05-05T23:05:51.912451Z","steps":["trace[1123871475] 'read index received' (duration: 244.920791ms)","trace[1123871475] 'applied index is now lower than readState.Index' (duration: 239.726µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:51.912597Z","caller":"traceutil/trace.go:171","msg":"trace[1856731422] transaction","detail":"{read_only:false; response_revision:26035; number_of_response:1; }","duration":"259.932064ms","start":"2026-05-05T23:05:51.652654Z","end":"2026-05-05T23:05:51.912586Z","steps":["trace[1856731422] 'process raft request' (duration: 259.586686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:51.913613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.301044ms","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-05-05T23:05:51.913716Z","caller":"traceutil/trace.go:171","msg":"trace[2065108797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26035; }","duration":"246.447649ms","start":"2026-05-05T23:05:51.667242Z","end":"2026-05-05T23:05:51.913689Z","steps":["trace[2065108797] 'agreement among raft nodes before linearized reading' (duration: 245.70664ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:52.349946Z","caller":"traceutil/trace.go:171","msg":"trace[744849547] linearizableReadLoop","detail":"{readStateIndex:26905; appliedIndex:26904; }","duration":"437.375027ms","start":"2026-05-05T23:05:51.912547Z","end":"2026-05-05T23:05:52.349922Z","steps":["trace[744849547] 'read index received' (duration: 437.152362ms)","trace[744849547] 'applied index is now lower than readState.Index' (duration: 221.805µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:52.350182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.406831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T23:05:52.350225Z","caller":"traceutil/trace.go:171","msg":"trace[1904434508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26036; }","duration":"462.494123ms","start":"2026-05-05T23:05:51.88772Z","end":"2026-05-05T23:05:52.350215Z","steps":["trace[1904434508] 'agreement among raft nodes before linearized reading' (duration: 462.296988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.35027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:51.887709Z","time spent":"462.549434ms","remote":"127.0.0.1:38666","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":"info","ts":"2026-05-05T23:05:52.350592Z","caller":"traceutil/trace.go:171","msg":"trace[14924142] transaction","detail":"{read_only:false; response_revision:26036; number_of_response:1; }","duration":"466.742385ms","start":"2026-05-05T23:05:51.883836Z","end":"2026-05-05T23:05:52.350579Z","steps":["trace[14924142] 'process raft request' (duration: 465.936575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.350697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:51.88381Z","time spent":"466.811907ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:05:52.350928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.592928ms","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-05-05T23:05:52.350962Z","caller":"traceutil/trace.go:171","msg":"trace[1620810244] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26036; }","duration":"460.673819ms","start":"2026-05-05T23:05:51.890278Z","end":"2026-05-05T23:05:52.350952Z","steps":["trace[1620810244] 'agreement among raft nodes before linearized reading' (duration: 460.577757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.35099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:51.890253Z","time spent":"460.730391ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T23:05:52.869395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.102972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:05:52.871987Z","caller":"traceutil/trace.go:171","msg":"trace[2004898623] transaction","detail":"{read_only:false; response_revision:26039; number_of_response:1; }","duration":"713.693466ms","start":"2026-05-05T23:05:52.15828Z","end":"2026-05-05T23:05:52.871973Z","steps":["trace[2004898623] 'process raft request' (duration: 713.532992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.87207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.158243Z","time spent":"713.777268ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:52.872165Z","caller":"traceutil/trace.go:171","msg":"trace[1339879144] transaction","detail":"{read_only:false; response_revision:26038; number_of_response:1; }","duration":"714.044844ms","start":"2026-05-05T23:05:52.158055Z","end":"2026-05-05T23:05:52.8721Z","steps":["trace[1339879144] 'process raft request' (duration: 713.687296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.872309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.158019Z","time spent":"714.206998ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:52.872668Z","caller":"traceutil/trace.go:171","msg":"trace[1959859041] transaction","detail":"{read_only:false; response_revision:26041; number_of_response:1; }","duration":"683.17596ms","start":"2026-05-05T23:05:52.18944Z","end":"2026-05-05T23:05:52.872616Z","steps":["trace[1959859041] 'process raft request' (duration: 682.947544ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:52.87262Z","caller":"traceutil/trace.go:171","msg":"trace[1386545816] transaction","detail":"{read_only:false; response_revision:26040; number_of_response:1; }","duration":"713.187175ms","start":"2026-05-05T23:05:52.159354Z","end":"2026-05-05T23:05:52.872541Z","steps":["trace[1386545816] 'process raft request' (duration: 712.490578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:52.873181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.189426Z","time spent":"683.62917ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:05:52.873261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.159323Z","time spent":"713.779348ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:52.872175Z","caller":"traceutil/trace.go:171","msg":"trace[1370759614] transaction","detail":"{read_only:false; response_revision:26037; number_of_response:1; }","duration":"952.169163ms","start":"2026-05-05T23:05:51.919823Z","end":"2026-05-05T23:05:52.871992Z","steps":["trace[1370759614] 'process raft request' (duration: 670.654337ms)","trace[1370759614] 'compare' (duration: 277.941879ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:05:52.873952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:51.919782Z","time spent":"954.123859ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:53.227044Z","caller":"traceutil/trace.go:171","msg":"trace[1808127861] linearizableReadLoop","detail":"{readStateIndex:26912; appliedIndex:26905; }","duration":"790.223393ms","start":"2026-05-05T23:05:52.436795Z","end":"2026-05-05T23:05:53.227019Z","steps":["trace[1808127861] 'read index received' (duration: 153.779572ms)","trace[1808127861] 'applied index is now lower than readState.Index' (duration: 636.442531ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:05:53.227054Z","caller":"traceutil/trace.go:171","msg":"trace[545287341] transaction","detail":"{read_only:false; response_revision:26042; number_of_response:1; }","duration":"870.86259ms","start":"2026-05-05T23:05:52.356151Z","end":"2026-05-05T23:05:53.227014Z","steps":["trace[545287341] 'process raft request' (duration: 869.482537ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:53.227094Z","caller":"traceutil/trace.go:171","msg":"trace[701961175] transaction","detail":"{read_only:false; response_revision:26043; number_of_response:1; }","duration":"870.86615ms","start":"2026-05-05T23:05:52.356178Z","end":"2026-05-05T23:05:53.227044Z","steps":["trace[701961175] 'process raft request' (duration: 870.728206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.227205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.391888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:53.227249Z","caller":"traceutil/trace.go:171","msg":"trace[1559006076] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:26043; }","duration":"790.50301ms","start":"2026-05-05T23:05:52.436731Z","end":"2026-05-05T23:05:53.227234Z","steps":["trace[1559006076] 'agreement among raft nodes before linearized reading' (duration: 790.408978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.227283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.436708Z","time spent":"790.565691ms","remote":"127.0.0.1:58756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true "} {"level":"warn","ts":"2026-05-05T23:05:53.227322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.356163Z","time spent":"871.033053ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:05:53.227326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.356133Z","time spent":"871.081775ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:05:53.228323Z","caller":"traceutil/trace.go:171","msg":"trace[812239663] transaction","detail":"{read_only:false; response_revision:26045; number_of_response:1; }","duration":"111.664115ms","start":"2026-05-05T23:05:53.116632Z","end":"2026-05-05T23:05:53.228296Z","steps":["trace[812239663] 'process raft request' (duration: 111.613474ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:53.228386Z","caller":"traceutil/trace.go:171","msg":"trace[547168646] transaction","detail":"{read_only:false; response_revision:26044; number_of_response:1; }","duration":"292.751527ms","start":"2026-05-05T23:05:52.935599Z","end":"2026-05-05T23:05:53.228351Z","steps":["trace[547168646] 'process raft request' (duration: 292.528321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.228963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.184935ms","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":"warn","ts":"2026-05-05T23:05:53.228979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.555046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:05:53.229085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.822881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:53.229095Z","caller":"traceutil/trace.go:171","msg":"trace[788095420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26045; }","duration":"779.74492ms","start":"2026-05-05T23:05:52.449319Z","end":"2026-05-05T23:05:53.229064Z","steps":["trace[788095420] 'agreement among raft nodes before linearized reading' (duration: 779.477613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.76963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:05:53.22913Z","caller":"traceutil/trace.go:171","msg":"trace[1603689092] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:26045; }","duration":"184.886782ms","start":"2026-05-05T23:05:53.044232Z","end":"2026-05-05T23:05:53.229119Z","steps":["trace[1603689092] 'agreement among raft nodes before linearized reading' (duration: 184.826661ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:53.229162Z","caller":"traceutil/trace.go:171","msg":"trace[585177262] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:26045; }","duration":"293.870513ms","start":"2026-05-05T23:05:52.935276Z","end":"2026-05-05T23:05:53.229147Z","steps":["trace[585177262] 'agreement among raft nodes before linearized reading' (duration: 293.696979ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:53.229034Z","caller":"traceutil/trace.go:171","msg":"trace[950813058] 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:26045; }","duration":"215.286856ms","start":"2026-05-05T23:05:53.013718Z","end":"2026-05-05T23:05:53.229005Z","steps":["trace[950813058] 'agreement among raft nodes before linearized reading' (duration: 215.171954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.728385ms","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-05-05T23:05:53.229354Z","caller":"traceutil/trace.go:171","msg":"trace[1597294551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26045; }","duration":"152.943811ms","start":"2026-05-05T23:05:53.076381Z","end":"2026-05-05T23:05:53.229325Z","steps":["trace[1597294551] 'agreement among raft nodes before linearized reading' (duration: 152.534241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.844548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:53.229405Z","caller":"traceutil/trace.go:171","msg":"trace[973191936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26045; }","duration":"217.931041ms","start":"2026-05-05T23:05:53.011464Z","end":"2026-05-05T23:05:53.229395Z","steps":["trace[973191936] 'agreement among raft nodes before linearized reading' (duration: 217.864829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.449308Z","time spent":"779.841583ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T23:05:53.229533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.440966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:05:53.229648Z","caller":"traceutil/trace.go:171","msg":"trace[1935150732] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:26045; }","duration":"543.59974ms","start":"2026-05-05T23:05:52.686032Z","end":"2026-05-05T23:05:53.229632Z","steps":["trace[1935150732] 'agreement among raft nodes before linearized reading' (duration: 543.441016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.68601Z","time spent":"543.663282ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":7,"response size":31,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-05-05T23:05:53.2294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.792757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:05:53.229759Z","caller":"traceutil/trace.go:171","msg":"trace[790097550] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:26045; }","duration":"194.203477ms","start":"2026-05-05T23:05:53.035539Z","end":"2026-05-05T23:05:53.229742Z","steps":["trace[790097550] 'agreement among raft nodes before linearized reading' (duration: 193.787167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.767952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-05T23:05:53.229873Z","caller":"traceutil/trace.go:171","msg":"trace[1528782987] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26045; }","duration":"105.882435ms","start":"2026-05-05T23:05:53.123948Z","end":"2026-05-05T23:05:53.229831Z","steps":["trace[1528782987] 'agreement among raft nodes before linearized reading' (duration: 105.66043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.229931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.775664ms","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-05-05T23:05:53.229962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.289624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:05:53.230006Z","caller":"traceutil/trace.go:171","msg":"trace[94385535] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:26045; }","duration":"761.347466ms","start":"2026-05-05T23:05:52.468645Z","end":"2026-05-05T23:05:53.229992Z","steps":["trace[94385535] 'agreement among raft nodes before linearized reading' (duration: 761.278914ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:05:53.230009Z","caller":"traceutil/trace.go:171","msg":"trace[937932958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26045; }","duration":"289.878987ms","start":"2026-05-05T23:05:52.940106Z","end":"2026-05-05T23:05:53.229985Z","steps":["trace[937932958] 'agreement among raft nodes before linearized reading' (duration: 289.654991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.230017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.447123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"warn","ts":"2026-05-05T23:05:53.230041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.468636Z","time spent":"761.395487ms","remote":"127.0.0.1:59122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true "} {"level":"info","ts":"2026-05-05T23:05:53.230058Z","caller":"traceutil/trace.go:171","msg":"trace[1272187863] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26045; }","duration":"668.518155ms","start":"2026-05-05T23:05:52.561524Z","end":"2026-05-05T23:05:53.230042Z","steps":["trace[1272187863] 'agreement among raft nodes before linearized reading' (duration: 668.341391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:05:53.230089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:52.561498Z","time spent":"668.584657ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-05T23:05:59.8767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.666809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eba3c2bd-d8f3-4f42-bc79-2036595811f4\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-05-05T23:05:59.876777Z","caller":"traceutil/trace.go:171","msg":"trace[1327945313] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eba3c2bd-d8f3-4f42-bc79-2036595811f4; range_end:; response_count:1; response_revision:26150; }","duration":"233.759201ms","start":"2026-05-05T23:05:59.643001Z","end":"2026-05-05T23:05:59.876761Z","steps":["trace[1327945313] 'range keys from in-memory index tree' (duration: 233.520716ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:00.082828Z","caller":"traceutil/trace.go:171","msg":"trace[735757645] transaction","detail":"{read_only:false; response_revision:26151; number_of_response:1; }","duration":"309.216214ms","start":"2026-05-05T23:05:59.773577Z","end":"2026-05-05T23:06:00.082794Z","steps":["trace[735757645] 'process raft request' (duration: 308.707161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.083053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:59.773538Z","time spent":"309.387658ms","remote":"127.0.0.1:45904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418457,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:06:00.454964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.847168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:06:00.455171Z","caller":"traceutil/trace.go:171","msg":"trace[143413122] linearizableReadLoop","detail":"{readStateIndex:27022; appliedIndex:27020; }","duration":"375.955095ms","start":"2026-05-05T23:06:00.079188Z","end":"2026-05-05T23:06:00.455143Z","steps":["trace[143413122] 'read index received' (duration: 3.050793ms)","trace[143413122] 'applied index is now lower than readState.Index' (duration: 372.902032ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:00.455296Z","caller":"traceutil/trace.go:171","msg":"trace[1885929057] transaction","detail":"{read_only:false; response_revision:26152; number_of_response:1; }","duration":"569.321082ms","start":"2026-05-05T23:05:59.885913Z","end":"2026-05-05T23:06:00.455234Z","steps":["trace[1885929057] 'process raft request' (duration: 462.024742ms)","trace[1885929057] 'compare' (duration: 106.229664ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:00.455387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.18763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:06:00.455429Z","caller":"traceutil/trace.go:171","msg":"trace[1930924111] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:26152; }","duration":"376.262312ms","start":"2026-05-05T23:06:00.079147Z","end":"2026-05-05T23:06:00.455409Z","steps":["trace[1930924111] 'agreement among raft nodes before linearized reading' (duration: 376.104569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.455444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:05:59.885867Z","time spent":"569.516867ms","remote":"127.0.0.1:38582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:06:00.455478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:06:00.079133Z","time spent":"376.335515ms","remote":"127.0.0.1:39744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":37,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-05-05T23:06:00.460012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.413681ms","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-05-05T23:06:00.460044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.673794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:00.460082Z","caller":"traceutil/trace.go:171","msg":"trace[808791668] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:26153; }","duration":"119.548215ms","start":"2026-05-05T23:06:00.340518Z","end":"2026-05-05T23:06:00.460067Z","steps":["trace[808791668] 'agreement among raft nodes before linearized reading' (duration: 119.415212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.460086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.560048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:00.460129Z","caller":"traceutil/trace.go:171","msg":"trace[902185930] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:26153; }","duration":"101.814057ms","start":"2026-05-05T23:06:00.358291Z","end":"2026-05-05T23:06:00.460105Z","steps":["trace[902185930] 'agreement among raft nodes before linearized reading' (duration: 101.672134ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:00.460149Z","caller":"traceutil/trace.go:171","msg":"trace[312064321] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:26153; }","duration":"214.671381ms","start":"2026-05-05T23:06:00.245461Z","end":"2026-05-05T23:06:00.460133Z","steps":["trace[312064321] 'agreement among raft nodes before linearized reading' (duration: 214.596349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.460003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.338764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:00.460483Z","caller":"traceutil/trace.go:171","msg":"trace[434586493] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:26153; }","duration":"352.893287ms","start":"2026-05-05T23:06:00.107562Z","end":"2026-05-05T23:06:00.460455Z","steps":["trace[434586493] 'agreement among raft nodes before linearized reading' (duration: 352.329184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.460554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:06:00.107509Z","time spent":"353.01955ms","remote":"127.0.0.1:59030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-05T23:06:00.725597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.233986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-05-05T23:06:00.725924Z","caller":"traceutil/trace.go:171","msg":"trace[1646912046] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26153; }","duration":"162.396879ms","start":"2026-05-05T23:06:00.563279Z","end":"2026-05-05T23:06:00.725676Z","steps":["trace[1646912046] 'range keys from in-memory index tree' (duration: 161.799786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.725147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.148114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eba3c2bd-d8f3-4f42-bc79-2036595811f4\" ","response":"range_response_count:1 size:3761"} {"level":"info","ts":"2026-05-05T23:06:00.726041Z","caller":"traceutil/trace.go:171","msg":"trace[950594742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eba3c2bd-d8f3-4f42-bc79-2036595811f4; range_end:; response_count:1; response_revision:26153; }","duration":"127.124658ms","start":"2026-05-05T23:06:00.598897Z","end":"2026-05-05T23:06:00.726021Z","steps":["trace[950594742] 'range keys from in-memory index tree' (duration: 126.008431ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:00.854186Z","caller":"traceutil/trace.go:171","msg":"trace[530841732] linearizableReadLoop","detail":"{readStateIndex:27024; appliedIndex:27023; }","duration":"105.618799ms","start":"2026-05-05T23:06:00.748539Z","end":"2026-05-05T23:06:00.854158Z","steps":["trace[530841732] 'read index received' (duration: 105.304432ms)","trace[530841732] 'applied index is now lower than readState.Index' (duration: 313.117µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:00.854279Z","caller":"traceutil/trace.go:171","msg":"trace[2005404533] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"108.478748ms","start":"2026-05-05T23:06:00.745754Z","end":"2026-05-05T23:06:00.854232Z","steps":["trace[2005404533] 'process raft request' (duration: 108.199002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:00.854426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.851225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-05-05T23:06:00.854458Z","caller":"traceutil/trace.go:171","msg":"trace[1242504033] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26154; }","duration":"105.948847ms","start":"2026-05-05T23:06:00.7485Z","end":"2026-05-05T23:06:00.854449Z","steps":["trace[1242504033] 'agreement among raft nodes before linearized reading' (duration: 105.759283ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:01.02926Z","caller":"traceutil/trace.go:171","msg":"trace[861489321] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"127.834695ms","start":"2026-05-05T23:06:00.901385Z","end":"2026-05-05T23:06:01.029219Z","steps":["trace[861489321] 'process raft request' (duration: 74.789826ms)","trace[861489321] 'compare' (duration: 52.718792ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:01.029763Z","caller":"traceutil/trace.go:171","msg":"trace[1539881135] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"111.947092ms","start":"2026-05-05T23:06:00.917778Z","end":"2026-05-05T23:06:01.029725Z","steps":["trace[1539881135] 'process raft request' (duration: 111.372178ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:01.029817Z","caller":"traceutil/trace.go:171","msg":"trace[1296150905] transaction","detail":"{read_only:false; response_revision:26158; number_of_response:1; }","duration":"109.928164ms","start":"2026-05-05T23:06:00.919854Z","end":"2026-05-05T23:06:01.029782Z","steps":["trace[1296150905] 'process raft request' (duration: 109.689348ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:01.030014Z","caller":"traceutil/trace.go:171","msg":"trace[1813042160] transaction","detail":"{read_only:false; response_revision:26159; number_of_response:1; }","duration":"109.888542ms","start":"2026-05-05T23:06:00.920114Z","end":"2026-05-05T23:06:01.030002Z","steps":["trace[1813042160] 'process raft request' (duration: 109.608615ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:01.030014Z","caller":"traceutil/trace.go:171","msg":"trace[896565699] linearizableReadLoop","detail":"{readStateIndex:27027; appliedIndex:27025; }","duration":"110.895147ms","start":"2026-05-05T23:06:00.919076Z","end":"2026-05-05T23:06:01.029971Z","steps":["trace[896565699] 'read index received' (duration: 57.12283ms)","trace[896565699] 'applied index is now lower than readState.Index' (duration: 53.770857ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:01.030318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.216465ms","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-05-05T23:06:01.03039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.416871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18accdea2ff0f5d2\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-05-05T23:06:01.030421Z","caller":"traceutil/trace.go:171","msg":"trace[324614474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26159; }","duration":"111.368958ms","start":"2026-05-05T23:06:00.919026Z","end":"2026-05-05T23:06:01.030395Z","steps":["trace[324614474] 'agreement among raft nodes before linearized reading' (duration: 111.076401ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:01.030436Z","caller":"traceutil/trace.go:171","msg":"trace[500187234] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18accdea2ff0f5d2; range_end:; response_count:1; response_revision:26159; }","duration":"109.513633ms","start":"2026-05-05T23:06:00.920908Z","end":"2026-05-05T23:06:01.030422Z","steps":["trace[500187234] 'agreement among raft nodes before linearized reading' (duration: 109.269247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:08.62514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.023806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:06:08.625169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.265904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-05-05T23:06:08.625206Z","caller":"traceutil/trace.go:171","msg":"trace[700047764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26238; }","duration":"175.148499ms","start":"2026-05-05T23:06:08.450043Z","end":"2026-05-05T23:06:08.625192Z","steps":["trace[700047764] 'range keys from in-memory index tree' (duration: 174.914991ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:08.625243Z","caller":"traceutil/trace.go:171","msg":"trace[341609790] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26238; }","duration":"270.408767ms","start":"2026-05-05T23:06:08.354814Z","end":"2026-05-05T23:06:08.625223Z","steps":["trace[341609790] 'range keys from in-memory index tree' (duration: 270.063208ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:08.812686Z","caller":"traceutil/trace.go:171","msg":"trace[1880750695] linearizableReadLoop","detail":"{readStateIndex:27111; appliedIndex:27110; }","duration":"194.801293ms","start":"2026-05-05T23:06:08.61786Z","end":"2026-05-05T23:06:08.812661Z","steps":["trace[1880750695] 'read index received' (duration: 194.613958ms)","trace[1880750695] 'applied index is now lower than readState.Index' (duration: 187.035µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:08.812764Z","caller":"traceutil/trace.go:171","msg":"trace[373366824] transaction","detail":"{read_only:false; response_revision:26239; number_of_response:1; }","duration":"322.465813ms","start":"2026-05-05T23:06:08.490263Z","end":"2026-05-05T23:06:08.812729Z","steps":["trace[373366824] 'process raft request' (duration: 322.268868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:08.812878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.012787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-05T23:06:08.812902Z","caller":"traceutil/trace.go:171","msg":"trace[331256128] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26239; }","duration":"195.103769ms","start":"2026-05-05T23:06:08.61779Z","end":"2026-05-05T23:06:08.812894Z","steps":["trace[331256128] 'agreement among raft nodes before linearized reading' (duration: 194.979076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:08.812937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:06:08.490235Z","time spent":"322.596767ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:06:08.812962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.768778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:08.813053Z","caller":"traceutil/trace.go:171","msg":"trace[336846366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26239; }","duration":"186.87668ms","start":"2026-05-05T23:06:08.626155Z","end":"2026-05-05T23:06:08.813031Z","steps":["trace[336846366] 'agreement among raft nodes before linearized reading' (duration: 186.706496ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.277496Z","caller":"traceutil/trace.go:171","msg":"trace[1625616913] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"126.458352ms","start":"2026-05-05T23:06:09.151004Z","end":"2026-05-05T23:06:09.277462Z","steps":["trace[1625616913] 'process raft request' (duration: 115.493868ms)","trace[1625616913] 'compare' (duration: 10.7855ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:09.277527Z","caller":"traceutil/trace.go:171","msg":"trace[992531067] linearizableReadLoop","detail":"{readStateIndex:27113; appliedIndex:27112; }","duration":"125.689174ms","start":"2026-05-05T23:06:09.15181Z","end":"2026-05-05T23:06:09.277499Z","steps":["trace[992531067] 'read index received' (duration: 114.708369ms)","trace[992531067] 'applied index is now lower than readState.Index' (duration: 10.979425ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:09.277807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.977851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-05-05T23:06:09.277882Z","caller":"traceutil/trace.go:171","msg":"trace[653730114] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:26241; }","duration":"126.110894ms","start":"2026-05-05T23:06:09.151752Z","end":"2026-05-05T23:06:09.277863Z","steps":["trace[653730114] 'agreement among raft nodes before linearized reading' (duration: 125.867768ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.277977Z","caller":"traceutil/trace.go:171","msg":"trace[1478548405] transaction","detail":"{read_only:false; response_revision:26243; number_of_response:1; }","duration":"120.915369ms","start":"2026-05-05T23:06:09.157026Z","end":"2026-05-05T23:06:09.277942Z","steps":["trace[1478548405] 'process raft request' (duration: 120.715814ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.278045Z","caller":"traceutil/trace.go:171","msg":"trace[944630941] transaction","detail":"{read_only:false; response_revision:26242; number_of_response:1; }","duration":"122.156339ms","start":"2026-05-05T23:06:09.155834Z","end":"2026-05-05T23:06:09.27799Z","steps":["trace[944630941] 'process raft request' (duration: 121.627766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:09.278188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.912558ms","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-05-05T23:06:09.278307Z","caller":"traceutil/trace.go:171","msg":"trace[581948409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26243; }","duration":"121.073662ms","start":"2026-05-05T23:06:09.157204Z","end":"2026-05-05T23:06:09.278278Z","steps":["trace[581948409] 'agreement among raft nodes before linearized reading' (duration: 120.649112ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.392171Z","caller":"traceutil/trace.go:171","msg":"trace[964730562] transaction","detail":"{read_only:false; response_revision:26244; number_of_response:1; }","duration":"108.231263ms","start":"2026-05-05T23:06:09.28392Z","end":"2026-05-05T23:06:09.392152Z","steps":["trace[964730562] 'process raft request' (duration: 105.519727ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.394996Z","caller":"traceutil/trace.go:171","msg":"trace[76833945] transaction","detail":"{read_only:false; response_revision:26245; number_of_response:1; }","duration":"108.813246ms","start":"2026-05-05T23:06:09.286156Z","end":"2026-05-05T23:06:09.394969Z","steps":["trace[76833945] 'process raft request' (duration: 108.568041ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.395375Z","caller":"traceutil/trace.go:171","msg":"trace[1506242553] transaction","detail":"{read_only:false; response_revision:26246; number_of_response:1; }","duration":"108.027998ms","start":"2026-05-05T23:06:09.287329Z","end":"2026-05-05T23:06:09.395357Z","steps":["trace[1506242553] 'process raft request' (duration: 107.580137ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.395464Z","caller":"traceutil/trace.go:171","msg":"trace[2019389583] transaction","detail":"{read_only:false; response_revision:26247; number_of_response:1; }","duration":"107.276669ms","start":"2026-05-05T23:06:09.288155Z","end":"2026-05-05T23:06:09.395431Z","steps":["trace[2019389583] 'process raft request' (duration: 107.046024ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:09.395835Z","caller":"traceutil/trace.go:171","msg":"trace[1489741263] transaction","detail":"{read_only:false; response_revision:26248; number_of_response:1; }","duration":"107.445103ms","start":"2026-05-05T23:06:09.288319Z","end":"2026-05-05T23:06:09.395764Z","steps":["trace[1489741263] 'process raft request' (duration: 107.063144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.497586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.661674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:19.497684Z","caller":"traceutil/trace.go:171","msg":"trace[67562966] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:26325; }","duration":"183.821458ms","start":"2026-05-05T23:06:19.313834Z","end":"2026-05-05T23:06:19.497656Z","steps":["trace[67562966] 'count revisions from in-memory index tree' (duration: 183.477559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.498007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.045391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:06:19.498195Z","caller":"traceutil/trace.go:171","msg":"trace[601407918] transaction","detail":"{read_only:false; response_revision:26326; number_of_response:1; }","duration":"177.395192ms","start":"2026-05-05T23:06:19.320781Z","end":"2026-05-05T23:06:19.498176Z","steps":["trace[601407918] 'process raft request' (duration: 27.072494ms)","trace[601407918] 'compare' (duration: 149.902878ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:19.49847Z","caller":"traceutil/trace.go:171","msg":"trace[1368035501] transaction","detail":"{read_only:false; response_revision:26327; number_of_response:1; }","duration":"176.240983ms","start":"2026-05-05T23:06:19.322211Z","end":"2026-05-05T23:06:19.498452Z","steps":["trace[1368035501] 'process raft request' (duration: 175.923316ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.498726Z","caller":"traceutil/trace.go:171","msg":"trace[354738447] transaction","detail":"{read_only:false; response_revision:26328; number_of_response:1; }","duration":"176.365457ms","start":"2026-05-05T23:06:19.322321Z","end":"2026-05-05T23:06:19.498687Z","steps":["trace[354738447] 'process raft request' (duration: 176.034009ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.719587Z","caller":"traceutil/trace.go:171","msg":"trace[1897557262] transaction","detail":"{read_only:false; response_revision:26330; number_of_response:1; }","duration":"285.89454ms","start":"2026-05-05T23:06:19.433664Z","end":"2026-05-05T23:06:19.719559Z","steps":["trace[1897557262] 'process raft request' (duration: 285.726996ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.719787Z","caller":"traceutil/trace.go:171","msg":"trace[1295612248] transaction","detail":"{read_only:false; response_revision:26329; number_of_response:1; }","duration":"288.80309ms","start":"2026-05-05T23:06:19.430958Z","end":"2026-05-05T23:06:19.719761Z","steps":["trace[1295612248] 'process raft request' (duration: 288.263037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.719964Z","caller":"traceutil/trace.go:171","msg":"trace[905901692] linearizableReadLoop","detail":"{readStateIndex:27205; appliedIndex:27199; }","duration":"276.852132ms","start":"2026-05-05T23:06:19.443102Z","end":"2026-05-05T23:06:19.719954Z","steps":["trace[905901692] 'read index received' (duration: 50.687054ms)","trace[905901692] 'applied index is now lower than readState.Index' (duration: 226.163098ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:19.720337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.213021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-05T23:06:19.72045Z","caller":"traceutil/trace.go:171","msg":"trace[1332652630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26331; }","duration":"277.374985ms","start":"2026-05-05T23:06:19.443047Z","end":"2026-05-05T23:06:19.720422Z","steps":["trace[1332652630] 'agreement among raft nodes before linearized reading' (duration: 277.091838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.720541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.089378ms","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-05-05T23:06:19.720601Z","caller":"traceutil/trace.go:171","msg":"trace[1760074391] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26331; }","duration":"277.207401ms","start":"2026-05-05T23:06:19.443375Z","end":"2026-05-05T23:06:19.720582Z","steps":["trace[1760074391] 'agreement among raft nodes before linearized reading' (duration: 277.027076ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.720668Z","caller":"traceutil/trace.go:171","msg":"trace[812209629] transaction","detail":"{read_only:false; response_revision:26331; number_of_response:1; }","duration":"282.910958ms","start":"2026-05-05T23:06:19.437743Z","end":"2026-05-05T23:06:19.720654Z","steps":["trace[812209629] 'process raft request' (duration: 281.73366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.720832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.157441ms","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-05-05T23:06:19.720865Z","caller":"traceutil/trace.go:171","msg":"trace[1847637929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26331; }","duration":"270.204982ms","start":"2026-05-05T23:06:19.450646Z","end":"2026-05-05T23:06:19.720851Z","steps":["trace[1847637929] 'agreement among raft nodes before linearized reading' (duration: 270.11477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.720955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.75499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-667d5d545c-vt8h4.18accc42bd33beec\" ","response":"range_response_count:1 size:2108"} {"level":"warn","ts":"2026-05-05T23:06:19.720998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.615103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T23:06:19.72104Z","caller":"traceutil/trace.go:171","msg":"trace[973923389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26331; }","duration":"268.666715ms","start":"2026-05-05T23:06:19.452366Z","end":"2026-05-05T23:06:19.721032Z","steps":["trace[973923389] 'agreement among raft nodes before linearized reading' (duration: 268.568133ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.721066Z","caller":"traceutil/trace.go:171","msg":"trace[450572675] range","detail":"{range_begin:/registry/events/openstack/glance-api-667d5d545c-vt8h4.18accc42bd33beec; range_end:; response_count:1; response_revision:26331; }","duration":"121.904563ms","start":"2026-05-05T23:06:19.599125Z","end":"2026-05-05T23:06:19.72103Z","steps":["trace[450572675] 'agreement among raft nodes before linearized reading' (duration: 121.625407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:19.721242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.778626ms","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-05-05T23:06:19.721337Z","caller":"traceutil/trace.go:171","msg":"trace[1558721954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26331; }","duration":"270.93961ms","start":"2026-05-05T23:06:19.450382Z","end":"2026-05-05T23:06:19.721321Z","steps":["trace[1558721954] 'agreement among raft nodes before linearized reading' (duration: 270.716745ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.927372Z","caller":"traceutil/trace.go:171","msg":"trace[1357524234] transaction","detail":"{read_only:false; response_revision:26333; number_of_response:1; }","duration":"200.898079ms","start":"2026-05-05T23:06:19.726449Z","end":"2026-05-05T23:06:19.927347Z","steps":["trace[1357524234] 'process raft request' (duration: 199.100306ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.927746Z","caller":"traceutil/trace.go:171","msg":"trace[1166443804] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"201.144705ms","start":"2026-05-05T23:06:19.726573Z","end":"2026-05-05T23:06:19.927717Z","steps":["trace[1166443804] 'process raft request' (duration: 200.409427ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.927927Z","caller":"traceutil/trace.go:171","msg":"trace[1052158276] transaction","detail":"{read_only:false; response_revision:26336; number_of_response:1; }","duration":"198.972523ms","start":"2026-05-05T23:06:19.72894Z","end":"2026-05-05T23:06:19.927913Z","steps":["trace[1052158276] 'process raft request' (duration: 198.895821ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.928004Z","caller":"traceutil/trace.go:171","msg":"trace[1648195980] transaction","detail":"{read_only:false; response_revision:26337; number_of_response:1; }","duration":"198.898951ms","start":"2026-05-05T23:06:19.729098Z","end":"2026-05-05T23:06:19.927997Z","steps":["trace[1648195980] 'process raft request' (duration: 198.781968ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:19.928026Z","caller":"traceutil/trace.go:171","msg":"trace[858753167] transaction","detail":"{read_only:false; response_revision:26335; number_of_response:1; }","duration":"200.359956ms","start":"2026-05-05T23:06:19.727653Z","end":"2026-05-05T23:06:19.928013Z","steps":["trace[858753167] 'process raft request' (duration: 199.669469ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:21.959494Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a5c.wal"} {"level":"warn","ts":"2026-05-05T23:06:27.699292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.446784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:06:27.699603Z","caller":"traceutil/trace.go:171","msg":"trace[173640670] transaction","detail":"{read_only:false; response_revision:26400; number_of_response:1; }","duration":"169.517592ms","start":"2026-05-05T23:06:27.530062Z","end":"2026-05-05T23:06:27.69958Z","steps":["trace[173640670] 'process raft request' (duration: 169.469691ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:27.69997Z","caller":"traceutil/trace.go:171","msg":"trace[1776161832] transaction","detail":"{read_only:false; response_revision:26397; number_of_response:1; }","duration":"254.940473ms","start":"2026-05-05T23:06:27.445016Z","end":"2026-05-05T23:06:27.699957Z","steps":["trace[1776161832] 'process raft request' (duration: 141.727421ms)","trace[1776161832] 'compare' (duration: 112.337861ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:27.700411Z","caller":"traceutil/trace.go:171","msg":"trace[1284793335] transaction","detail":"{read_only:false; response_revision:26399; number_of_response:1; }","duration":"171.123601ms","start":"2026-05-05T23:06:27.529277Z","end":"2026-05-05T23:06:27.7004Z","steps":["trace[1284793335] 'process raft request' (duration: 170.204259ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:27.70091Z","caller":"traceutil/trace.go:171","msg":"trace[539756918] transaction","detail":"{read_only:false; response_revision:26398; number_of_response:1; }","duration":"172.76108ms","start":"2026-05-05T23:06:27.528106Z","end":"2026-05-05T23:06:27.700867Z","steps":["trace[539756918] 'process raft request' (duration: 171.299735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:28.049739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.479499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-05T23:06:28.04996Z","caller":"traceutil/trace.go:171","msg":"trace[33489305] transaction","detail":"{read_only:false; response_revision:26402; number_of_response:1; }","duration":"301.475727ms","start":"2026-05-05T23:06:27.748467Z","end":"2026-05-05T23:06:28.049942Z","steps":["trace[33489305] 'process raft request' (duration: 301.377074ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.049959Z","caller":"traceutil/trace.go:171","msg":"trace[442645526] transaction","detail":"{read_only:false; response_revision:26401; number_of_response:1; }","duration":"308.397034ms","start":"2026-05-05T23:06:27.741523Z","end":"2026-05-05T23:06:28.04992Z","steps":["trace[442645526] 'process raft request' (duration: 107.642208ms)","trace[442645526] 'compare' (duration: 199.847024ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:28.050034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:06:27.748443Z","time spent":"301.559639ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T23:06:28.050113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T23:06:27.741495Z","time spent":"308.534807ms","remote":"127.0.0.1:38666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T23:06:28.050157Z","caller":"traceutil/trace.go:171","msg":"trace[169692898] linearizableReadLoop","detail":"{readStateIndex:27280; appliedIndex:27276; }","duration":"285.606004ms","start":"2026-05-05T23:06:27.764516Z","end":"2026-05-05T23:06:28.050122Z","steps":["trace[169692898] 'read index received' (duration: 84.597842ms)","trace[169692898] 'applied index is now lower than readState.Index' (duration: 201.006462ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:28.050245Z","caller":"traceutil/trace.go:171","msg":"trace[360703439] transaction","detail":"{read_only:false; response_revision:26404; number_of_response:1; }","duration":"296.937748ms","start":"2026-05-05T23:06:27.753299Z","end":"2026-05-05T23:06:28.050237Z","steps":["trace[360703439] 'process raft request' (duration: 296.730813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:28.050363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.628826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-05T23:06:28.050381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.847809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1444"} {"level":"info","ts":"2026-05-05T23:06:28.050396Z","caller":"traceutil/trace.go:171","msg":"trace[19831948] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26404; }","duration":"167.688568ms","start":"2026-05-05T23:06:27.882695Z","end":"2026-05-05T23:06:28.050384Z","steps":["trace[19831948] 'agreement among raft nodes before linearized reading' (duration: 167.627037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.050424Z","caller":"traceutil/trace.go:171","msg":"trace[1595195023] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26404; }","duration":"285.941932ms","start":"2026-05-05T23:06:27.764467Z","end":"2026-05-05T23:06:28.050409Z","steps":["trace[1595195023] 'agreement among raft nodes before linearized reading' (duration: 285.790558ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.050511Z","caller":"traceutil/trace.go:171","msg":"trace[1162963162] transaction","detail":"{read_only:false; response_revision:26403; number_of_response:1; }","duration":"297.288646ms","start":"2026-05-05T23:06:27.753088Z","end":"2026-05-05T23:06:28.050376Z","steps":["trace[1162963162] 'process raft request' (duration: 296.817295ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.269734Z","caller":"traceutil/trace.go:171","msg":"trace[563510921] linearizableReadLoop","detail":"{readStateIndex:27284; appliedIndex:27280; }","duration":"213.881173ms","start":"2026-05-05T23:06:28.05583Z","end":"2026-05-05T23:06:28.269711Z","steps":["trace[563510921] 'read index received' (duration: 66.022024ms)","trace[563510921] 'applied index is now lower than readState.Index' (duration: 147.858139ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:28.269921Z","caller":"traceutil/trace.go:171","msg":"trace[1741289224] transaction","detail":"{read_only:false; response_revision:26408; number_of_response:1; }","duration":"214.182109ms","start":"2026-05-05T23:06:28.055718Z","end":"2026-05-05T23:06:28.2699Z","steps":["trace[1741289224] 'process raft request' (duration: 213.922033ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.269955Z","caller":"traceutil/trace.go:171","msg":"trace[121883813] transaction","detail":"{read_only:false; response_revision:26409; number_of_response:1; }","duration":"211.181426ms","start":"2026-05-05T23:06:28.058734Z","end":"2026-05-05T23:06:28.269916Z","steps":["trace[121883813] 'process raft request' (duration: 210.936381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:28.269994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.1383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9547"} {"level":"info","ts":"2026-05-05T23:06:28.269964Z","caller":"traceutil/trace.go:171","msg":"trace[2141579663] transaction","detail":"{read_only:false; response_revision:26407; number_of_response:1; }","duration":"214.309642ms","start":"2026-05-05T23:06:28.055597Z","end":"2026-05-05T23:06:28.269906Z","steps":["trace[2141579663] 'process raft request' (duration: 213.993515ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.270046Z","caller":"traceutil/trace.go:171","msg":"trace[692820837] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26409; }","duration":"214.219581ms","start":"2026-05-05T23:06:28.055811Z","end":"2026-05-05T23:06:28.27003Z","steps":["trace[692820837] 'agreement among raft nodes before linearized reading' (duration: 214.005275ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:28.26996Z","caller":"traceutil/trace.go:171","msg":"trace[997024761] transaction","detail":"{read_only:false; response_revision:26406; number_of_response:1; }","duration":"214.388325ms","start":"2026-05-05T23:06:28.055544Z","end":"2026-05-05T23:06:28.269933Z","steps":["trace[997024761] 'process raft request' (duration: 179.920962ms)","trace[997024761] 'compare' (duration: 33.920499ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:29.578162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.461691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-05-05T23:06:29.57826Z","caller":"traceutil/trace.go:171","msg":"trace[1051805089] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:26411; }","duration":"133.620926ms","start":"2026-05-05T23:06:29.444623Z","end":"2026-05-05T23:06:29.578244Z","steps":["trace[1051805089] 'range keys from in-memory index tree' (duration: 133.282927ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:33.564136Z","caller":"traceutil/trace.go:171","msg":"trace[1740065150] linearizableReadLoop","detail":"{readStateIndex:27316; appliedIndex:27315; }","duration":"115.753103ms","start":"2026-05-05T23:06:33.448357Z","end":"2026-05-05T23:06:33.56411Z","steps":["trace[1740065150] 'read index received' (duration: 115.552058ms)","trace[1740065150] 'applied index is now lower than readState.Index' (duration: 199.325µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:33.564306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.918058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-05T23:06:33.56434Z","caller":"traceutil/trace.go:171","msg":"trace[1419279131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26439; }","duration":"115.976479ms","start":"2026-05-05T23:06:33.448351Z","end":"2026-05-05T23:06:33.564328Z","steps":["trace[1419279131] 'agreement among raft nodes before linearized reading' (duration: 115.859696ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:33.564567Z","caller":"traceutil/trace.go:171","msg":"trace[1942966507] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"123.974983ms","start":"2026-05-05T23:06:33.440582Z","end":"2026-05-05T23:06:33.564557Z","steps":["trace[1942966507] 'process raft request' (duration: 123.348567ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:34.455965Z","caller":"traceutil/trace.go:171","msg":"trace[263214922] linearizableReadLoop","detail":"{readStateIndex:27324; appliedIndex:27323; }","duration":"157.617526ms","start":"2026-05-05T23:06:34.29832Z","end":"2026-05-05T23:06:34.455938Z","steps":["trace[263214922] 'read index received' (duration: 157.436561ms)","trace[263214922] 'applied index is now lower than readState.Index' (duration: 179.495µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:34.456137Z","caller":"traceutil/trace.go:171","msg":"trace[575043864] transaction","detail":"{read_only:false; response_revision:26447; number_of_response:1; }","duration":"158.370273ms","start":"2026-05-05T23:06:34.297709Z","end":"2026-05-05T23:06:34.456079Z","steps":["trace[575043864] 'process raft request' (duration: 158.063126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:34.456267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.924872ms","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-05-05T23:06:34.45632Z","caller":"traceutil/trace.go:171","msg":"trace[475645515] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26447; }","duration":"158.017874ms","start":"2026-05-05T23:06:34.298286Z","end":"2026-05-05T23:06:34.456304Z","steps":["trace[475645515] 'agreement among raft nodes before linearized reading' (duration: 157.789649ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:34.457841Z","caller":"traceutil/trace.go:171","msg":"trace[641349551] transaction","detail":"{read_only:false; response_revision:26448; number_of_response:1; }","duration":"158.758572ms","start":"2026-05-05T23:06:34.29903Z","end":"2026-05-05T23:06:34.457788Z","steps":["trace[641349551] 'process raft request' (duration: 158.190158ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:34.457863Z","caller":"traceutil/trace.go:171","msg":"trace[1929902741] transaction","detail":"{read_only:false; response_revision:26449; number_of_response:1; }","duration":"158.556517ms","start":"2026-05-05T23:06:34.29927Z","end":"2026-05-05T23:06:34.457826Z","steps":["trace[1929902741] 'process raft request' (duration: 158.143667ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:34.619885Z","caller":"traceutil/trace.go:171","msg":"trace[2144810420] transaction","detail":"{read_only:false; response_revision:26450; number_of_response:1; }","duration":"157.799148ms","start":"2026-05-05T23:06:34.46204Z","end":"2026-05-05T23:06:34.619839Z","steps":["trace[2144810420] 'process raft request' (duration: 157.596063ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:35.130829Z","caller":"traceutil/trace.go:171","msg":"trace[310961486] transaction","detail":"{read_only:false; response_revision:26451; number_of_response:1; }","duration":"144.333395ms","start":"2026-05-05T23:06:34.986462Z","end":"2026-05-05T23:06:35.130795Z","steps":["trace[310961486] 'process raft request' (duration: 144.14132ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:37.092412Z","caller":"traceutil/trace.go:171","msg":"trace[2035947537] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"112.152257ms","start":"2026-05-05T23:06:36.980225Z","end":"2026-05-05T23:06:37.092377Z","steps":["trace[2035947537] 'process raft request' (duration: 111.916741ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:37.336769Z","caller":"traceutil/trace.go:171","msg":"trace[382508129] linearizableReadLoop","detail":"{readStateIndex:27346; appliedIndex:27345; }","duration":"148.443313ms","start":"2026-05-05T23:06:37.188296Z","end":"2026-05-05T23:06:37.33674Z","steps":["trace[382508129] 'read index received' (duration: 51.551744ms)","trace[382508129] 'applied index is now lower than readState.Index' (duration: 96.890139ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:37.336796Z","caller":"traceutil/trace.go:171","msg":"trace[722619843] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"199.628958ms","start":"2026-05-05T23:06:37.137126Z","end":"2026-05-05T23:06:37.336755Z","steps":["trace[722619843] 'process raft request' (duration: 102.651727ms)","trace[722619843] 'compare' (duration: 96.684414ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T23:06:37.33695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.625097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T23:06:37.337063Z","caller":"traceutil/trace.go:171","msg":"trace[339984171] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:26468; }","duration":"148.75808ms","start":"2026-05-05T23:06:37.188287Z","end":"2026-05-05T23:06:37.337045Z","steps":["trace[339984171] 'agreement among raft nodes before linearized reading' (duration: 148.548335ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:38.185591Z","caller":"traceutil/trace.go:171","msg":"trace[1036716058] transaction","detail":"{read_only:false; response_revision:26473; number_of_response:1; }","duration":"100.439175ms","start":"2026-05-05T23:06:38.08513Z","end":"2026-05-05T23:06:38.18557Z","steps":["trace[1036716058] 'process raft request' (duration: 100.286551ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:38.219475Z","caller":"traceutil/trace.go:171","msg":"trace[294384198] transaction","detail":"{read_only:false; response_revision:26474; number_of_response:1; }","duration":"133.559784ms","start":"2026-05-05T23:06:38.085829Z","end":"2026-05-05T23:06:38.219389Z","steps":["trace[294384198] 'process raft request' (duration: 133.241526ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:38.220179Z","caller":"traceutil/trace.go:171","msg":"trace[1470437026] transaction","detail":"{read_only:false; response_revision:26475; number_of_response:1; }","duration":"131.913584ms","start":"2026-05-05T23:06:38.088023Z","end":"2026-05-05T23:06:38.219937Z","steps":["trace[1470437026] 'process raft request' (duration: 131.30988ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:38.350113Z","caller":"traceutil/trace.go:171","msg":"trace[247765616] transaction","detail":"{read_only:false; response_revision:26476; number_of_response:1; }","duration":"124.804883ms","start":"2026-05-05T23:06:38.225253Z","end":"2026-05-05T23:06:38.350058Z","steps":["trace[247765616] 'process raft request' (duration: 124.522077ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:40.54172Z","caller":"traceutil/trace.go:171","msg":"trace[981779830] transaction","detail":"{read_only:false; response_revision:26491; number_of_response:1; }","duration":"102.36598ms","start":"2026-05-05T23:06:40.439331Z","end":"2026-05-05T23:06:40.541697Z","steps":["trace[981779830] 'process raft request' (duration: 101.987231ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:40.652583Z","caller":"traceutil/trace.go:171","msg":"trace[1769119643] transaction","detail":"{read_only:false; response_revision:26493; number_of_response:1; }","duration":"104.274657ms","start":"2026-05-05T23:06:40.548277Z","end":"2026-05-05T23:06:40.652552Z","steps":["trace[1769119643] 'process raft request' (duration: 91.638722ms)","trace[1769119643] 'compare' (duration: 12.04241ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T23:06:40.652918Z","caller":"traceutil/trace.go:171","msg":"trace[222763455] transaction","detail":"{read_only:false; response_revision:26494; number_of_response:1; }","duration":"104.616905ms","start":"2026-05-05T23:06:40.548264Z","end":"2026-05-05T23:06:40.652881Z","steps":["trace[222763455] 'process raft request' (duration: 103.893458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:50.110066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.854657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-05T23:06:50.110183Z","caller":"traceutil/trace.go:171","msg":"trace[1000241212] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26569; }","duration":"186.019411ms","start":"2026-05-05T23:06:49.924138Z","end":"2026-05-05T23:06:50.110157Z","steps":["trace[1000241212] 'range keys from in-memory index tree' (duration: 185.655602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T23:06:50.110114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.195053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-05-05T23:06:50.110507Z","caller":"traceutil/trace.go:171","msg":"trace[895638625] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26569; }","duration":"164.581953ms","start":"2026-05-05T23:06:49.945904Z","end":"2026-05-05T23:06:50.110486Z","steps":["trace[895638625] 'range keys from in-memory index tree' (duration: 164.109412ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:50.369096Z","caller":"traceutil/trace.go:171","msg":"trace[963945783] transaction","detail":"{read_only:false; response_revision:26571; number_of_response:1; }","duration":"111.07952ms","start":"2026-05-05T23:06:50.25799Z","end":"2026-05-05T23:06:50.369069Z","steps":["trace[963945783] 'process raft request' (duration: 110.201779ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:06:50.369413Z","caller":"traceutil/trace.go:171","msg":"trace[712440357] transaction","detail":"{read_only:false; response_revision:26572; number_of_response:1; }","duration":"108.726555ms","start":"2026-05-05T23:06:50.260659Z","end":"2026-05-05T23:06:50.369386Z","steps":["trace[712440357] 'process raft request' (duration: 108.316955ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T23:09:22.926752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25147} {"level":"info","ts":"2026-05-05T23:09:23.079451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25147,"took":"147.988462ms","hash":2935444839,"current-db-size-bytes":59990016,"current-db-size":"60 MB","current-db-size-in-use-bytes":37384192,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-05-05T23:09:23.079515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2935444839,"revision":25147,"compact-revision":21926} {"level":"info","ts":"2026-05-05T23:10:57.544853Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T23:10:57.550795Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-05-05T23:10:57.55089Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-05-05T23:14:22.934344Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28064} {"level":"info","ts":"2026-05-05T23:14:23.082389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28064,"took":"141.896812ms","hash":1763846303,"current-db-size-bytes":59990016,"current-db-size":"60 MB","current-db-size-in-use-bytes":32530432,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T23:14:23.082462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1763846303,"revision":28064,"compact-revision":25147} {"level":"info","ts":"2026-05-05T23:19:22.940146Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30566} {"level":"info","ts":"2026-05-05T23:19:23.07613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30566,"took":"129.428564ms","hash":3987321273,"current-db-size-bytes":59990016,"current-db-size":"60 MB","current-db-size-in-use-bytes":30302208,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-05T23:19:23.076182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3987321273,"revision":30566,"compact-revision":28064} {"level":"info","ts":"2026-05-05T23:24:22.948276Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32828} {"level":"info","ts":"2026-05-05T23:24:23.091086Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32828,"took":"138.303469ms","hash":2216269947,"current-db-size-bytes":59990016,"current-db-size":"60 MB","current-db-size-in-use-bytes":30736384,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-05T23:24:23.091168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2216269947,"revision":32828,"compact-revision":30566} {"level":"info","ts":"2026-05-05T23:29:22.955288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35109} {"level":"info","ts":"2026-05-05T23:29:23.116924Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35109,"took":"155.539013ms","hash":1440965412,"current-db-size-bytes":60456960,"current-db-size":"60 MB","current-db-size-in-use-bytes":31580160,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T23:29:23.116984Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1440965412,"revision":35109,"compact-revision":32828} {"level":"info","ts":"2026-05-05T23:32:25.278285Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T23:32:25.282489Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-05-05T23:32:25.282598Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-05-05T23:34:22.964267Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37352} {"level":"info","ts":"2026-05-05T23:34:23.085713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37352,"took":"115.315555ms","hash":2304857963,"current-db-size-bytes":60456960,"current-db-size":"60 MB","current-db-size-in-use-bytes":31358976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-05T23:34:23.085787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2304857963,"revision":37352,"compact-revision":35109}