{"level":"warn","ts":"2026-08-05T21:41:23.073197Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-05T21:41:23.073363Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.112:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.112:2380","--initial-cluster=instance=https://199.19.213.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.112:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-05T21:41:23.073451Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-05T21:41:23.073462Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-08-05T21:41:23.073495Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-05T21:41:23.074259Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"]} {"level":"info","ts":"2026-08-05T21:41:23.074384Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.112:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-05T21:41:23.076963Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.237747ms"} {"level":"info","ts":"2026-08-05T21:41:23.08283Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"197930edc5411b2e","cluster-id":"8165613f50a6d530"} {"level":"info","ts":"2026-08-05T21:41:23.082932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=()"} {"level":"info","ts":"2026-08-05T21:41:23.082959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 0"} {"level":"info","ts":"2026-08-05T21:41:23.082972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 197930edc5411b2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-05T21:41:23.082994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 1"} {"level":"info","ts":"2026-08-05T21:41:23.083048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"warn","ts":"2026-08-05T21:41:23.088591Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-05T21:41:23.090471Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-05T21:41:23.092277Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-05T21:41:23.094766Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"197930edc5411b2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-05T21:41:23.094873Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-05T21:41:23.094986Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"197930edc5411b2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-05T21:41:23.09504Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-05T21:41:23.095061Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-05T21:41:23.096073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"info","ts":"2026-08-05T21:41:23.096274Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","added-peer-id":"197930edc5411b2e","added-peer-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-08-05T21:41:23.098559Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-05T21:41:23.098661Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-08-05T21:41:23.098704Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-08-05T21:41:23.098934Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"197930edc5411b2e","initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-05T21:41:23.098999Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-05T21:41:23.984139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e is starting a new election at term 1"} {"level":"info","ts":"2026-08-05T21:41:23.984202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became pre-candidate at term 1"} {"level":"info","ts":"2026-08-05T21:41:23.984227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgPreVoteResp from 197930edc5411b2e at term 1"} {"level":"info","ts":"2026-08-05T21:41:23.984246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became candidate at term 2"} {"level":"info","ts":"2026-08-05T21:41:23.984258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgVoteResp from 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-08-05T21:41:23.984274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became leader at term 2"} {"level":"info","ts":"2026-08-05T21:41:23.984288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 197930edc5411b2e elected leader 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-08-05T21:41:23.985417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"197930edc5411b2e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.112:2379]}","request-path":"/0/members/197930edc5411b2e/attributes","cluster-id":"8165613f50a6d530","publish-timeout":"7s"} {"level":"info","ts":"2026-08-05T21:41:23.98544Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:41:23.985737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-05T21:41:23.986029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:41:23.986139Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-05T21:41:23.986363Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-05T21:41:23.988081Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:41:23.988517Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:41:23.988626Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-05T21:41:23.9908Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.112:2379"} {"level":"info","ts":"2026-08-05T21:41:23.99129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-05T21:42:08.659453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.101614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-05T21:42:08.659562Z","caller":"traceutil/trace.go:171","msg":"trace[1994768838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"187.242767ms","start":"2026-08-05T21:42:08.4723Z","end":"2026-08-05T21:42:08.659542Z","steps":["trace[1994768838] 'range keys from in-memory index tree' (duration: 186.91835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:42:08.659383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.141215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:42:08.65967Z","caller":"traceutil/trace.go:171","msg":"trace[43897566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"247.496881ms","start":"2026-08-05T21:42:08.412152Z","end":"2026-08-05T21:42:08.659649Z","steps":["trace[43897566] 'range keys from in-memory index tree' (duration: 247.063592ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:08.914844Z","caller":"traceutil/trace.go:171","msg":"trace[347266603] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"254.276601ms","start":"2026-08-05T21:42:08.660538Z","end":"2026-08-05T21:42:08.914815Z","steps":["trace[347266603] 'read index received' (duration: 253.300222ms)","trace[347266603] 'applied index is now lower than readState.Index' (duration: 975.109µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:42:08.914972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.410843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:42:08.914983Z","caller":"traceutil/trace.go:171","msg":"trace[1018519648] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"263.136972ms","start":"2026-08-05T21:42:08.651784Z","end":"2026-08-05T21:42:08.914921Z","steps":["trace[1018519648] 'process raft request' (duration: 262.261315ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:08.915088Z","caller":"traceutil/trace.go:171","msg":"trace[795777991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"254.543427ms","start":"2026-08-05T21:42:08.660531Z","end":"2026-08-05T21:42:08.915074Z","steps":["trace[795777991] 'agreement among raft nodes before linearized reading' (duration: 254.387824ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:08.94663Z","caller":"traceutil/trace.go:171","msg":"trace[2093368551] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"281.835622ms","start":"2026-08-05T21:42:08.664761Z","end":"2026-08-05T21:42:08.946597Z","steps":["trace[2093368551] 'process raft request' (duration: 281.625028ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:09.149731Z","caller":"traceutil/trace.go:171","msg":"trace[1470862980] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"168.868312ms","start":"2026-08-05T21:42:08.98079Z","end":"2026-08-05T21:42:09.149658Z","steps":["trace[1470862980] 'process raft request' (duration: 158.395129ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:23.935861Z","caller":"traceutil/trace.go:171","msg":"trace[236865545] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"110.641308ms","start":"2026-08-05T21:42:23.825204Z","end":"2026-08-05T21:42:23.935845Z","steps":["trace[236865545] 'process raft request' (duration: 110.531296ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:40.468717Z","caller":"traceutil/trace.go:171","msg":"trace[761708182] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"114.211737ms","start":"2026-08-05T21:42:40.354485Z","end":"2026-08-05T21:42:40.468697Z","steps":["trace[761708182] 'process raft request' (duration: 113.995293ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:40.46886Z","caller":"traceutil/trace.go:171","msg":"trace[965948775] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"114.361979ms","start":"2026-08-05T21:42:40.354488Z","end":"2026-08-05T21:42:40.46885Z","steps":["trace[965948775] 'process raft request' (duration: 114.086274ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:40.469054Z","caller":"traceutil/trace.go:171","msg":"trace[390140115] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"113.876771ms","start":"2026-08-05T21:42:40.355138Z","end":"2026-08-05T21:42:40.469015Z","steps":["trace[390140115] 'process raft request' (duration: 113.498503ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:40.4693Z","caller":"traceutil/trace.go:171","msg":"trace[1912877146] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"114.474772ms","start":"2026-08-05T21:42:40.354817Z","end":"2026-08-05T21:42:40.469292Z","steps":["trace[1912877146] 'process raft request' (duration: 113.788379ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:51.322112Z","caller":"traceutil/trace.go:171","msg":"trace[163494289] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"114.982172ms","start":"2026-08-05T21:42:51.207102Z","end":"2026-08-05T21:42:51.322084Z","steps":["trace[163494289] 'process raft request' (duration: 114.840169ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:42:51.359298Z","caller":"traceutil/trace.go:171","msg":"trace[525778664] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"140.421176ms","start":"2026-08-05T21:42:51.218857Z","end":"2026-08-05T21:42:51.359279Z","steps":["trace[525778664] 'process raft request' (duration: 126.037607ms)","trace[525778664] 'compare' (duration: 14.306847ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:43:05.510364Z","caller":"traceutil/trace.go:171","msg":"trace[1034577831] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"106.042419ms","start":"2026-08-05T21:43:05.404283Z","end":"2026-08-05T21:43:05.510325Z","steps":["trace[1034577831] 'process raft request' (duration: 103.414798ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:43:36.448541Z","caller":"traceutil/trace.go:171","msg":"trace[1981570794] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"125.142187ms","start":"2026-08-05T21:43:36.323367Z","end":"2026-08-05T21:43:36.448509Z","steps":["trace[1981570794] 'process raft request' (duration: 124.959883ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:43:36.91602Z","caller":"traceutil/trace.go:171","msg":"trace[1324958163] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1877; }","duration":"150.544907ms","start":"2026-08-05T21:43:36.765451Z","end":"2026-08-05T21:43:36.915996Z","steps":["trace[1324958163] 'read index received' (duration: 150.315953ms)","trace[1324958163] 'applied index is now lower than readState.Index' (duration: 228.044µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:43:36.916172Z","caller":"traceutil/trace.go:171","msg":"trace[1519915631] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"217.414369ms","start":"2026-08-05T21:43:36.698716Z","end":"2026-08-05T21:43:36.916131Z","steps":["trace[1519915631] 'process raft request' (duration: 217.103543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:43:36.916264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.808512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-05T21:43:36.916301Z","caller":"traceutil/trace.go:171","msg":"trace[1677503664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1806; }","duration":"150.922104ms","start":"2026-08-05T21:43:36.765369Z","end":"2026-08-05T21:43:36.916291Z","steps":["trace[1677503664] 'agreement among raft nodes before linearized reading' (duration: 150.764871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:43:36.916394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.014209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-05T21:43:36.916489Z","caller":"traceutil/trace.go:171","msg":"trace[1178412374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1806; }","duration":"118.173442ms","start":"2026-08-05T21:43:36.798294Z","end":"2026-08-05T21:43:36.916468Z","steps":["trace[1178412374] 'agreement among raft nodes before linearized reading' (duration: 117.899097ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:44:20.529177Z","caller":"traceutil/trace.go:171","msg":"trace[2042817108] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"176.560099ms","start":"2026-08-05T21:44:20.352554Z","end":"2026-08-05T21:44:20.529114Z","steps":["trace[2042817108] 'read index received' (duration: 159.399598ms)","trace[2042817108] 'applied index is now lower than readState.Index' (duration: 17.158621ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:44:20.529221Z","caller":"traceutil/trace.go:171","msg":"trace[1353356309] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"190.394957ms","start":"2026-08-05T21:44:20.338751Z","end":"2026-08-05T21:44:20.529146Z","steps":["trace[1353356309] 'process raft request' (duration: 173.138174ms)","trace[1353356309] 'compare' (duration: 16.902686ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:44:20.529449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.882895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-08-05T21:44:20.529474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.772554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:44:20.529544Z","caller":"traceutil/trace.go:171","msg":"trace[245711242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2102; }","duration":"116.914687ms","start":"2026-08-05T21:44:20.41261Z","end":"2026-08-05T21:44:20.529525Z","steps":["trace[245711242] 'agreement among raft nodes before linearized reading' (duration: 116.769984ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:44:20.529542Z","caller":"traceutil/trace.go:171","msg":"trace[1617862626] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"177.048029ms","start":"2026-08-05T21:44:20.35247Z","end":"2026-08-05T21:44:20.529518Z","steps":["trace[1617862626] 'agreement among raft nodes before linearized reading' (duration: 176.759403ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:44:26.486418Z","caller":"traceutil/trace.go:171","msg":"trace[1814648390] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"121.052249ms","start":"2026-08-05T21:44:26.365345Z","end":"2026-08-05T21:44:26.486397Z","steps":["trace[1814648390] 'process raft request' (duration: 120.651521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:44:26.692677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.956209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-08-05T21:44:26.692729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.176619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-08-05T21:44:26.692922Z","caller":"traceutil/trace.go:171","msg":"trace[1389222015] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2131; }","duration":"116.220424ms","start":"2026-08-05T21:44:26.576595Z","end":"2026-08-05T21:44:26.692815Z","steps":["trace[1389222015] 'range keys from in-memory index tree' (duration: 115.610622ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:44:26.692869Z","caller":"traceutil/trace.go:171","msg":"trace[414004252] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2131; }","duration":"136.379573ms","start":"2026-08-05T21:44:26.556459Z","end":"2026-08-05T21:44:26.692838Z","steps":["trace[414004252] 'range keys from in-memory index tree' (duration: 135.889653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:45:16.59216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.715777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:45:16.592292Z","caller":"traceutil/trace.go:171","msg":"trace[1613534174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2575; }","duration":"180.945271ms","start":"2026-08-05T21:45:16.411322Z","end":"2026-08-05T21:45:16.592268Z","steps":["trace[1613534174] 'range keys from in-memory index tree' (duration: 180.520943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:45:51.810432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.255992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-05T21:45:51.810527Z","caller":"traceutil/trace.go:171","msg":"trace[1408170744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2784; }","duration":"113.412305ms","start":"2026-08-05T21:45:51.697098Z","end":"2026-08-05T21:45:51.81051Z","steps":["trace[1408170744] 'range keys from in-memory index tree' (duration: 113.042128ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:48:27.49317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.948082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-05T21:48:27.493329Z","caller":"traceutil/trace.go:171","msg":"trace[409441739] transaction","detail":"{read_only:false; response_revision:3806; number_of_response:1; }","duration":"241.886356ms","start":"2026-08-05T21:48:27.251369Z","end":"2026-08-05T21:48:27.493255Z","steps":["trace[409441739] 'process raft request' (duration: 113.386573ms)","trace[409441739] 'compare' (duration: 127.84682ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:48:27.521905Z","caller":"traceutil/trace.go:171","msg":"trace[488278331] transaction","detail":"{read_only:false; response_revision:3807; number_of_response:1; }","duration":"151.907494ms","start":"2026-08-05T21:48:27.369974Z","end":"2026-08-05T21:48:27.521882Z","steps":["trace[488278331] 'process raft request' (duration: 151.784641ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:48:57.614843Z","caller":"traceutil/trace.go:171","msg":"trace[106469463] linearizableReadLoop","detail":"{readStateIndex:4134; appliedIndex:4133; }","duration":"203.070979ms","start":"2026-08-05T21:48:57.41174Z","end":"2026-08-05T21:48:57.614811Z","steps":["trace[106469463] 'read index received' (duration: 202.950806ms)","trace[106469463] 'applied index is now lower than readState.Index' (duration: 118.603µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:48:57.61488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:48:57.197107Z","time spent":"417.765552ms","remote":"127.0.0.1:50340","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-05T21:48:57.615028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.293693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T21:48:57.615111Z","caller":"traceutil/trace.go:171","msg":"trace[74007420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3979; }","duration":"203.442026ms","start":"2026-08-05T21:48:57.411653Z","end":"2026-08-05T21:48:57.615095Z","steps":["trace[74007420] 'agreement among raft nodes before linearized reading' (duration: 203.283513ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:48:57.615219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.314993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-05T21:48:57.615276Z","caller":"traceutil/trace.go:171","msg":"trace[432103472] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3979; }","duration":"124.420094ms","start":"2026-08-05T21:48:57.490842Z","end":"2026-08-05T21:48:57.615263Z","steps":["trace[432103472] 'agreement among raft nodes before linearized reading' (duration: 124.20867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:49:54.339407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.99403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-08-05T21:49:54.339559Z","caller":"traceutil/trace.go:171","msg":"trace[1087962765] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5028; }","duration":"120.255096ms","start":"2026-08-05T21:49:54.219278Z","end":"2026-08-05T21:49:54.339533Z","steps":["trace[1087962765] 'range keys from in-memory index tree' (duration: 119.682414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:49:54.340173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.535205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786936"} {"level":"info","ts":"2026-08-05T21:49:54.3403Z","caller":"traceutil/trace.go:171","msg":"trace[1109683883] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5028; }","duration":"114.712529ms","start":"2026-08-05T21:49:54.225562Z","end":"2026-08-05T21:49:54.340274Z","steps":["trace[1109683883] 'range keys from in-memory index tree' (duration: 113.810071ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:54.871654Z","caller":"traceutil/trace.go:171","msg":"trace[1850278619] linearizableReadLoop","detail":"{readStateIndex:5223; appliedIndex:5222; }","duration":"150.68ms","start":"2026-08-05T21:49:54.720941Z","end":"2026-08-05T21:49:54.871621Z","steps":["trace[1850278619] 'read index received' (duration: 150.363504ms)","trace[1850278619] 'applied index is now lower than readState.Index' (duration: 314.786µs)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:49:54.872019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.047498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-05T21:49:54.87231Z","caller":"traceutil/trace.go:171","msg":"trace[14223250] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"183.464791ms","start":"2026-08-05T21:49:54.688261Z","end":"2026-08-05T21:49:54.871726Z","steps":["trace[14223250] 'process raft request' (duration: 183.035913ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:54.872427Z","caller":"traceutil/trace.go:171","msg":"trace[1210741592] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5030; }","duration":"151.18925ms","start":"2026-08-05T21:49:54.720864Z","end":"2026-08-05T21:49:54.872053Z","steps":["trace[1210741592] 'agreement among raft nodes before linearized reading' (duration: 150.880755ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:54.998661Z","caller":"traceutil/trace.go:171","msg":"trace[1654697508] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"149.244353ms","start":"2026-08-05T21:49:54.849379Z","end":"2026-08-05T21:49:54.998624Z","steps":["trace[1654697508] 'process raft request' (duration: 149.147411ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:54.998722Z","caller":"traceutil/trace.go:171","msg":"trace[1698027321] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"202.726902ms","start":"2026-08-05T21:49:54.795952Z","end":"2026-08-05T21:49:54.998679Z","steps":["trace[1698027321] 'process raft request' (duration: 202.388196ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:55.032Z","caller":"traceutil/trace.go:171","msg":"trace[326656973] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5223; }","duration":"150.779593ms","start":"2026-08-05T21:49:54.881197Z","end":"2026-08-05T21:49:55.031976Z","steps":["trace[326656973] 'read index received' (duration: 117.227587ms)","trace[326656973] 'applied index is now lower than readState.Index' (duration: 33.551136ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:49:55.032144Z","caller":"traceutil/trace.go:171","msg":"trace[984389603] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"151.381734ms","start":"2026-08-05T21:49:54.880741Z","end":"2026-08-05T21:49:55.032122Z","steps":["trace[984389603] 'process raft request' (duration: 151.16753ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:55.032137Z","caller":"traceutil/trace.go:171","msg":"trace[587209151] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"151.945235ms","start":"2026-08-05T21:49:54.880134Z","end":"2026-08-05T21:49:55.032079Z","steps":["trace[587209151] 'process raft request' (duration: 151.725971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:49:55.032231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.026087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d00c579c-098a-461c-a70f-1f5d6676d7d2\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-05T21:49:55.032285Z","caller":"traceutil/trace.go:171","msg":"trace[1258473807] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d00c579c-098a-461c-a70f-1f5d6676d7d2; range_end:; response_count:1; response_revision:5036; }","duration":"151.11741ms","start":"2026-08-05T21:49:54.881153Z","end":"2026-08-05T21:49:55.032271Z","steps":["trace[1258473807] 'agreement among raft nodes before linearized reading' (duration: 150.911566ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:49:55.032211Z","caller":"traceutil/trace.go:171","msg":"trace[684291494] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"153.830572ms","start":"2026-08-05T21:49:54.87835Z","end":"2026-08-05T21:49:55.03218Z","steps":["trace[684291494] 'process raft request' (duration: 153.393214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:50:15.645853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.714279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-05T21:50:15.645959Z","caller":"traceutil/trace.go:171","msg":"trace[859933584] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5467; }","duration":"101.866302ms","start":"2026-08-05T21:50:15.54407Z","end":"2026-08-05T21:50:15.645936Z","steps":["trace[859933584] 'range keys from in-memory index tree' (duration: 101.538936ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:50:15.908275Z","caller":"traceutil/trace.go:171","msg":"trace[206149543] transaction","detail":"{read_only:false; response_revision:5469; number_of_response:1; }","duration":"253.751778ms","start":"2026-08-05T21:50:15.65448Z","end":"2026-08-05T21:50:15.908232Z","steps":["trace[206149543] 'process raft request' (duration: 190.559621ms)","trace[206149543] 'compare' (duration: 62.870321ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:50:15.90864Z","caller":"traceutil/trace.go:171","msg":"trace[1888082608] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"253.134467ms","start":"2026-08-05T21:50:15.655468Z","end":"2026-08-05T21:50:15.908603Z","steps":["trace[1888082608] 'process raft request' (duration: 252.713528ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:50:15.908932Z","caller":"traceutil/trace.go:171","msg":"trace[734470530] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"253.230009ms","start":"2026-08-05T21:50:15.655656Z","end":"2026-08-05T21:50:15.908886Z","steps":["trace[734470530] 'process raft request' (duration: 252.793931ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:50:16.075473Z","caller":"traceutil/trace.go:171","msg":"trace[1448449457] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"154.025847ms","start":"2026-08-05T21:50:15.921388Z","end":"2026-08-05T21:50:16.075413Z","steps":["trace[1448449457] 'process raft request' (duration: 129.73288ms)","trace[1448449457] 'compare' (duration: 23.579214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:50:18.142312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.909772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-05T21:50:18.142441Z","caller":"traceutil/trace.go:171","msg":"trace[941824010] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5503; }","duration":"103.098156ms","start":"2026-08-05T21:50:18.039308Z","end":"2026-08-05T21:50:18.142406Z","steps":["trace[941824010] 'range keys from in-memory index tree' (duration: 102.645618ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:50:26.87617Z","caller":"traceutil/trace.go:171","msg":"trace[974238818] transaction","detail":"{read_only:false; response_revision:5594; number_of_response:1; }","duration":"113.097139ms","start":"2026-08-05T21:50:26.763033Z","end":"2026-08-05T21:50:26.87613Z","steps":["trace[974238818] 'process raft request' (duration: 112.950536ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:51:08.746274Z","caller":"traceutil/trace.go:171","msg":"trace[245098356] transaction","detail":"{read_only:false; response_revision:5949; number_of_response:1; }","duration":"106.154526ms","start":"2026-08-05T21:51:08.640077Z","end":"2026-08-05T21:51:08.746232Z","steps":["trace[245098356] 'process raft request' (duration: 92.139536ms)","trace[245098356] 'compare' (duration: 13.749555ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:51:24.01139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-08-05T21:51:24.092281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"79.015053ms","hash":1700821136,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":33632256,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-05T21:51:24.092359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1700821136,"revision":2962,"compact-revision":-1} {"level":"info","ts":"2026-08-05T21:56:24.018478Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6068} {"level":"info","ts":"2026-08-05T21:56:24.111024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6068,"took":"90.697396ms","hash":2706150776,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":21659648,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-05T21:56:24.111119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2706150776,"revision":6068,"compact-revision":2962} {"level":"info","ts":"2026-08-05T21:56:40.712021Z","caller":"traceutil/trace.go:171","msg":"trace[1329069066] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"354.003685ms","start":"2026-08-05T21:56:40.357977Z","end":"2026-08-05T21:56:40.711981Z","steps":["trace[1329069066] 'process raft request' (duration: 353.748399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:56:40.712263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:56:40.357959Z","time spent":"354.163849ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:56:40.849128Z","caller":"traceutil/trace.go:171","msg":"trace[1347118749] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"490.571656ms","start":"2026-08-05T21:56:40.358521Z","end":"2026-08-05T21:56:40.849093Z","steps":["trace[1347118749] 'process raft request' (duration: 464.482445ms)","trace[1347118749] 'compare' (duration: 25.821036ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:56:40.849351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:56:40.358467Z","time spent":"490.76471ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:56:43.555552Z","caller":"traceutil/trace.go:171","msg":"trace[1030797272] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"103.420435ms","start":"2026-08-05T21:56:43.452098Z","end":"2026-08-05T21:56:43.555519Z","steps":["trace[1030797272] 'process raft request' (duration: 102.67645ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:11.32942Z","caller":"traceutil/trace.go:171","msg":"trace[1532718609] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"309.133984ms","start":"2026-08-05T21:57:11.020251Z","end":"2026-08-05T21:57:11.329385Z","steps":["trace[1532718609] 'process raft request' (duration: 308.91478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:57:11.329837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:57:11.020215Z","time spent":"309.322227ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-05T21:57:11.482514Z","caller":"traceutil/trace.go:171","msg":"trace[48299628] linearizableReadLoop","detail":"{readStateIndex:8897; appliedIndex:8895; }","duration":"409.9822ms","start":"2026-08-05T21:57:11.072497Z","end":"2026-08-05T21:57:11.482479Z","steps":["trace[48299628] 'read index received' (duration: 256.692828ms)","trace[48299628] 'applied index is now lower than readState.Index' (duration: 153.287542ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:57:11.48287Z","caller":"traceutil/trace.go:171","msg":"trace[253318911] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"455.110415ms","start":"2026-08-05T21:57:11.027744Z","end":"2026-08-05T21:57:11.482854Z","steps":["trace[253318911] 'process raft request' (duration: 440.897423ms)","trace[253318911] 'compare' (duration: 13.524409ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T21:57:11.483016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:57:11.027711Z","time spent":"455.205318ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T21:57:11.483338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.850906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-05T21:57:11.483488Z","caller":"traceutil/trace.go:171","msg":"trace[977779945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8590; }","duration":"411.000539ms","start":"2026-08-05T21:57:11.072427Z","end":"2026-08-05T21:57:11.483428Z","steps":["trace[977779945] 'agreement among raft nodes before linearized reading' (duration: 410.788045ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:57:11.483567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:57:11.072399Z","time spent":"411.127701ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-05T21:57:11.48389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.362046ms","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-08-05T21:57:11.483964Z","caller":"traceutil/trace.go:171","msg":"trace[369533708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8590; }","duration":"410.453038ms","start":"2026-08-05T21:57:11.0735Z","end":"2026-08-05T21:57:11.483953Z","steps":["trace[369533708] 'agreement among raft nodes before linearized reading' (duration: 410.283555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:57:11.484006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T21:57:11.073492Z","time spent":"410.504979ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-05T21:57:11.484859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.458401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cs8df\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-08-05T21:57:11.48495Z","caller":"traceutil/trace.go:171","msg":"trace[275104682] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cs8df; range_end:; response_count:1; response_revision:8590; }","duration":"220.601065ms","start":"2026-08-05T21:57:11.264334Z","end":"2026-08-05T21:57:11.484935Z","steps":["trace[275104682] 'agreement among raft nodes before linearized reading' (duration: 220.365009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T21:57:13.767675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.842239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-05T21:57:13.767767Z","caller":"traceutil/trace.go:171","msg":"trace[1707642539] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8602; }","duration":"107.984682ms","start":"2026-08-05T21:57:13.65976Z","end":"2026-08-05T21:57:13.767744Z","steps":["trace[1707642539] 'range keys from in-memory index tree' (duration: 107.665526ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:23.851909Z","caller":"traceutil/trace.go:171","msg":"trace[444512291] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"141.966785ms","start":"2026-08-05T21:57:23.709893Z","end":"2026-08-05T21:57:23.85186Z","steps":["trace[444512291] 'process raft request' (duration: 91.049428ms)","trace[444512291] 'compare' (duration: 50.761504ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T21:57:23.856715Z","caller":"traceutil/trace.go:171","msg":"trace[1384951686] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8697; }","duration":"145.9198ms","start":"2026-08-05T21:57:23.710738Z","end":"2026-08-05T21:57:23.856658Z","steps":["trace[1384951686] 'process raft request' (duration: 145.663035ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:25.450888Z","caller":"traceutil/trace.go:171","msg":"trace[753989477] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"123.362908ms","start":"2026-08-05T21:57:25.327492Z","end":"2026-08-05T21:57:25.450854Z","steps":["trace[753989477] 'process raft request' (duration: 123.185665ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:25.57569Z","caller":"traceutil/trace.go:171","msg":"trace[200217331] transaction","detail":"{read_only:false; response_revision:8709; number_of_response:1; }","duration":"107.309829ms","start":"2026-08-05T21:57:25.468353Z","end":"2026-08-05T21:57:25.575663Z","steps":["trace[200217331] 'process raft request' (duration: 107.179717ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T21:57:40.943559Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002400.wal"} {"level":"info","ts":"2026-08-05T21:59:09.675858Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"197930edc5411b2e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-05T21:59:09.682184Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-05T21:59:09.682303Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-05T22:01:24.027003Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8154} {"level":"info","ts":"2026-08-05T22:01:24.094351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8154,"took":"64.944403ms","hash":2869774504,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":29642752,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-05T22:01:24.094418Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2869774504,"revision":8154,"compact-revision":6068} {"level":"info","ts":"2026-08-05T22:06:24.03283Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10767} {"level":"info","ts":"2026-08-05T22:06:24.111403Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10767,"took":"75.655819ms","hash":430267773,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":27267072,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-05T22:06:24.111481Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":430267773,"revision":10767,"compact-revision":8154} {"level":"warn","ts":"2026-08-05T22:08:56.443213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.943577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-p5sdq\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-08-05T22:08:56.443324Z","caller":"traceutil/trace.go:171","msg":"trace[706075256] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-p5sdq; range_end:; response_count:1; response_revision:13961; }","duration":"129.12119ms","start":"2026-08-05T22:08:56.31418Z","end":"2026-08-05T22:08:56.443301Z","steps":["trace[706075256] 'range keys from in-memory index tree' (duration: 128.688672ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:08:56.639502Z","caller":"traceutil/trace.go:171","msg":"trace[1717311942] transaction","detail":"{read_only:false; response_revision:13962; number_of_response:1; }","duration":"183.003979ms","start":"2026-08-05T22:08:56.456454Z","end":"2026-08-05T22:08:56.639458Z","steps":["trace[1717311942] 'process raft request' (duration: 182.732514ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:09:18.968926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.773155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-05T22:09:18.969065Z","caller":"traceutil/trace.go:171","msg":"trace[253674281] linearizableReadLoop","detail":"{readStateIndex:14769; appliedIndex:14768; }","duration":"147.877392ms","start":"2026-08-05T22:09:18.821167Z","end":"2026-08-05T22:09:18.969045Z","steps":["trace[253674281] 'read index received' (duration: 19.849483ms)","trace[253674281] 'applied index is now lower than readState.Index' (duration: 128.026689ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:09:18.969163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.999344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T22:09:18.969199Z","caller":"traceutil/trace.go:171","msg":"trace[2117906162] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:14275; }","duration":"148.088526ms","start":"2026-08-05T22:09:18.821101Z","end":"2026-08-05T22:09:18.96919Z","steps":["trace[2117906162] 'agreement among raft nodes before linearized reading' (duration: 147.994214ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:09:18.969428Z","caller":"traceutil/trace.go:171","msg":"trace[2022416853] transaction","detail":"{read_only:false; response_revision:14275; number_of_response:1; }","duration":"202.896062ms","start":"2026-08-05T22:09:18.766505Z","end":"2026-08-05T22:09:18.969401Z","steps":["trace[2022416853] 'process raft request' (duration: 74.545077ms)","trace[2022416853] 'compare' (duration: 127.639372ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:10:44.603642Z","caller":"traceutil/trace.go:171","msg":"trace[791826392] linearizableReadLoop","detail":"{readStateIndex:15595; appliedIndex:15594; }","duration":"138.699015ms","start":"2026-08-05T22:10:44.464918Z","end":"2026-08-05T22:10:44.603617Z","steps":["trace[791826392] 'read index received' (duration: 138.662914ms)","trace[791826392] 'applied index is now lower than readState.Index' (duration: 34.471µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:10:44.603734Z","caller":"traceutil/trace.go:171","msg":"trace[1731992182] transaction","detail":"{read_only:false; response_revision:15078; number_of_response:1; }","duration":"148.597215ms","start":"2026-08-05T22:10:44.45507Z","end":"2026-08-05T22:10:44.603667Z","steps":["trace[1731992182] 'process raft request' (duration: 148.36369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.603798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.868469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T22:10:44.604179Z","caller":"traceutil/trace.go:171","msg":"trace[443750705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15078; }","duration":"139.262246ms","start":"2026-08-05T22:10:44.464897Z","end":"2026-08-05T22:10:44.604159Z","steps":["trace[443750705] 'agreement among raft nodes before linearized reading' (duration: 138.829088ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:44.805298Z","caller":"traceutil/trace.go:171","msg":"trace[1588361833] linearizableReadLoop","detail":"{readStateIndex:15596; appliedIndex:15595; }","duration":"201.540957ms","start":"2026-08-05T22:10:44.60373Z","end":"2026-08-05T22:10:44.805271Z","steps":["trace[1588361833] 'read index received' (duration: 180.858987ms)","trace[1588361833] 'applied index is now lower than readState.Index' (duration: 20.68073ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:10:44.805426Z","caller":"traceutil/trace.go:171","msg":"trace[1272138467] transaction","detail":"{read_only:false; response_revision:15079; number_of_response:1; }","duration":"224.58147ms","start":"2026-08-05T22:10:44.580831Z","end":"2026-08-05T22:10:44.805413Z","steps":["trace[1272138467] 'process raft request' (duration: 203.793589ms)","trace[1272138467] 'compare' (duration: 20.106418ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:10:44.805765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.452416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-05T22:10:44.805829Z","caller":"traceutil/trace.go:171","msg":"trace[2024156853] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15079; }","duration":"228.562158ms","start":"2026-08-05T22:10:44.577252Z","end":"2026-08-05T22:10:44.805814Z","steps":["trace[2024156853] 'agreement among raft nodes before linearized reading' (duration: 228.334204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.80607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.526519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-08-05T22:10:44.806109Z","caller":"traceutil/trace.go:171","msg":"trace[955358572] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15079; }","duration":"224.594821ms","start":"2026-08-05T22:10:44.581504Z","end":"2026-08-05T22:10:44.806099Z","steps":["trace[955358572] 'agreement among raft nodes before linearized reading' (duration: 224.492039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.806113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.842414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-08-05T22:10:44.806157Z","caller":"traceutil/trace.go:171","msg":"trace[651830661] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:15079; }","duration":"268.930606ms","start":"2026-08-05T22:10:44.537214Z","end":"2026-08-05T22:10:44.806144Z","steps":["trace[651830661] 'agreement among raft nodes before linearized reading' (duration: 268.719592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.806177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.736731ms","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-08-05T22:10:44.806444Z","caller":"traceutil/trace.go:171","msg":"trace[131787939] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15079; }","duration":"229.052977ms","start":"2026-08-05T22:10:44.577359Z","end":"2026-08-05T22:10:44.806412Z","steps":["trace[131787939] 'agreement among raft nodes before linearized reading' (duration: 228.6559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.806488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.464659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-8tm56\" ","response":"range_response_count:1 size:20660"} {"level":"warn","ts":"2026-08-05T22:10:44.806911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.409884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-08-05T22:10:44.806855Z","caller":"traceutil/trace.go:171","msg":"trace[481331225] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-8tm56; range_end:; response_count:1; response_revision:15079; }","duration":"264.849346ms","start":"2026-08-05T22:10:44.541994Z","end":"2026-08-05T22:10:44.806843Z","steps":["trace[481331225] 'agreement among raft nodes before linearized reading' (duration: 264.402618ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:44.806964Z","caller":"traceutil/trace.go:171","msg":"trace[385407102] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15079; }","duration":"229.525726ms","start":"2026-08-05T22:10:44.577426Z","end":"2026-08-05T22:10:44.806952Z","steps":["trace[385407102] 'agreement among raft nodes before linearized reading' (duration: 229.388574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.805674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.552248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T22:10:44.807612Z","caller":"traceutil/trace.go:171","msg":"trace[14058168] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15079; }","duration":"230.552906ms","start":"2026-08-05T22:10:44.577047Z","end":"2026-08-05T22:10:44.8076Z","steps":["trace[14058168] 'agreement among raft nodes before linearized reading' (duration: 228.576868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.977993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.404913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-05T22:10:44.978081Z","caller":"traceutil/trace.go:171","msg":"trace[625308845] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15080; }","duration":"230.539365ms","start":"2026-08-05T22:10:44.747524Z","end":"2026-08-05T22:10:44.978063Z","steps":["trace[625308845] 'agreement among raft nodes before linearized reading' (duration: 230.28709ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:44.978177Z","caller":"traceutil/trace.go:171","msg":"trace[433211840] linearizableReadLoop","detail":"{readStateIndex:15597; appliedIndex:15596; }","duration":"172.371243ms","start":"2026-08-05T22:10:44.805378Z","end":"2026-08-05T22:10:44.97775Z","steps":["trace[433211840] 'read index received' (duration: 163.822438ms)","trace[433211840] 'applied index is now lower than readState.Index' (duration: 8.547915ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:10:44.978201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.96074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-05T22:10:44.978428Z","caller":"traceutil/trace.go:171","msg":"trace[2037430847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15080; }","duration":"333.247616ms","start":"2026-08-05T22:10:44.645164Z","end":"2026-08-05T22:10:44.978411Z","steps":["trace[2037430847] 'agreement among raft nodes before linearized reading' (duration: 332.868848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.978469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:10:44.645142Z","time spent":"333.314747ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-05T22:10:44.978551Z","caller":"traceutil/trace.go:171","msg":"trace[1638327147] transaction","detail":"{read_only:false; response_revision:15080; number_of_response:1; }","duration":"249.732657ms","start":"2026-08-05T22:10:44.728796Z","end":"2026-08-05T22:10:44.978528Z","steps":["trace[1638327147] 'process raft request' (duration: 240.418836ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:44.985438Z","caller":"traceutil/trace.go:171","msg":"trace[1512531711] transaction","detail":"{read_only:false; response_revision:15081; number_of_response:1; }","duration":"174.357042ms","start":"2026-08-05T22:10:44.811017Z","end":"2026-08-05T22:10:44.985374Z","steps":["trace[1512531711] 'process raft request' (duration: 174.119058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:44.985975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.465795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:77 size:744325"} {"level":"info","ts":"2026-08-05T22:10:44.986094Z","caller":"traceutil/trace.go:171","msg":"trace[1983626655] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:77; response_revision:15081; }","duration":"173.549257ms","start":"2026-08-05T22:10:44.812481Z","end":"2026-08-05T22:10:44.986031Z","steps":["trace[1983626655] 'agreement among raft nodes before linearized reading' (duration: 172.749842ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:45.171972Z","caller":"traceutil/trace.go:171","msg":"trace[1424588743] linearizableReadLoop","detail":"{readStateIndex:15600; appliedIndex:15598; }","duration":"177.544834ms","start":"2026-08-05T22:10:44.994402Z","end":"2026-08-05T22:10:45.171947Z","steps":["trace[1424588743] 'read index received' (duration: 49.734019ms)","trace[1424588743] 'applied index is now lower than readState.Index' (duration: 127.809835ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:10:45.172118Z","caller":"traceutil/trace.go:171","msg":"trace[749509271] transaction","detail":"{read_only:false; response_revision:15083; number_of_response:1; }","duration":"182.824626ms","start":"2026-08-05T22:10:44.989249Z","end":"2026-08-05T22:10:45.172073Z","steps":["trace[749509271] 'process raft request' (duration: 168.945528ms)","trace[749509271] 'compare' (duration: 13.638903ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:10:45.172174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.737198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-05T22:10:45.172227Z","caller":"traceutil/trace.go:171","msg":"trace[218458776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:15083; }","duration":"177.828939ms","start":"2026-08-05T22:10:44.994382Z","end":"2026-08-05T22:10:45.172211Z","steps":["trace[218458776] 'agreement among raft nodes before linearized reading' (duration: 177.690677ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:45.30955Z","caller":"traceutil/trace.go:171","msg":"trace[1227838899] linearizableReadLoop","detail":"{readStateIndex:15601; appliedIndex:15600; }","duration":"137.480621ms","start":"2026-08-05T22:10:45.172029Z","end":"2026-08-05T22:10:45.30951Z","steps":["trace[1227838899] 'read index received' (duration: 124.235555ms)","trace[1227838899] 'applied index is now lower than readState.Index' (duration: 13.243476ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:10:45.309857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.354792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18677"} {"level":"warn","ts":"2026-08-05T22:10:45.309888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.536944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vzcbr\" ","response":"range_response_count:1 size:22132"} {"level":"info","ts":"2026-08-05T22:10:45.309927Z","caller":"traceutil/trace.go:171","msg":"trace[642830840] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:15084; }","duration":"315.462283ms","start":"2026-08-05T22:10:44.994452Z","end":"2026-08-05T22:10:45.309915Z","steps":["trace[642830840] 'agreement among raft nodes before linearized reading' (duration: 315.186698ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:45.309956Z","caller":"traceutil/trace.go:171","msg":"trace[127672848] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vzcbr; range_end:; response_count:1; response_revision:15084; }","duration":"191.630196ms","start":"2026-08-05T22:10:45.118307Z","end":"2026-08-05T22:10:45.309938Z","steps":["trace[127672848] 'agreement among raft nodes before linearized reading' (duration: 191.377091ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:45.309978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:10:44.994446Z","time spent":"315.521774ms","remote":"127.0.0.1:50504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":18700,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" "} {"level":"warn","ts":"2026-08-05T22:10:45.309991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.705526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-05T22:10:45.310101Z","caller":"traceutil/trace.go:171","msg":"trace[247013833] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15084; }","duration":"150.852969ms","start":"2026-08-05T22:10:45.159226Z","end":"2026-08-05T22:10:45.310078Z","steps":["trace[247013833] 'agreement among raft nodes before linearized reading' (duration: 150.4216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:45.310299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.721794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-08-05T22:10:45.310341Z","caller":"traceutil/trace.go:171","msg":"trace[1818680461] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15084; }","duration":"211.801624ms","start":"2026-08-05T22:10:45.098529Z","end":"2026-08-05T22:10:45.310331Z","steps":["trace[1818680461] 'agreement among raft nodes before linearized reading' (duration: 211.687052ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:45.310328Z","caller":"traceutil/trace.go:171","msg":"trace[899802364] transaction","detail":"{read_only:false; response_revision:15084; number_of_response:1; }","duration":"239.805714ms","start":"2026-08-05T22:10:45.07047Z","end":"2026-08-05T22:10:45.310276Z","steps":["trace[899802364] 'process raft request' (duration: 225.686932ms)","trace[899802364] 'compare' (duration: 13.169894ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:10:45.310633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.213517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-08-05T22:10:45.310677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.898717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vzcbr\" ","response":"range_response_count:1 size:22132"} {"level":"info","ts":"2026-08-05T22:10:45.310748Z","caller":"traceutil/trace.go:171","msg":"trace[2017786968] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15084; }","duration":"149.37466ms","start":"2026-08-05T22:10:45.161346Z","end":"2026-08-05T22:10:45.310721Z","steps":["trace[2017786968] 'agreement among raft nodes before linearized reading' (duration: 149.010183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:10:45.310767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.228115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-05T22:10:45.310811Z","caller":"traceutil/trace.go:171","msg":"trace[478829177] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vzcbr; range_end:; response_count:1; response_revision:15084; }","duration":"224.100221ms","start":"2026-08-05T22:10:45.086683Z","end":"2026-08-05T22:10:45.310783Z","steps":["trace[478829177] 'agreement among raft nodes before linearized reading' (duration: 223.706183ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:10:45.310871Z","caller":"traceutil/trace.go:171","msg":"trace[1647722972] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15084; }","duration":"152.382948ms","start":"2026-08-05T22:10:45.158463Z","end":"2026-08-05T22:10:45.310846Z","steps":["trace[1647722972] 'agreement among raft nodes before linearized reading' (duration: 151.735656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:11:06.49368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.140553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-05T22:11:06.493836Z","caller":"traceutil/trace.go:171","msg":"trace[622427119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15190; }","duration":"125.364198ms","start":"2026-08-05T22:11:06.368452Z","end":"2026-08-05T22:11:06.493816Z","steps":["trace[622427119] 'range keys from in-memory index tree' (duration: 124.98433ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:11:24.039896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12882} {"level":"info","ts":"2026-08-05T22:11:24.116603Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12882,"took":"73.224812ms","hash":3295848242,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":30208000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-05T22:11:24.116678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3295848242,"revision":12882,"compact-revision":10767} {"level":"info","ts":"2026-08-05T22:16:24.04784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15316} {"level":"warn","ts":"2026-08-05T22:16:24.322712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.24811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-05T22:16:24.323083Z","caller":"traceutil/trace.go:171","msg":"trace[1037359988] transaction","detail":"{read_only:false; response_revision:17625; number_of_response:1; }","duration":"130.525019ms","start":"2026-08-05T22:16:24.192527Z","end":"2026-08-05T22:16:24.323052Z","steps":["trace[1037359988] 'process raft request' (duration: 130.396407ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:16:24.323109Z","caller":"traceutil/trace.go:171","msg":"trace[1642626802] transaction","detail":"{read_only:false; response_revision:17624; number_of_response:1; }","duration":"229.824055ms","start":"2026-08-05T22:16:24.09322Z","end":"2026-08-05T22:16:24.323044Z","steps":["trace[1642626802] 'process raft request' (duration: 23.147897ms)","trace[1642626802] 'compare' (duration: 180.34352ms)","trace[1642626802] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:487; } (duration: 25.778277ms)"],"step_count":3} {"level":"info","ts":"2026-08-05T22:16:24.38734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15316,"took":"335.894961ms","hash":947650050,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":31932416,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-05T22:16:24.38747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":947650050,"revision":15316,"compact-revision":12882} {"level":"info","ts":"2026-08-05T22:19:53.562213Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"197930edc5411b2e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-05T22:19:53.575054Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-05T22:19:53.575357Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-05T22:21:24.066504Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17623} {"level":"info","ts":"2026-08-05T22:21:24.168451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17623,"took":"98.880188ms","hash":2699580238,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":34566144,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-05T22:21:24.168555Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2699580238,"revision":17623,"compact-revision":15316} {"level":"warn","ts":"2026-08-05T22:22:03.368992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.881369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-05T22:22:03.369183Z","caller":"traceutil/trace.go:171","msg":"trace[334298338] linearizableReadLoop","detail":"{readStateIndex:20952; appliedIndex:20951; }","duration":"251.051563ms","start":"2026-08-05T22:22:03.118114Z","end":"2026-08-05T22:22:03.369165Z","steps":["trace[334298338] 'read index received' (duration: 27.900628ms)","trace[334298338] 'applied index is now lower than readState.Index' (duration: 223.149394ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:22:03.369246Z","caller":"traceutil/trace.go:171","msg":"trace[1312191278] transaction","detail":"{read_only:false; response_revision:20266; number_of_response:1; }","duration":"353.559799ms","start":"2026-08-05T22:22:03.015646Z","end":"2026-08-05T22:22:03.369205Z","steps":["trace[1312191278] 'process raft request' (duration: 130.354904ms)","trace[1312191278] 'compare' (duration: 222.657495ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:22:03.369423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:22:03.015575Z","time spent":"353.759073ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-05T22:22:03.369438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.309498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-08-05T22:22:03.369542Z","caller":"traceutil/trace.go:171","msg":"trace[336868241] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:20266; }","duration":"251.44859ms","start":"2026-08-05T22:22:03.118059Z","end":"2026-08-05T22:22:03.369508Z","steps":["trace[336868241] 'agreement among raft nodes before linearized reading' (duration: 251.169995ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:22:03.442327Z","caller":"traceutil/trace.go:171","msg":"trace[1687667707] transaction","detail":"{read_only:false; response_revision:20267; number_of_response:1; }","duration":"135.601075ms","start":"2026-08-05T22:22:03.306701Z","end":"2026-08-05T22:22:03.442302Z","steps":["trace[1687667707] 'process raft request' (duration: 135.479683ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:22:03.623786Z","caller":"traceutil/trace.go:171","msg":"trace[1956096072] linearizableReadLoop","detail":"{readStateIndex:20954; appliedIndex:20952; }","duration":"254.53532ms","start":"2026-08-05T22:22:03.36921Z","end":"2026-08-05T22:22:03.623746Z","steps":["trace[1956096072] 'read index received' (duration: 73.027999ms)","trace[1956096072] 'applied index is now lower than readState.Index' (duration: 181.506021ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:22:03.624212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.202586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9a5ffe9c-4d02-4fbe-bcd8-efd51511e1ac\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-08-05T22:22:03.62425Z","caller":"traceutil/trace.go:171","msg":"trace[1618564520] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9a5ffe9c-4d02-4fbe-bcd8-efd51511e1ac; range_end:; response_count:1; response_revision:20268; }","duration":"251.276356ms","start":"2026-08-05T22:22:03.372963Z","end":"2026-08-05T22:22:03.624239Z","steps":["trace[1618564520] 'agreement among raft nodes before linearized reading' (duration: 251.133404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:22:03.624227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.922803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-05T22:22:03.62432Z","caller":"traceutil/trace.go:171","msg":"trace[421074941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20268; }","duration":"415.108237ms","start":"2026-08-05T22:22:03.209194Z","end":"2026-08-05T22:22:03.624302Z","steps":["trace[421074941] 'agreement among raft nodes before linearized reading' (duration: 414.806001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:22:03.624368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:22:03.209143Z","time spent":"415.216169ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-05T22:22:03.624239Z","caller":"traceutil/trace.go:171","msg":"trace[1025390692] transaction","detail":"{read_only:false; response_revision:20268; number_of_response:1; }","duration":"310.493799ms","start":"2026-08-05T22:22:03.313715Z","end":"2026-08-05T22:22:03.624209Z","steps":["trace[1025390692] 'process raft request' (duration: 268.345426ms)","trace[1025390692] 'compare' (duration: 41.502201ms)"],"step_count":2} {"level":"warn","ts":"2026-08-05T22:22:03.624578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T22:22:03.313684Z","time spent":"310.826696ms","remote":"127.0.0.1:50592","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-08-05T22:22:03.624251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.893036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:22:03.624661Z","caller":"traceutil/trace.go:171","msg":"trace[507399477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20268; }","duration":"213.327865ms","start":"2026-08-05T22:22:03.411307Z","end":"2026-08-05T22:22:03.624635Z","steps":["trace[507399477] 'agreement among raft nodes before linearized reading' (duration: 212.867776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:22:03.920599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.79182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-05T22:22:03.920802Z","caller":"traceutil/trace.go:171","msg":"trace[90701567] transaction","detail":"{read_only:false; response_revision:20269; number_of_response:1; }","duration":"290.229618ms","start":"2026-08-05T22:22:03.630523Z","end":"2026-08-05T22:22:03.920752Z","steps":["trace[90701567] 'process raft request' (duration: 141.142942ms)","trace[90701567] 'compare' (duration: 148.173079ms)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:22:03.922611Z","caller":"traceutil/trace.go:171","msg":"trace[269274314] transaction","detail":"{read_only:false; response_revision:20270; number_of_response:1; }","duration":"258.049828ms","start":"2026-08-05T22:22:03.664541Z","end":"2026-08-05T22:22:03.922591Z","steps":["trace[269274314] 'process raft request' (duration: 257.850504ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:22:04.498263Z","caller":"traceutil/trace.go:171","msg":"trace[1797943024] transaction","detail":"{read_only:false; response_revision:20274; number_of_response:1; }","duration":"265.836238ms","start":"2026-08-05T22:22:04.2324Z","end":"2026-08-05T22:22:04.498236Z","steps":["trace[1797943024] 'process raft request' (duration: 265.696635ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:22:04.498262Z","caller":"traceutil/trace.go:171","msg":"trace[1767116400] transaction","detail":"{read_only:false; response_revision:20273; number_of_response:1; }","duration":"266.326296ms","start":"2026-08-05T22:22:04.231894Z","end":"2026-08-05T22:22:04.49822Z","steps":["trace[1767116400] 'process raft request' (duration: 266.058711ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:25:42.555916Z","caller":"traceutil/trace.go:171","msg":"trace[7249040] transaction","detail":"{read_only:false; response_revision:22223; number_of_response:1; }","duration":"148.102827ms","start":"2026-08-05T22:25:42.407788Z","end":"2026-08-05T22:25:42.555891Z","steps":["trace[7249040] 'process raft request' (duration: 141.785315ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:25:53.305749Z","caller":"traceutil/trace.go:171","msg":"trace[1265793738] linearizableReadLoop","detail":"{readStateIndex:23435; appliedIndex:23434; }","duration":"158.312523ms","start":"2026-08-05T22:25:53.147409Z","end":"2026-08-05T22:25:53.305721Z","steps":["trace[1265793738] 'read index received' (duration: 158.202201ms)","trace[1265793738] 'applied index is now lower than readState.Index' (duration: 108.812µs)"],"step_count":2} {"level":"info","ts":"2026-08-05T22:25:53.305924Z","caller":"traceutil/trace.go:171","msg":"trace[1240077656] transaction","detail":"{read_only:false; response_revision:22676; number_of_response:1; }","duration":"171.644121ms","start":"2026-08-05T22:25:53.134265Z","end":"2026-08-05T22:25:53.305909Z","steps":["trace[1240077656] 'process raft request' (duration: 171.277904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:25:53.306367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.922415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"} {"level":"info","ts":"2026-08-05T22:25:53.30658Z","caller":"traceutil/trace.go:171","msg":"trace[667708174] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22676; }","duration":"159.17388ms","start":"2026-08-05T22:25:53.147383Z","end":"2026-08-05T22:25:53.306557Z","steps":["trace[667708174] 'agreement among raft nodes before linearized reading' (duration: 158.68718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:25:53.336047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.051396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"} {"level":"warn","ts":"2026-08-05T22:25:53.336055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.685367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-05T22:25:53.336111Z","caller":"traceutil/trace.go:171","msg":"trace[98459206] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22677; }","duration":"175.132357ms","start":"2026-08-05T22:25:53.16096Z","end":"2026-08-05T22:25:53.336093Z","steps":["trace[98459206] 'agreement among raft nodes before linearized reading' (duration: 174.964194ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:25:53.336133Z","caller":"traceutil/trace.go:171","msg":"trace[1009489366] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:22677; }","duration":"149.824899ms","start":"2026-08-05T22:25:53.186289Z","end":"2026-08-05T22:25:53.336114Z","steps":["trace[1009489366] 'agreement among raft nodes before linearized reading' (duration: 149.690037ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:25:53.336306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.070451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:672"} {"level":"info","ts":"2026-08-05T22:25:53.336438Z","caller":"traceutil/trace.go:171","msg":"trace[2041365713] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22677; }","duration":"168.268666ms","start":"2026-08-05T22:25:53.168124Z","end":"2026-08-05T22:25:53.336392Z","steps":["trace[2041365713] 'agreement among raft nodes before linearized reading' (duration: 167.897619ms)"],"step_count":1} {"level":"warn","ts":"2026-08-05T22:25:53.336525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.333432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-05T22:25:53.336531Z","caller":"traceutil/trace.go:171","msg":"trace[977463004] transaction","detail":"{read_only:false; response_revision:22677; number_of_response:1; }","duration":"126.130243ms","start":"2026-08-05T22:25:53.21033Z","end":"2026-08-05T22:25:53.33646Z","steps":["trace[977463004] 'process raft request' (duration: 125.44398ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:25:53.336584Z","caller":"traceutil/trace.go:171","msg":"trace[1023919540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22677; }","duration":"174.532206ms","start":"2026-08-05T22:25:53.162032Z","end":"2026-08-05T22:25:53.336564Z","steps":["trace[1023919540] 'agreement among raft nodes before linearized reading' (duration: 174.327032ms)"],"step_count":1} {"level":"info","ts":"2026-08-05T22:26:24.074232Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20067} {"level":"info","ts":"2026-08-05T22:26:24.188145Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20067,"took":"109.587904ms","hash":95959585,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":42369024,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-08-05T22:26:24.188219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":95959585,"revision":20067,"compact-revision":17623} {"level":"info","ts":"2026-08-05T22:31:24.080935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22981} {"level":"info","ts":"2026-08-05T22:31:24.212688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22981,"took":"127.74588ms","hash":1684181298,"current-db-size-bytes":58363904,"current-db-size":"58 MB","current-db-size-in-use-bytes":31334400,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-05T22:31:24.212765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1684181298,"revision":22981,"compact-revision":20067}