{"level":"warn","ts":"2026-08-10T22:22:08.445712Z","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-10T22:22:08.445812Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.116: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.116:2380","--initial-cluster=instance=https://199.19.213.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.116: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-10T22:22:08.445885Z","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-10T22:22:08.445902Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.116:2380"]} {"level":"info","ts":"2026-08-10T22:22:08.445926Z","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-10T22:22:08.446561Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"]} {"level":"info","ts":"2026-08-10T22:22:08.446638Z","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":8,"max-cpu-available":8,"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.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.116: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-10T22:22:08.451055Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.195046ms"} {"level":"info","ts":"2026-08-10T22:22:08.458864Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca739d563b259b56","cluster-id":"2052ec4484eed829"} {"level":"info","ts":"2026-08-10T22:22:08.458962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T22:22:08.458985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 0"} {"level":"info","ts":"2026-08-10T22:22:08.458996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca739d563b259b56 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T22:22:08.459011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 1"} {"level":"info","ts":"2026-08-10T22:22:08.459051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"} {"level":"warn","ts":"2026-08-10T22:22:08.464745Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T22:22:08.466239Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T22:22:08.467426Z","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-10T22:22:08.470799Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca739d563b259b56","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T22:22:08.470977Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca739d563b259b56","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T22:22:08.471049Z","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-10T22:22:08.47118Z","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-10T22:22:08.471206Z","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-10T22:22:08.472238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"} {"level":"info","ts":"2026-08-10T22:22:08.472491Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","added-peer-id":"ca739d563b259b56","added-peer-peer-urls":["https://199.19.213.116:2380"]} {"level":"info","ts":"2026-08-10T22:22:08.481463Z","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-10T22:22:08.481647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca739d563b259b56","initial-advertise-peer-urls":["https://199.19.213.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T22:22:08.481669Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T22:22:08.481768Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.116:2380"} {"level":"info","ts":"2026-08-10T22:22:08.481785Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.116:2380"} {"level":"info","ts":"2026-08-10T22:22:09.260273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T22:22:09.260323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T22:22:09.260354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgPreVoteResp from ca739d563b259b56 at term 1"} {"level":"info","ts":"2026-08-10T22:22:09.260373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became candidate at term 2"} {"level":"info","ts":"2026-08-10T22:22:09.260381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgVoteResp from ca739d563b259b56 at term 2"} {"level":"info","ts":"2026-08-10T22:22:09.260392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became leader at term 2"} {"level":"info","ts":"2026-08-10T22:22:09.260406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca739d563b259b56 elected leader ca739d563b259b56 at term 2"} {"level":"info","ts":"2026-08-10T22:22:09.261792Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:22:09.262317Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca739d563b259b56","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.116:2379]}","request-path":"/0/members/ca739d563b259b56/attributes","cluster-id":"2052ec4484eed829","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T22:22:09.26256Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:22:09.262631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:22:09.26266Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:22:09.262695Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:22:09.262715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:22:09.263292Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T22:22:09.263323Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T22:22:09.265738Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-10T22:22:09.268274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.116:2379"} {"level":"info","ts":"2026-08-10T22:22:57.767971Z","caller":"traceutil/trace.go:171","msg":"trace[1287548233] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"115.633369ms","start":"2026-08-10T22:22:57.65232Z","end":"2026-08-10T22:22:57.767954Z","steps":["trace[1287548233] 'process raft request' (duration: 115.22719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:22:58.354061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.449604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:22:58.354157Z","caller":"traceutil/trace.go:171","msg":"trace[2059899789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"362.590808ms","start":"2026-08-10T22:22:57.991552Z","end":"2026-08-10T22:22:58.354142Z","steps":["trace[2059899789] 'range keys from in-memory index tree' (duration: 362.380133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:22:58.354183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:22:57.991535Z","time spent":"362.642119ms","remote":"127.0.0.1:40874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-10T22:22:58.548563Z","caller":"traceutil/trace.go:171","msg":"trace[1224627519] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"190.143142ms","start":"2026-08-10T22:22:58.358369Z","end":"2026-08-10T22:22:58.548512Z","steps":["trace[1224627519] 'process raft request' (duration: 188.612459ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:22:58.602353Z","caller":"traceutil/trace.go:171","msg":"trace[1129532718] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"109.871559ms","start":"2026-08-10T22:22:58.492426Z","end":"2026-08-10T22:22:58.602298Z","steps":["trace[1129532718] 'read index received' (duration: 53.448658ms)","trace[1129532718] 'applied index is now lower than readState.Index' (duration: 56.422071ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:22:58.602527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.091284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vqqk4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-10T22:22:58.60256Z","caller":"traceutil/trace.go:171","msg":"trace[761738886] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vqqk4; range_end:; response_count:1; response_revision:648; }","duration":"110.166506ms","start":"2026-08-10T22:22:58.492382Z","end":"2026-08-10T22:22:58.602549Z","steps":["trace[761738886] 'agreement among raft nodes before linearized reading' (duration: 110.042133ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:22:58.602781Z","caller":"traceutil/trace.go:171","msg":"trace[1684500094] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"223.97158ms","start":"2026-08-10T22:22:58.378761Z","end":"2026-08-10T22:22:58.602732Z","steps":["trace[1684500094] 'process raft request' (duration: 223.06565ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:23:14.938167Z","caller":"traceutil/trace.go:171","msg":"trace[389327448] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"302.717116ms","start":"2026-08-10T22:23:14.635427Z","end":"2026-08-10T22:23:14.938144Z","steps":["trace[389327448] 'read index received' (duration: 227.670487ms)","trace[389327448] 'applied index is now lower than readState.Index' (duration: 75.045989ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:23:14.938294Z","caller":"traceutil/trace.go:171","msg":"trace[286882532] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"334.875922ms","start":"2026-08-10T22:23:14.603409Z","end":"2026-08-10T22:23:14.938285Z","steps":["trace[286882532] 'process raft request' (duration: 259.745811ms)","trace[286882532] 'compare' (duration: 74.884566ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:23:14.93868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.226707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-10T22:23:14.938717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:23:14.603396Z","time spent":"334.920942ms","remote":"127.0.0.1:41058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:23:14.938736Z","caller":"traceutil/trace.go:171","msg":"trace[1532961507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"303.350028ms","start":"2026-08-10T22:23:14.635371Z","end":"2026-08-10T22:23:14.938721Z","steps":["trace[1532961507] 'agreement among raft nodes before linearized reading' (duration: 303.210495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:23:14.938764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:23:14.635349Z","time spent":"303.40829ms","remote":"127.0.0.1:41124","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":"info","ts":"2026-08-10T22:24:46.685828Z","caller":"traceutil/trace.go:171","msg":"trace[717690889] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"110.412909ms","start":"2026-08-10T22:24:46.575389Z","end":"2026-08-10T22:24:46.685802Z","steps":["trace[717690889] 'process raft request' (duration: 110.244746ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:47.157222Z","caller":"traceutil/trace.go:171","msg":"trace[129093453] linearizableReadLoop","detail":"{readStateIndex:2015; appliedIndex:2014; }","duration":"108.690332ms","start":"2026-08-10T22:24:47.048505Z","end":"2026-08-10T22:24:47.157195Z","steps":["trace[129093453] 'read index received' (duration: 108.54233ms)","trace[129093453] 'applied index is now lower than readState.Index' (duration: 147.252µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:24:47.157387Z","caller":"traceutil/trace.go:171","msg":"trace[364621970] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"129.30349ms","start":"2026-08-10T22:24:47.027976Z","end":"2026-08-10T22:24:47.157279Z","steps":["trace[364621970] 'process raft request' (duration: 129.074147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:24:47.157485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.935545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-56345a3f-b105-4df7-bec1-6d94564c4e40\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-10T22:24:47.157521Z","caller":"traceutil/trace.go:171","msg":"trace[198546958] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-56345a3f-b105-4df7-bec1-6d94564c4e40; range_end:; response_count:1; response_revision:1940; }","duration":"109.065047ms","start":"2026-08-10T22:24:47.048447Z","end":"2026-08-10T22:24:47.157512Z","steps":["trace[198546958] 'agreement among raft nodes before linearized reading' (duration: 108.858364ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:58.853775Z","caller":"traceutil/trace.go:171","msg":"trace[289571313] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"273.139973ms","start":"2026-08-10T22:24:58.580608Z","end":"2026-08-10T22:24:58.853748Z","steps":["trace[289571313] 'process raft request' (duration: 272.978461ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:59.166124Z","caller":"traceutil/trace.go:171","msg":"trace[1620923278] linearizableReadLoop","detail":"{readStateIndex:2120; appliedIndex:2119; }","duration":"193.191729ms","start":"2026-08-10T22:24:58.972906Z","end":"2026-08-10T22:24:59.166098Z","steps":["trace[1620923278] 'read index received' (duration: 192.743633ms)","trace[1620923278] 'applied index is now lower than readState.Index' (duration: 446.866µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:24:59.16637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.445863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-10T22:24:59.166409Z","caller":"traceutil/trace.go:171","msg":"trace[372334164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2041; }","duration":"193.539055ms","start":"2026-08-10T22:24:58.972857Z","end":"2026-08-10T22:24:59.166396Z","steps":["trace[372334164] 'agreement among raft nodes before linearized reading' (duration: 193.379802ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:24:59.166425Z","caller":"traceutil/trace.go:171","msg":"trace[614900] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"237.667291ms","start":"2026-08-10T22:24:58.928743Z","end":"2026-08-10T22:24:59.16641Z","steps":["trace[614900] 'process raft request' (duration: 236.981471ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:35.793644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.916833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:25:35.793812Z","caller":"traceutil/trace.go:171","msg":"trace[1380465619] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"147.939613ms","start":"2026-08-10T22:25:35.645855Z","end":"2026-08-10T22:25:35.793795Z","steps":["trace[1380465619] 'process raft request' (duration: 147.884542ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:35.793847Z","caller":"traceutil/trace.go:171","msg":"trace[634892259] linearizableReadLoop","detail":"{readStateIndex:2338; appliedIndex:2337; }","duration":"202.523039ms","start":"2026-08-10T22:25:35.591312Z","end":"2026-08-10T22:25:35.793835Z","steps":["trace[634892259] 'read index received' (duration: 49.66µs)","trace[634892259] 'applied index is now lower than readState.Index' (duration: 202.472329ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:25:35.794283Z","caller":"traceutil/trace.go:171","msg":"trace[921361575] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"405.924841ms","start":"2026-08-10T22:25:35.388304Z","end":"2026-08-10T22:25:35.794229Z","steps":["trace[921361575] 'process raft request' (duration: 145.149037ms)","trace[921361575] 'compare' (duration: 259.72077ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:35.794319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.990236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:25:35.794406Z","caller":"traceutil/trace.go:171","msg":"trace[1183586363] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2252; }","duration":"203.138007ms","start":"2026-08-10T22:25:35.591249Z","end":"2026-08-10T22:25:35.794387Z","steps":["trace[1183586363] 'agreement among raft nodes before linearized reading' (duration: 202.980405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:35.794437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:25:35.388274Z","time spent":"406.049592ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:25:35.956826Z","caller":"traceutil/trace.go:171","msg":"trace[973618199] linearizableReadLoop","detail":"{readStateIndex:2340; appliedIndex:2339; }","duration":"162.542014ms","start":"2026-08-10T22:25:35.794262Z","end":"2026-08-10T22:25:35.956804Z","steps":["trace[973618199] 'read index received' (duration: 110.057755ms)","trace[973618199] 'applied index is now lower than readState.Index' (duration: 52.483489ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:25:35.956927Z","caller":"traceutil/trace.go:171","msg":"trace[1826127048] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"203.614274ms","start":"2026-08-10T22:25:35.753303Z","end":"2026-08-10T22:25:35.956918Z","steps":["trace[1826127048] 'process raft request' (duration: 150.988693ms)","trace[1826127048] 'compare' (duration: 52.411868ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:35.957124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.342602ms","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":"info","ts":"2026-08-10T22:25:35.957173Z","caller":"traceutil/trace.go:171","msg":"trace[1892203460] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2253; }","duration":"210.432154ms","start":"2026-08-10T22:25:35.746729Z","end":"2026-08-10T22:25:35.957161Z","steps":["trace[1892203460] 'agreement among raft nodes before linearized reading' (duration: 210.293702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:35.957249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.947349ms","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-10T22:25:35.957294Z","caller":"traceutil/trace.go:171","msg":"trace[1954645552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2253; }","duration":"284.033861ms","start":"2026-08-10T22:25:35.673249Z","end":"2026-08-10T22:25:35.957283Z","steps":["trace[1954645552] 'agreement among raft nodes before linearized reading' (duration: 283.896259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:35.95761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.432094ms","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-10T22:25:35.957741Z","caller":"traceutil/trace.go:171","msg":"trace[289364771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2253; }","duration":"261.671036ms","start":"2026-08-10T22:25:35.696041Z","end":"2026-08-10T22:25:35.957712Z","steps":["trace[289364771] 'agreement among raft nodes before linearized reading' (duration: 261.255311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:35.958424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.065299ms","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-10T22:25:35.958468Z","caller":"traceutil/trace.go:171","msg":"trace[668227314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2253; }","duration":"114.141179ms","start":"2026-08-10T22:25:35.844316Z","end":"2026-08-10T22:25:35.958457Z","steps":["trace[668227314] 'agreement among raft nodes before linearized reading' (duration: 114.024058ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:26:18.338969Z","caller":"traceutil/trace.go:171","msg":"trace[380549273] linearizableReadLoop","detail":"{readStateIndex:2686; appliedIndex:2685; }","duration":"135.60741ms","start":"2026-08-10T22:26:18.203339Z","end":"2026-08-10T22:26:18.338946Z","steps":["trace[380549273] 'read index received' (duration: 135.415913ms)","trace[380549273] 'applied index is now lower than readState.Index' (duration: 190.417µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:26:18.339046Z","caller":"traceutil/trace.go:171","msg":"trace[2019428787] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"138.621117ms","start":"2026-08-10T22:26:18.200384Z","end":"2026-08-10T22:26:18.339005Z","steps":["trace[2019428787] 'process raft request' (duration: 138.42494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:18.339165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.806387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-10T22:26:18.339201Z","caller":"traceutil/trace.go:171","msg":"trace[1329687948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2588; }","duration":"135.88753ms","start":"2026-08-10T22:26:18.203303Z","end":"2026-08-10T22:26:18.339191Z","steps":["trace[1329687948] 'agreement among raft nodes before linearized reading' (duration: 135.758145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:26:18.339253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.59722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-10T22:26:18.339321Z","caller":"traceutil/trace.go:171","msg":"trace[1575237140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2588; }","duration":"135.687783ms","start":"2026-08-10T22:26:18.203617Z","end":"2026-08-10T22:26:18.339305Z","steps":["trace[1575237140] 'agreement among raft nodes before linearized reading' (duration: 135.491216ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:59.973737Z","caller":"traceutil/trace.go:171","msg":"trace[1063167414] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"109.596937ms","start":"2026-08-10T22:30:59.864116Z","end":"2026-08-10T22:30:59.973713Z","steps":["trace[1063167414] 'process raft request' (duration: 108.918914ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.187124Z","caller":"traceutil/trace.go:171","msg":"trace[2002058620] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4959; }","duration":"135.764517ms","start":"2026-08-10T22:31:05.05134Z","end":"2026-08-10T22:31:05.187104Z","steps":["trace[2002058620] 'read index received' (duration: 135.435941ms)","trace[2002058620] 'applied index is now lower than readState.Index' (duration: 327.816µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:31:05.187212Z","caller":"traceutil/trace.go:171","msg":"trace[977185106] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"137.342145ms","start":"2026-08-10T22:31:05.049836Z","end":"2026-08-10T22:31:05.187179Z","steps":["trace[977185106] 'process raft request' (duration: 136.867627ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:05.18756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.197894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:57148"} {"level":"info","ts":"2026-08-10T22:31:05.187596Z","caller":"traceutil/trace.go:171","msg":"trace[178016931] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4778; }","duration":"136.278106ms","start":"2026-08-10T22:31:05.05131Z","end":"2026-08-10T22:31:05.187588Z","steps":["trace[178016931] 'agreement among raft nodes before linearized reading' (duration: 135.879459ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.257034Z","caller":"traceutil/trace.go:171","msg":"trace[2005159277] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"194.136298ms","start":"2026-08-10T22:31:05.062873Z","end":"2026-08-10T22:31:05.257009Z","steps":["trace[2005159277] 'process raft request' (duration: 193.948554ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.25732Z","caller":"traceutil/trace.go:171","msg":"trace[268482820] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"101.012323ms","start":"2026-08-10T22:31:05.156292Z","end":"2026-08-10T22:31:05.257305Z","steps":["trace[268482820] 'process raft request' (duration: 100.659497ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.380638Z","caller":"traceutil/trace.go:171","msg":"trace[2034001835] linearizableReadLoop","detail":"{readStateIndex:4963; appliedIndex:4962; }","duration":"123.327798ms","start":"2026-08-10T22:31:05.257276Z","end":"2026-08-10T22:31:05.380604Z","steps":["trace[2034001835] 'read index received' (duration: 123.308288ms)","trace[2034001835] 'applied index is now lower than readState.Index' (duration: 18.98µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:31:05.380766Z","caller":"traceutil/trace.go:171","msg":"trace[1628637864] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"146.713941ms","start":"2026-08-10T22:31:05.23404Z","end":"2026-08-10T22:31:05.380754Z","steps":["trace[1628637864] 'process raft request' (duration: 146.417095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:05.381127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.696658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-08-10T22:31:05.381346Z","caller":"traceutil/trace.go:171","msg":"trace[201354769] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4781; }","duration":"177.949472ms","start":"2026-08-10T22:31:05.203376Z","end":"2026-08-10T22:31:05.381325Z","steps":["trace[201354769] 'agreement among raft nodes before linearized reading' (duration: 177.604566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:05.381804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.08128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-10T22:31:05.381851Z","caller":"traceutil/trace.go:171","msg":"trace[2114972491] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4781; }","duration":"133.184502ms","start":"2026-08-10T22:31:05.248657Z","end":"2026-08-10T22:31:05.381841Z","steps":["trace[2114972491] 'agreement among raft nodes before linearized reading' (duration: 132.200564ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:05.398189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.302948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-08-10T22:31:05.398292Z","caller":"traceutil/trace.go:171","msg":"trace[988254162] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4784; }","duration":"131.444401ms","start":"2026-08-10T22:31:05.266835Z","end":"2026-08-10T22:31:05.398279Z","steps":["trace[988254162] 'agreement among raft nodes before linearized reading' (duration: 131.229407ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.398427Z","caller":"traceutil/trace.go:171","msg":"trace[679457235] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"136.423548ms","start":"2026-08-10T22:31:05.261909Z","end":"2026-08-10T22:31:05.398333Z","steps":["trace[679457235] 'process raft request' (duration: 135.9954ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:05.398739Z","caller":"traceutil/trace.go:171","msg":"trace[109167320] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"137.340285ms","start":"2026-08-10T22:31:05.261342Z","end":"2026-08-10T22:31:05.398682Z","steps":["trace[109167320] 'process raft request' (duration: 125.434405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:05.399154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.225965ms","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-10T22:31:05.399258Z","caller":"traceutil/trace.go:171","msg":"trace[732516504] 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:4784; }","duration":"123.384978ms","start":"2026-08-10T22:31:05.275856Z","end":"2026-08-10T22:31:05.399241Z","steps":["trace[732516504] 'agreement among raft nodes before linearized reading' (duration: 123.029952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:12.514961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.934738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:31:12.515108Z","caller":"traceutil/trace.go:171","msg":"trace[1722790368] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"312.385821ms","start":"2026-08-10T22:31:12.202705Z","end":"2026-08-10T22:31:12.51509Z","steps":["trace[1722790368] 'process raft request' (duration: 161.216469ms)","trace[1722790368] 'compare' (duration: 150.628342ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:31:12.515178Z","caller":"traceutil/trace.go:171","msg":"trace[398324979] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"312.429352ms","start":"2026-08-10T22:31:12.202719Z","end":"2026-08-10T22:31:12.515148Z","steps":["trace[398324979] 'read index received' (duration: 352.977µs)","trace[398324979] 'applied index is now lower than readState.Index' (duration: 312.075295ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:31:12.515287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.564574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"} {"level":"info","ts":"2026-08-10T22:31:12.515307Z","caller":"traceutil/trace.go:171","msg":"trace[1210395699] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:4879; }","duration":"312.629885ms","start":"2026-08-10T22:31:12.20267Z","end":"2026-08-10T22:31:12.5153Z","steps":["trace[1210395699] 'agreement among raft nodes before linearized reading' (duration: 312.560093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:12.515328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:31:12.202651Z","time spent":"312.671446ms","remote":"127.0.0.1:41230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":670,"request content":"key:\"/registry/clusterroles/system:discovery\" "} {"level":"info","ts":"2026-08-10T22:31:12.515681Z","caller":"traceutil/trace.go:171","msg":"trace[345416319] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"157.181568ms","start":"2026-08-10T22:31:12.358473Z","end":"2026-08-10T22:31:12.515655Z","steps":["trace[345416319] 'process raft request' (duration: 156.566997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:12.515859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.354355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-10T22:31:12.515944Z","caller":"traceutil/trace.go:171","msg":"trace[537535038] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4879; }","duration":"310.474667ms","start":"2026-08-10T22:31:12.205453Z","end":"2026-08-10T22:31:12.515928Z","steps":["trace[537535038] 'agreement among raft nodes before linearized reading' (duration: 310.214972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:12.516012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:31:12.205437Z","time spent":"310.563569ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1308,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-08-10T22:31:12.516027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:31:12.202687Z","time spent":"313.290917ms","remote":"127.0.0.1:40948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-10T22:31:12.516415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.723251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-10T22:31:12.516441Z","caller":"traceutil/trace.go:171","msg":"trace[1129482577] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4879; }","duration":"143.787283ms","start":"2026-08-10T22:31:12.372648Z","end":"2026-08-10T22:31:12.516435Z","steps":["trace[1129482577] 'agreement among raft nodes before linearized reading' (duration: 143.004129ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:12.911259Z","caller":"traceutil/trace.go:171","msg":"trace[761945265] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5073; }","duration":"147.525338ms","start":"2026-08-10T22:31:12.763714Z","end":"2026-08-10T22:31:12.911239Z","steps":["trace[761945265] 'read index received' (duration: 147.507898ms)","trace[761945265] 'applied index is now lower than readState.Index' (duration: 16.53µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:31:12.911447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.705592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-08-10T22:31:12.911476Z","caller":"traceutil/trace.go:171","msg":"trace[1229447776] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4889; }","duration":"147.783062ms","start":"2026-08-10T22:31:12.763684Z","end":"2026-08-10T22:31:12.911467Z","steps":["trace[1229447776] 'agreement among raft nodes before linearized reading' (duration: 147.65532ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:12.911438Z","caller":"traceutil/trace.go:171","msg":"trace[1439604304] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"148.040577ms","start":"2026-08-10T22:31:12.763338Z","end":"2026-08-10T22:31:12.911379Z","steps":["trace[1439604304] 'process raft request' (duration: 147.757382ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:13.05791Z","caller":"traceutil/trace.go:171","msg":"trace[1961525716] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5074; }","duration":"146.55632ms","start":"2026-08-10T22:31:12.911314Z","end":"2026-08-10T22:31:13.05787Z","steps":["trace[1961525716] 'read index received' (duration: 126.797544ms)","trace[1961525716] 'applied index is now lower than readState.Index' (duration: 19.757506ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:31:13.05797Z","caller":"traceutil/trace.go:171","msg":"trace[271500623] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"270.115258ms","start":"2026-08-10T22:31:12.787815Z","end":"2026-08-10T22:31:13.05793Z","steps":["trace[271500623] 'process raft request' (duration: 250.353842ms)","trace[271500623] 'compare' (duration: 19.534102ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:31:13.058188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.290799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:31:13.058246Z","caller":"traceutil/trace.go:171","msg":"trace[1852624519] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:4890; }","duration":"291.380752ms","start":"2026-08-10T22:31:12.766848Z","end":"2026-08-10T22:31:13.058229Z","steps":["trace[1852624519] 'agreement among raft nodes before linearized reading' (duration: 291.238509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:13.058492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.278174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-10T22:31:13.05853Z","caller":"traceutil/trace.go:171","msg":"trace[1823014054] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4890; }","duration":"293.335926ms","start":"2026-08-10T22:31:12.765186Z","end":"2026-08-10T22:31:13.058522Z","steps":["trace[1823014054] 'agreement among raft nodes before linearized reading' (duration: 293.189583ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:13.058635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.116202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-08-10T22:31:13.058736Z","caller":"traceutil/trace.go:171","msg":"trace[1398267344] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4890; }","duration":"142.230465ms","start":"2026-08-10T22:31:12.916456Z","end":"2026-08-10T22:31:13.058687Z","steps":["trace[1398267344] 'agreement among raft nodes before linearized reading' (duration: 142.010091ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:13.059019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.005458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3223"} {"level":"info","ts":"2026-08-10T22:31:13.059066Z","caller":"traceutil/trace.go:171","msg":"trace[232724610] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4890; }","duration":"139.067999ms","start":"2026-08-10T22:31:12.919986Z","end":"2026-08-10T22:31:13.059054Z","steps":["trace[232724610] 'agreement among raft nodes before linearized reading' (duration: 138.945097ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:13.192073Z","caller":"traceutil/trace.go:171","msg":"trace[1615306442] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"109.423998ms","start":"2026-08-10T22:31:13.082628Z","end":"2026-08-10T22:31:13.192052Z","steps":["trace[1615306442] 'process raft request' (duration: 109.368937ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:13.192426Z","caller":"traceutil/trace.go:171","msg":"trace[794987244] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"110.551387ms","start":"2026-08-10T22:31:13.081859Z","end":"2026-08-10T22:31:13.192411Z","steps":["trace[794987244] 'process raft request' (duration: 109.996248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:13.192476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.001944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61393"} {"level":"info","ts":"2026-08-10T22:31:13.192555Z","caller":"traceutil/trace.go:171","msg":"trace[929069604] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"110.597819ms","start":"2026-08-10T22:31:13.08195Z","end":"2026-08-10T22:31:13.192548Z","steps":["trace[929069604] 'process raft request' (duration: 110.018469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:13.192658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.196825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b1b11c5a-b826-40a6-ae44-0238e0f85167\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-08-10T22:31:13.192704Z","caller":"traceutil/trace.go:171","msg":"trace[1592072508] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b1b11c5a-b826-40a6-ae44-0238e0f85167; range_end:; response_count:1; response_revision:4897; }","duration":"129.257545ms","start":"2026-08-10T22:31:13.063436Z","end":"2026-08-10T22:31:13.192694Z","steps":["trace[1592072508] 'agreement among raft nodes before linearized reading' (duration: 129.144893ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:13.192555Z","caller":"traceutil/trace.go:171","msg":"trace[1333442744] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4897; }","duration":"128.120536ms","start":"2026-08-10T22:31:13.064416Z","end":"2026-08-10T22:31:13.192537Z","steps":["trace[1333442744] 'agreement among raft nodes before linearized reading' (duration: 127.701458ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:16.263311Z","caller":"traceutil/trace.go:171","msg":"trace[159981290] linearizableReadLoop","detail":"{readStateIndex:5144; appliedIndex:5143; }","duration":"174.040282ms","start":"2026-08-10T22:31:16.089249Z","end":"2026-08-10T22:31:16.263289Z","steps":["trace[159981290] 'read index received' (duration: 151.714212ms)","trace[159981290] 'applied index is now lower than readState.Index' (duration: 22.32521ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:31:16.263419Z","caller":"traceutil/trace.go:171","msg":"trace[43849189] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"176.335532ms","start":"2026-08-10T22:31:16.087073Z","end":"2026-08-10T22:31:16.263408Z","steps":["trace[43849189] 'process raft request' (duration: 153.998432ms)","trace[43849189] 'compare' (duration: 22.006985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:31:16.263585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.323467ms","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-10T22:31:16.263607Z","caller":"traceutil/trace.go:171","msg":"trace[832279040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4959; }","duration":"174.379259ms","start":"2026-08-10T22:31:16.089222Z","end":"2026-08-10T22:31:16.263601Z","steps":["trace[832279040] 'agreement among raft nodes before linearized reading' (duration: 174.279217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:16.263792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.527986ms","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-10T22:31:16.263819Z","caller":"traceutil/trace.go:171","msg":"trace[1673634703] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4959; }","duration":"168.571206ms","start":"2026-08-10T22:31:16.095239Z","end":"2026-08-10T22:31:16.26381Z","steps":["trace[1673634703] 'agreement among raft nodes before linearized reading' (duration: 168.505325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:16.263905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.803529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-10T22:31:16.263961Z","caller":"traceutil/trace.go:171","msg":"trace[1668833115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4959; }","duration":"165.86881ms","start":"2026-08-10T22:31:16.098075Z","end":"2026-08-10T22:31:16.263944Z","steps":["trace[1668833115] 'agreement among raft nodes before linearized reading' (duration: 165.703537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:16.263972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.062353ms","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-10T22:31:16.264061Z","caller":"traceutil/trace.go:171","msg":"trace[1091915148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4959; }","duration":"166.191886ms","start":"2026-08-10T22:31:16.097852Z","end":"2026-08-10T22:31:16.264043Z","steps":["trace[1091915148] 'agreement among raft nodes before linearized reading' (duration: 165.947811ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:25.840496Z","caller":"traceutil/trace.go:171","msg":"trace[659325758] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"138.709197ms","start":"2026-08-10T22:31:25.701768Z","end":"2026-08-10T22:31:25.840477Z","steps":["trace[659325758] 'process raft request' (duration: 138.537064ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:26.376998Z","caller":"traceutil/trace.go:171","msg":"trace[143657914] transaction","detail":"{read_only:false; response_revision:5098; number_of_response:1; }","duration":"100.572824ms","start":"2026-08-10T22:31:26.276408Z","end":"2026-08-10T22:31:26.376981Z","steps":["trace[143657914] 'process raft request' (duration: 66.485543ms)","trace[143657914] 'compare' (duration: 33.626953ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:32:03.776393Z","caller":"traceutil/trace.go:171","msg":"trace[1466279336] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"196.076211ms","start":"2026-08-10T22:32:03.580283Z","end":"2026-08-10T22:32:03.77636Z","steps":["trace[1466279336] 'process raft request' (duration: 100.67277ms)","trace[1466279336] 'compare' (duration: 95.270589ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:32:09.302098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-08-10T22:32:09.373623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"70.210921ms","hash":1766430249,"current-db-size-bytes":51683328,"current-db-size":"52 MB","current-db-size-in-use-bytes":28610560,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-10T22:32:09.373689Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1766430249,"revision":2865,"compact-revision":-1} {"level":"info","ts":"2026-08-10T22:34:00.882665Z","caller":"traceutil/trace.go:171","msg":"trace[1970298692] linearizableReadLoop","detail":"{readStateIndex:6390; appliedIndex:6389; }","duration":"196.391199ms","start":"2026-08-10T22:34:00.686252Z","end":"2026-08-10T22:34:00.882644Z","steps":["trace[1970298692] 'read index received' (duration: 196.211857ms)","trace[1970298692] 'applied index is now lower than readState.Index' (duration: 178.702µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:34:00.8831Z","caller":"traceutil/trace.go:171","msg":"trace[1807138191] transaction","detail":"{read_only:false; response_revision:6166; number_of_response:1; }","duration":"204.793625ms","start":"2026-08-10T22:34:00.678295Z","end":"2026-08-10T22:34:00.883089Z","steps":["trace[1807138191] 'process raft request' (duration: 204.227475ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:34:00.883297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.02428ms","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-10T22:34:00.883323Z","caller":"traceutil/trace.go:171","msg":"trace[914976854] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6166; }","duration":"197.08073ms","start":"2026-08-10T22:34:00.686236Z","end":"2026-08-10T22:34:00.883317Z","steps":["trace[914976854] 'agreement among raft nodes before linearized reading' (duration: 196.977819ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:37:09.308675Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5462} {"level":"info","ts":"2026-08-10T22:37:09.379942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5462,"took":"70.084803ms","hash":3680669338,"current-db-size-bytes":51683328,"current-db-size":"52 MB","current-db-size-in-use-bytes":18464768,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-10T22:37:09.38005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3680669338,"revision":5462,"compact-revision":2865}