{"level":"warn","ts":"2026-07-30T18:55:40.708628Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T18:55:40.708726Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-30T18:55:40.708805Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T18:55:40.708817Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-30T18:55:40.708837Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T18:55:40.709486Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-07-30T18:55:40.709559Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-30T18:55:40.715665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.897187ms"} {"level":"info","ts":"2026-07-30T18:55:40.723739Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-07-30T18:55:40.723907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T18:55:40.723951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-07-30T18:55:40.723973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T18:55:40.723988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-07-30T18:55:40.724057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-07-30T18:55:40.729452Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T18:55:40.730863Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T18:55:40.731899Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-30T18:55:40.734499Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T18:55:40.734796Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T18:55:40.735032Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T18:55:40.734677Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T18:55:40.735106Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T18:55:40.737118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-07-30T18:55:40.737405Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-30T18:55:40.740676Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T18:55:40.740971Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T18:55:40.741006Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-30T18:55:40.741162Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-30T18:55:40.741029Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T18:55:41.225444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T18:55:41.225522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T18:55:41.225584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-07-30T18:55:41.225613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-07-30T18:55:41.225629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-30T18:55:41.225652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-07-30T18:55:41.225671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-30T18:55:41.226876Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:55:41.227568Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T18:55:41.22775Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T18:55:41.227814Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T18:55:41.231016Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T18:55:41.231196Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T18:55:41.23154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T18:55:41.234917Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:55:41.235049Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:55:41.235091Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:55:41.23913Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-07-30T18:56:04.131164Z","caller":"traceutil/trace.go:171","msg":"trace[387091227] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"190.127839ms","start":"2026-07-30T18:56:03.940984Z","end":"2026-07-30T18:56:04.131112Z","steps":["trace[387091227] 'process raft request' (duration: 109.685856ms)","trace[387091227] 'compare' (duration: 80.186246ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:56:04.131268Z","caller":"traceutil/trace.go:171","msg":"trace[1343417671] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"190.152269ms","start":"2026-07-30T18:56:03.941069Z","end":"2026-07-30T18:56:04.131222Z","steps":["trace[1343417671] 'process raft request' (duration: 189.974175ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:56:04.131332Z","caller":"traceutil/trace.go:171","msg":"trace[103184169] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"177.891602ms","start":"2026-07-30T18:56:03.953409Z","end":"2026-07-30T18:56:04.131301Z","steps":["trace[103184169] 'process raft request' (duration: 177.834871ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:56:04.131553Z","caller":"traceutil/trace.go:171","msg":"trace[1505638962] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"187.126683ms","start":"2026-07-30T18:56:03.944415Z","end":"2026-07-30T18:56:04.131542Z","steps":["trace[1505638962] 'process raft request' (duration: 186.767214ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:56:04.1315Z","caller":"traceutil/trace.go:171","msg":"trace[1547322763] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"189.212706ms","start":"2026-07-30T18:56:03.942233Z","end":"2026-07-30T18:56:04.131445Z","steps":["trace[1547322763] 'process raft request' (duration: 188.875217ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:56:24.08314Z","caller":"traceutil/trace.go:171","msg":"trace[541005982] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"262.835309ms","start":"2026-07-30T18:56:23.820272Z","end":"2026-07-30T18:56:24.083107Z","steps":["trace[541005982] 'read index received' (duration: 260.913951ms)","trace[541005982] 'applied index is now lower than readState.Index' (duration: 1.920408ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:56:24.083201Z","caller":"traceutil/trace.go:171","msg":"trace[2106548033] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"339.085139ms","start":"2026-07-30T18:56:23.744091Z","end":"2026-07-30T18:56:24.083176Z","steps":["trace[2106548033] 'process raft request' (duration: 337.443567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:56:24.08344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.177099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tmv6w\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-07-30T18:56:24.083461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.169818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-30T18:56:24.083545Z","caller":"traceutil/trace.go:171","msg":"trace[448147659] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tmv6w; range_end:; response_count:1; response_revision:590; }","duration":"142.351133ms","start":"2026-07-30T18:56:23.941179Z","end":"2026-07-30T18:56:24.08353Z","steps":["trace[448147659] 'agreement among raft nodes before linearized reading' (duration: 142.116408ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:56:24.083565Z","caller":"traceutil/trace.go:171","msg":"trace[1935347792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"263.307882ms","start":"2026-07-30T18:56:23.820238Z","end":"2026-07-30T18:56:24.083545Z","steps":["trace[1935347792] 'agreement among raft nodes before linearized reading' (duration: 263.048885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:56:24.083955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T18:56:23.744072Z","time spent":"339.183762ms","remote":"127.0.0.1:53970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T18:56:24.549433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.873468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:56:24.549703Z","caller":"traceutil/trace.go:171","msg":"trace[1866777438] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:593; }","duration":"370.188777ms","start":"2026-07-30T18:56:24.179494Z","end":"2026-07-30T18:56:24.549683Z","steps":["trace[1866777438] 'range keys from in-memory index tree' (duration: 369.786476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:56:24.549746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T18:56:24.179476Z","time spent":"370.260648ms","remote":"127.0.0.1:54130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-30T18:56:24.549597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.419679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-30T18:56:24.549834Z","caller":"traceutil/trace.go:171","msg":"trace[647201664] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:593; }","duration":"262.663695ms","start":"2026-07-30T18:56:24.287126Z","end":"2026-07-30T18:56:24.54979Z","steps":["trace[647201664] 'range keys from in-memory index tree' (duration: 262.284816ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:18.10755Z","caller":"traceutil/trace.go:171","msg":"trace[2028629883] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"129.359417ms","start":"2026-07-30T18:57:17.978156Z","end":"2026-07-30T18:57:18.107516Z","steps":["trace[2028629883] 'process raft request' (duration: 129.100971ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:42.210237Z","caller":"traceutil/trace.go:171","msg":"trace[2140855572] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"154.959214ms","start":"2026-07-30T18:57:42.055206Z","end":"2026-07-30T18:57:42.210165Z","steps":["trace[2140855572] 'process raft request' (duration: 139.09443ms)","trace[2140855572] 'compare' (duration: 15.592217ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:57:42.882511Z","caller":"traceutil/trace.go:171","msg":"trace[991821322] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"147.208591ms","start":"2026-07-30T18:57:42.735275Z","end":"2026-07-30T18:57:42.882483Z","steps":["trace[991821322] 'read index received' (duration: 146.991506ms)","trace[991821322] 'applied index is now lower than readState.Index' (duration: 216.065µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:57:42.882632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.338744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:57:42.882669Z","caller":"traceutil/trace.go:171","msg":"trace[126458519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1323; }","duration":"147.434247ms","start":"2026-07-30T18:57:42.735214Z","end":"2026-07-30T18:57:42.882648Z","steps":["trace[126458519] 'agreement among raft nodes before linearized reading' (duration: 147.362505ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:42.88273Z","caller":"traceutil/trace.go:171","msg":"trace[1213365911] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"326.577783ms","start":"2026-07-30T18:57:42.556123Z","end":"2026-07-30T18:57:42.882701Z","steps":["trace[1213365911] 'process raft request' (duration: 326.207384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:57:42.882973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T18:57:42.556111Z","time spent":"326.753987ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T18:57:43.796673Z","caller":"traceutil/trace.go:171","msg":"trace[971568331] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"122.335622ms","start":"2026-07-30T18:57:43.674299Z","end":"2026-07-30T18:57:43.796635Z","steps":["trace[971568331] 'process raft request' (duration: 101.173678ms)","trace[971568331] 'compare' (duration: 20.867585ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:57:45.177136Z","caller":"traceutil/trace.go:171","msg":"trace[1353874368] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"285.477181ms","start":"2026-07-30T18:57:44.891611Z","end":"2026-07-30T18:57:45.177088Z","steps":["trace[1353874368] 'process raft request' (duration: 285.259915ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:57:46.507994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.146696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:57:46.508088Z","caller":"traceutil/trace.go:171","msg":"trace[1898085367] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1346; }","duration":"122.31229ms","start":"2026-07-30T18:57:46.385755Z","end":"2026-07-30T18:57:46.508068Z","steps":["trace[1898085367] 'count revisions from in-memory index tree' (duration: 121.995963ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:40.816652Z","caller":"traceutil/trace.go:171","msg":"trace[1900427322] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"126.843543ms","start":"2026-07-30T18:58:40.689779Z","end":"2026-07-30T18:58:40.816623Z","steps":["trace[1900427322] 'process raft request' (duration: 83.968984ms)","trace[1900427322] 'compare' (duration: 42.760326ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:58:41.582691Z","caller":"traceutil/trace.go:171","msg":"trace[1784847084] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"100.908022ms","start":"2026-07-30T18:58:41.481761Z","end":"2026-07-30T18:58:41.582669Z","steps":["trace[1784847084] 'process raft request' (duration: 100.706647ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:41.613143Z","caller":"traceutil/trace.go:171","msg":"trace[1594959099] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"127.15319ms","start":"2026-07-30T18:58:41.48596Z","end":"2026-07-30T18:58:41.613113Z","steps":["trace[1594959099] 'process raft request' (duration: 126.993106ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:41.613291Z","caller":"traceutil/trace.go:171","msg":"trace[1198545023] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2230; }","duration":"101.682651ms","start":"2026-07-30T18:58:41.511565Z","end":"2026-07-30T18:58:41.613247Z","steps":["trace[1198545023] 'read index received' (duration: 70.982523ms)","trace[1198545023] 'applied index is now lower than readState.Index' (duration: 30.693438ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:58:41.613536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.948537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-30T18:58:41.613677Z","caller":"traceutil/trace.go:171","msg":"trace[1774415391] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2148; }","duration":"102.105302ms","start":"2026-07-30T18:58:41.511536Z","end":"2026-07-30T18:58:41.613641Z","steps":["trace[1774415391] 'agreement among raft nodes before linearized reading' (duration: 101.891226ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:15.902374Z","caller":"traceutil/trace.go:171","msg":"trace[369770173] linearizableReadLoop","detail":"{readStateIndex:2502; appliedIndex:2501; }","duration":"165.649031ms","start":"2026-07-30T18:59:15.736693Z","end":"2026-07-30T18:59:15.902342Z","steps":["trace[369770173] 'read index received' (duration: 111.920824ms)","trace[369770173] 'applied index is now lower than readState.Index' (duration: 53.726317ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:59:15.902424Z","caller":"traceutil/trace.go:171","msg":"trace[138275889] transaction","detail":"{read_only:false; response_revision:2410; number_of_response:1; }","duration":"166.641515ms","start":"2026-07-30T18:59:15.73574Z","end":"2026-07-30T18:59:15.902381Z","steps":["trace[138275889] 'process raft request' (duration: 112.834806ms)","trace[138275889] 'compare' (duration: 53.511792ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:59:15.902596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.885457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:59:15.902681Z","caller":"traceutil/trace.go:171","msg":"trace[386871866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2410; }","duration":"166.01453ms","start":"2026-07-30T18:59:15.736645Z","end":"2026-07-30T18:59:15.90266Z","steps":["trace[386871866] 'agreement among raft nodes before linearized reading' (duration: 165.867826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:59:15.902689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.13616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-07-30T18:59:15.902759Z","caller":"traceutil/trace.go:171","msg":"trace[1122967414] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2410; }","duration":"159.207542ms","start":"2026-07-30T18:59:15.743526Z","end":"2026-07-30T18:59:15.902733Z","steps":["trace[1122967414] 'agreement among raft nodes before linearized reading' (duration: 159.023957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:59:15.90286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.520966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-30T18:59:15.90269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.715348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-30T18:59:15.90293Z","caller":"traceutil/trace.go:171","msg":"trace[218760198] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2410; }","duration":"122.615248ms","start":"2026-07-30T18:59:15.780295Z","end":"2026-07-30T18:59:15.90291Z","steps":["trace[218760198] 'agreement among raft nodes before linearized reading' (duration: 122.433604ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:15.903075Z","caller":"traceutil/trace.go:171","msg":"trace[144778384] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2410; }","duration":"131.067497ms","start":"2026-07-30T18:59:15.771924Z","end":"2026-07-30T18:59:15.902992Z","steps":["trace[144778384] 'agreement among raft nodes before linearized reading' (duration: 130.633465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:59:15.903213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.27799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-30T18:59:15.903376Z","caller":"traceutil/trace.go:171","msg":"trace[119261224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2410; }","duration":"139.499236ms","start":"2026-07-30T18:59:15.763855Z","end":"2026-07-30T18:59:15.903354Z","steps":["trace[119261224] 'agreement among raft nodes before linearized reading' (duration: 139.105906ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:03:07.024482Z","caller":"traceutil/trace.go:171","msg":"trace[1412834122] transaction","detail":"{read_only:false; response_revision:3985; number_of_response:1; }","duration":"267.793132ms","start":"2026-07-30T19:03:06.756651Z","end":"2026-07-30T19:03:07.024444Z","steps":["trace[1412834122] 'process raft request' (duration: 267.29561ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:05:41.257422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3043} {"level":"info","ts":"2026-07-30T19:05:41.357179Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3043,"took":"98.608117ms","hash":144843334,"current-db-size-bytes":35487744,"current-db-size":"36 MB","current-db-size-in-use-bytes":8454144,"current-db-size-in-use":"8.5 MB"} {"level":"info","ts":"2026-07-30T19:05:41.357257Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":144843334,"revision":3043,"compact-revision":-1} {"level":"info","ts":"2026-07-30T19:06:23.29373Z","caller":"traceutil/trace.go:171","msg":"trace[1747508483] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"155.010355ms","start":"2026-07-30T19:06:23.138693Z","end":"2026-07-30T19:06:23.293703Z","steps":["trace[1747508483] 'process raft request' (duration: 154.796959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.234109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646845104877397032,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T19:06:24.956443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.604643746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-30T19:06:24.956532Z","caller":"traceutil/trace.go:171","msg":"trace[55328575] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:5233; }","duration":"1.604744779s","start":"2026-07-30T19:06:23.351768Z","end":"2026-07-30T19:06:24.956513Z","steps":["trace[55328575] 'range keys from in-memory index tree' (duration: 1.60441881s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.956503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30330227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-07-30T19:06:24.956569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.351682Z","time spent":"1.604879352s","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-30T19:06:24.956765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.601381677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T19:06:24.956792Z","caller":"traceutil/trace.go:171","msg":"trace[871303671] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5233; }","duration":"1.601412097s","start":"2026-07-30T19:06:23.355372Z","end":"2026-07-30T19:06:24.956785Z","steps":["trace[871303671] 'count revisions from in-memory index tree' (duration: 1.601284115s)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:24.956589Z","caller":"traceutil/trace.go:171","msg":"trace[985638140] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:5233; }","duration":"1.303457013s","start":"2026-07-30T19:06:23.653109Z","end":"2026-07-30T19:06:24.956566Z","steps":["trace[985638140] 'range keys from in-memory index tree' (duration: 1.303107774s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.956832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.653081Z","time spent":"1.3037373s","remote":"127.0.0.1:54066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-07-30T19:06:24.956815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.355283Z","time spent":"1.60152338s","remote":"127.0.0.1:54334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:06:24.958026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.213594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:06:24.958124Z","caller":"traceutil/trace.go:171","msg":"trace[79133679] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"1.237569334s","start":"2026-07-30T19:06:23.720539Z","end":"2026-07-30T19:06:24.958108Z","steps":["trace[79133679] 'process raft request' (duration: 781.797517ms)","trace[79133679] 'compare' (duration: 454.791194ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:06:24.958173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.720508Z","time spent":"1.237642176s","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:06:24.960924Z","caller":"traceutil/trace.go:171","msg":"trace[685192856] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5415; }","duration":"1.227864447s","start":"2026-07-30T19:06:23.733036Z","end":"2026-07-30T19:06:24.960901Z","steps":["trace[685192856] 'read index received' (duration: 769.196858ms)","trace[685192856] 'applied index is now lower than readState.Index' (duration: 458.666348ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:06:24.961028Z","caller":"traceutil/trace.go:171","msg":"trace[1461369175] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"949.165903ms","start":"2026-07-30T19:06:24.01184Z","end":"2026-07-30T19:06:24.961006Z","steps":["trace[1461369175] 'process raft request' (duration: 949.002959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.961058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228032081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:06:24.961042Z","caller":"traceutil/trace.go:171","msg":"trace[1028925280] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"1.234002106s","start":"2026-07-30T19:06:23.726929Z","end":"2026-07-30T19:06:24.960931Z","steps":["trace[1028925280] 'process raft request' (duration: 1.233781241s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.961179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.011792Z","time spent":"949.282796ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:06:24.961098Z","caller":"traceutil/trace.go:171","msg":"trace[761048656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5236; }","duration":"1.228129103s","start":"2026-07-30T19:06:23.732956Z","end":"2026-07-30T19:06:24.961085Z","steps":["trace[761048656] 'agreement among raft nodes before linearized reading' (duration: 1.228062121s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.96126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.726883Z","time spent":"1.234268844s","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:06:24.961305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:23.732912Z","time spent":"1.228374469s","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-30T19:06:24.963071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.61997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-30T19:06:24.963082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.294997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12463"} {"level":"info","ts":"2026-07-30T19:06:24.963128Z","caller":"traceutil/trace.go:171","msg":"trace[1567104200] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:5237; }","duration":"640.677662ms","start":"2026-07-30T19:06:24.322437Z","end":"2026-07-30T19:06:24.963114Z","steps":["trace[1567104200] 'agreement among raft nodes before linearized reading' (duration: 640.478657ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:24.96314Z","caller":"traceutil/trace.go:171","msg":"trace[1492695668] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5237; }","duration":"283.399429ms","start":"2026-07-30T19:06:24.679723Z","end":"2026-07-30T19:06:24.963122Z","steps":["trace[1492695668] 'agreement among raft nodes before linearized reading' (duration: 283.213965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.322348Z","time spent":"640.806305ms","remote":"127.0.0.1:53926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-07-30T19:06:24.963163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.346307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-30T19:06:24.963165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.45382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-30T19:06:24.96325Z","caller":"traceutil/trace.go:171","msg":"trace[1770861061] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5237; }","duration":"822.44076ms","start":"2026-07-30T19:06:24.140788Z","end":"2026-07-30T19:06:24.963229Z","steps":["trace[1770861061] 'agreement among raft nodes before linearized reading' (duration: 822.237275ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:24.963262Z","caller":"traceutil/trace.go:171","msg":"trace[1950547683] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5237; }","duration":"521.596594ms","start":"2026-07-30T19:06:24.441642Z","end":"2026-07-30T19:06:24.963238Z","steps":["trace[1950547683] 'agreement among raft nodes before linearized reading' (duration: 521.327507ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.347037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-30T19:06:24.963289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.140753Z","time spent":"822.527802ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-30T19:06:24.9633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.441615Z","time spent":"521.677426ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-30T19:06:24.963082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.239805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-30T19:06:24.963312Z","caller":"traceutil/trace.go:171","msg":"trace[1700672843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5237; }","duration":"822.435149ms","start":"2026-07-30T19:06:24.140863Z","end":"2026-07-30T19:06:24.963298Z","steps":["trace[1700672843] 'agreement among raft nodes before linearized reading' (duration: 822.246215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.140835Z","time spent":"822.508841ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-30T19:06:24.963371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.003792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:06:24.963321Z","caller":"traceutil/trace.go:171","msg":"trace[1020677093] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"420.804254ms","start":"2026-07-30T19:06:24.542506Z","end":"2026-07-30T19:06:24.96331Z","steps":["trace[1020677093] 'process raft request' (duration: 420.086316ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:24.963403Z","caller":"traceutil/trace.go:171","msg":"trace[1030051116] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5237; }","duration":"236.064624ms","start":"2026-07-30T19:06:24.72733Z","end":"2026-07-30T19:06:24.963395Z","steps":["trace[1030051116] 'agreement among raft nodes before linearized reading' (duration: 236.007332ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:24.963349Z","caller":"traceutil/trace.go:171","msg":"trace[1883141743] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:5237; }","duration":"822.575433ms","start":"2026-07-30T19:06:24.140761Z","end":"2026-07-30T19:06:24.963336Z","steps":["trace[1883141743] 'agreement among raft nodes before linearized reading' (duration: 822.210644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.140749Z","time spent":"822.679425ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-30T19:06:24.963466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.54247Z","time spent":"420.936127ms","remote":"127.0.0.1:54158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:06:24.963067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.463892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:06:24.963556Z","caller":"traceutil/trace.go:171","msg":"trace[262738261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5237; }","duration":"812.000555ms","start":"2026-07-30T19:06:24.15154Z","end":"2026-07-30T19:06:24.96354Z","steps":["trace[262738261] 'agreement among raft nodes before linearized reading' (duration: 811.447032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.151521Z","time spent":"812.066076ms","remote":"127.0.0.1:35978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:06:24.963932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.946366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T19:06:24.963967Z","caller":"traceutil/trace.go:171","msg":"trace[749871746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5237; }","duration":"522.982467ms","start":"2026-07-30T19:06:24.440976Z","end":"2026-07-30T19:06:24.963959Z","steps":["trace[749871746] 'agreement among raft nodes before linearized reading' (duration: 522.138057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:06:24.963995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:06:24.440944Z","time spent":"523.04352ms","remote":"127.0.0.1:54158","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-07-30T19:10:41.264127Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4965} {"level":"info","ts":"2026-07-30T19:10:41.303861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4965,"took":"38.450466ms","hash":440566910,"current-db-size-bytes":35487744,"current-db-size":"36 MB","current-db-size-in-use-bytes":11698176,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-07-30T19:10:41.30392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":440566910,"revision":4965,"compact-revision":3043} {"level":"info","ts":"2026-07-30T19:15:41.270412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7246} {"level":"info","ts":"2026-07-30T19:15:41.324083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7246,"took":"52.28839ms","hash":2561566972,"current-db-size-bytes":35487744,"current-db-size":"36 MB","current-db-size-in-use-bytes":11673600,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-07-30T19:15:41.32416Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2561566972,"revision":7246,"compact-revision":4965} {"level":"info","ts":"2026-07-30T19:16:05.880427Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T19:16:05.885664Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-30T19:16:05.885816Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-30T19:20:41.276372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9526} {"level":"info","ts":"2026-07-30T19:20:41.334746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9526,"took":"57.015979ms","hash":1630157678,"current-db-size-bytes":35487744,"current-db-size":"36 MB","current-db-size-in-use-bytes":9723904,"current-db-size-in-use":"9.7 MB"} {"level":"info","ts":"2026-07-30T19:20:41.334912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1630157678,"revision":9526,"compact-revision":7246}