{"level":"warn","ts":"2026-07-14T05:08:40.633302Z","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-14T05:08:40.633428Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-14T05:08:40.633522Z","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-14T05:08:40.63354Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-14T05:08:40.634915Z","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-14T05:08:40.636402Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-07-14T05:08:40.636525Z","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.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-14T05:08:40.641176Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.341167ms"} {"level":"info","ts":"2026-07-14T05:08:40.646357Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-07-14T05:08:40.646432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T05:08:40.646463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-07-14T05:08:40.646475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T05:08:40.646489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-07-14T05:08:40.646538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-07-14T05:08:40.652302Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T05:08:40.653952Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T05:08:40.655033Z","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-14T05:08:40.657345Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T05:08:40.658886Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T05:08:40.658938Z","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-14T05:08:40.65907Z","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-14T05:08:40.659091Z","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-14T05:08:40.661477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-07-14T05:08:40.661907Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-14T05:08:40.663753Z","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-14T05:08:40.664028Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T05:08:40.664077Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T05:08:40.66423Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-14T05:08:40.664255Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-14T05:08:41.047545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T05:08:41.047646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T05:08:41.047683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-07-14T05:08:41.047707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-07-14T05:08:41.047716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-14T05:08:41.047749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-07-14T05:08:41.04776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-14T05:08:41.051179Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T05:08:41.052219Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T05:08:41.052229Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T05:08:41.052564Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T05:08:41.052716Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T05:08:41.052781Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T05:08:41.053234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T05:08:41.053349Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T05:08:41.053387Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T05:08:41.056245Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T05:08:41.064304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-07-14T05:08:59.390963Z","caller":"traceutil/trace.go:171","msg":"trace[1057674307] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"130.763132ms","start":"2026-07-14T05:08:59.260178Z","end":"2026-07-14T05:08:59.390941Z","steps":["trace[1057674307] 'process raft request' (duration: 130.219868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:08:59.740574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.6324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:08:59.74065Z","caller":"traceutil/trace.go:171","msg":"trace[1500603219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:381; }","duration":"180.729321ms","start":"2026-07-14T05:08:59.559908Z","end":"2026-07-14T05:08:59.740637Z","steps":["trace[1500603219] 'range keys from in-memory index tree' (duration: 180.4852ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:09:22.089852Z","caller":"traceutil/trace.go:171","msg":"trace[1739164223] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"158.346499ms","start":"2026-07-14T05:09:21.931473Z","end":"2026-07-14T05:09:22.08982Z","steps":["trace[1739164223] 'process raft request' (duration: 158.143708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:09:22.375562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.971373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T05:09:22.375747Z","caller":"traceutil/trace.go:171","msg":"trace[884489829] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"199.778718ms","start":"2026-07-14T05:09:22.17594Z","end":"2026-07-14T05:09:22.375718Z","steps":["trace[884489829] 'read index received' (duration: 44.76µs)","trace[884489829] 'applied index is now lower than readState.Index' (duration: 199.731878ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:09:22.375851Z","caller":"traceutil/trace.go:171","msg":"trace[896641817] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"415.57918ms","start":"2026-07-14T05:09:21.96019Z","end":"2026-07-14T05:09:22.37577Z","steps":["trace[896641817] 'process raft request' (duration: 213.749663ms)","trace[896641817] 'compare' (duration: 199.684627ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:09:22.375933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.992239ms","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-07-14T05:09:22.37599Z","caller":"traceutil/trace.go:171","msg":"trace[1221900211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"200.104849ms","start":"2026-07-14T05:09:22.17587Z","end":"2026-07-14T05:09:22.375975Z","steps":["trace[1221900211] 'agreement among raft nodes before linearized reading' (duration: 199.916198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:09:22.376196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:09:21.960159Z","time spent":"415.850761ms","remote":"127.0.0.1:50872","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-14T05:09:23.020044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.751623ms","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-14T05:09:23.020164Z","caller":"traceutil/trace.go:171","msg":"trace[1699944185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"161.934163ms","start":"2026-07-14T05:09:22.858205Z","end":"2026-07-14T05:09:23.020139Z","steps":["trace[1699944185] 'range keys from in-memory index tree' (duration: 161.478181ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:09:38.48478Z","caller":"traceutil/trace.go:171","msg":"trace[1901601988] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"206.488866ms","start":"2026-07-14T05:09:38.278267Z","end":"2026-07-14T05:09:38.484756Z","steps":["trace[1901601988] 'process raft request' (duration: 206.353511ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:10:11.460824Z","caller":"traceutil/trace.go:171","msg":"trace[92504318] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"182.357195ms","start":"2026-07-14T05:10:11.27843Z","end":"2026-07-14T05:10:11.460787Z","steps":["trace[92504318] 'process raft request' (duration: 182.151081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:58.720836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.045654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T05:10:58.720986Z","caller":"traceutil/trace.go:171","msg":"trace[1175743429] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"339.295251ms","start":"2026-07-14T05:10:58.381665Z","end":"2026-07-14T05:10:58.72096Z","steps":["trace[1175743429] 'process raft request' (duration: 235.004633ms)","trace[1175743429] 'compare' (duration: 103.833551ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:10:58.721204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:10:58.38165Z","time spent":"339.384602ms","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:10:58.795484Z","caller":"traceutil/trace.go:171","msg":"trace[123849950] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1916; }","duration":"389.742692ms","start":"2026-07-14T05:10:58.405713Z","end":"2026-07-14T05:10:58.795456Z","steps":["trace[123849950] 'read index received' (duration: 211.175309ms)","trace[123849950] 'applied index is now lower than readState.Index' (duration: 178.566433ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:10:58.79555Z","caller":"traceutil/trace.go:171","msg":"trace[287471187] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"406.983189ms","start":"2026-07-14T05:10:58.38854Z","end":"2026-07-14T05:10:58.795523Z","steps":["trace[287471187] 'process raft request' (duration: 406.768876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:58.796328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:10:58.388491Z","time spent":"407.659421ms","remote":"127.0.0.1:50958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:10:58.795788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.049937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc8706be-719c-4a3c-ac56-a8a14258d5df\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-14T05:10:58.796561Z","caller":"traceutil/trace.go:171","msg":"trace[2142170467] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc8706be-719c-4a3c-ac56-a8a14258d5df; range_end:; response_count:1; response_revision:1846; }","duration":"390.79731ms","start":"2026-07-14T05:10:58.405678Z","end":"2026-07-14T05:10:58.796475Z","steps":["trace[2142170467] 'agreement among raft nodes before linearized reading' (duration: 389.925856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:58.796712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:10:58.405665Z","time spent":"390.954482ms","remote":"127.0.0.1:50958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc8706be-719c-4a3c-ac56-a8a14258d5df\" "} {"level":"warn","ts":"2026-07-14T05:10:58.797014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.046061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:10:58.797062Z","caller":"traceutil/trace.go:171","msg":"trace[58019879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"238.132863ms","start":"2026-07-14T05:10:58.558918Z","end":"2026-07-14T05:10:58.79705Z","steps":["trace[58019879] 'agreement among raft nodes before linearized reading' (duration: 238.042322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:59.096226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.027409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T05:10:59.09646Z","caller":"traceutil/trace.go:171","msg":"trace[170517753] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"294.0293ms","start":"2026-07-14T05:10:58.802398Z","end":"2026-07-14T05:10:59.096428Z","steps":["trace[170517753] 'process raft request' (duration: 19.638176ms)","trace[170517753] 'compare' (duration: 273.910997ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:10:59.096536Z","caller":"traceutil/trace.go:171","msg":"trace[698438434] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"293.772267ms","start":"2026-07-14T05:10:58.802738Z","end":"2026-07-14T05:10:59.096511Z","steps":["trace[698438434] 'process raft request' (duration: 293.643995ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:10:59.096483Z","caller":"traceutil/trace.go:171","msg":"trace[2018036000] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1918; }","duration":"292.051398ms","start":"2026-07-14T05:10:58.804418Z","end":"2026-07-14T05:10:59.096469Z","steps":["trace[2018036000] 'read index received' (duration: 17.630913ms)","trace[2018036000] 'applied index is now lower than readState.Index' (duration: 274.419575ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:10:59.096631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.21758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fc8706be-719c-4a3c-ac56-a8a14258d5df\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-14T05:10:59.096666Z","caller":"traceutil/trace.go:171","msg":"trace[2014040471] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fc8706be-719c-4a3c-ac56-a8a14258d5df; range_end:; response_count:1; response_revision:1850; }","duration":"292.283411ms","start":"2026-07-14T05:10:58.804372Z","end":"2026-07-14T05:10:59.096656Z","steps":["trace[2014040471] 'agreement among raft nodes before linearized reading' (duration: 292.136809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:59.096855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.727768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T05:10:59.096989Z","caller":"traceutil/trace.go:171","msg":"trace[1558818385] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1850; }","duration":"272.932841ms","start":"2026-07-14T05:10:58.824032Z","end":"2026-07-14T05:10:59.096965Z","steps":["trace[1558818385] 'agreement among raft nodes before linearized reading' (duration: 272.709156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:59.097086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.735515ms","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-07-14T05:10:59.097141Z","caller":"traceutil/trace.go:171","msg":"trace[133484034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1850; }","duration":"160.832776ms","start":"2026-07-14T05:10:58.936295Z","end":"2026-07-14T05:10:59.097127Z","steps":["trace[133484034] 'agreement among raft nodes before linearized reading' (duration: 160.669914ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:10:59.096474Z","caller":"traceutil/trace.go:171","msg":"trace[1421092432] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"293.733766ms","start":"2026-07-14T05:10:58.802708Z","end":"2026-07-14T05:10:59.096442Z","steps":["trace[1421092432] 'process raft request' (duration: 293.616614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:10:59.097371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.094292ms","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-07-14T05:10:59.097495Z","caller":"traceutil/trace.go:171","msg":"trace[458197560] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"294.661269ms","start":"2026-07-14T05:10:58.802815Z","end":"2026-07-14T05:10:59.097476Z","steps":["trace[458197560] 'process raft request' (duration: 293.616842ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:10:59.097452Z","caller":"traceutil/trace.go:171","msg":"trace[1498095676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1850; }","duration":"135.222035ms","start":"2026-07-14T05:10:58.962212Z","end":"2026-07-14T05:10:59.097434Z","steps":["trace[1498095676] 'agreement among raft nodes before linearized reading' (duration: 134.656146ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:11:09.87124Z","caller":"traceutil/trace.go:171","msg":"trace[2130804908] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"195.102032ms","start":"2026-07-14T05:11:09.676108Z","end":"2026-07-14T05:11:09.87121Z","steps":["trace[2130804908] 'process raft request' (duration: 194.92314ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:11:28.078741Z","caller":"traceutil/trace.go:171","msg":"trace[1941234686] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2136; }","duration":"118.173829ms","start":"2026-07-14T05:11:27.960545Z","end":"2026-07-14T05:11:28.078718Z","steps":["trace[1941234686] 'read index received' (duration: 56.620464ms)","trace[1941234686] 'applied index is now lower than readState.Index' (duration: 61.552245ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:11:28.078857Z","caller":"traceutil/trace.go:171","msg":"trace[1146285243] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"135.621179ms","start":"2026-07-14T05:11:27.943193Z","end":"2026-07-14T05:11:28.078814Z","steps":["trace[1146285243] 'process raft request' (duration: 112.521217ms)","trace[1146285243] 'compare' (duration: 22.9164ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:11:28.078978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.412172ms","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-14T05:11:28.079032Z","caller":"traceutil/trace.go:171","msg":"trace[474213490] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2060; }","duration":"118.491983ms","start":"2026-07-14T05:11:27.960517Z","end":"2026-07-14T05:11:28.079009Z","steps":["trace[474213490] 'agreement among raft nodes before linearized reading' (duration: 118.30316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:11:28.603911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.201864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-14T05:11:28.603982Z","caller":"traceutil/trace.go:171","msg":"trace[1174656752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2061; }","duration":"354.324855ms","start":"2026-07-14T05:11:28.249641Z","end":"2026-07-14T05:11:28.603966Z","steps":["trace[1174656752] 'range keys from in-memory index tree' (duration: 354.054642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:11:28.604018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:11:28.249607Z","time spent":"354.403186ms","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T05:11:28.604068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.667417ms","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-07-14T05:11:28.604131Z","caller":"traceutil/trace.go:171","msg":"trace[819404743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2061; }","duration":"350.737707ms","start":"2026-07-14T05:11:28.253362Z","end":"2026-07-14T05:11:28.6041Z","steps":["trace[819404743] 'range keys from in-memory index tree' (duration: 350.553765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:11:28.604162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:11:28.253352Z","time spent":"350.802908ms","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T05:11:28.846033Z","caller":"traceutil/trace.go:171","msg":"trace[134360762] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"237.367115ms","start":"2026-07-14T05:11:28.608639Z","end":"2026-07-14T05:11:28.846006Z","steps":["trace[134360762] 'process raft request' (duration: 237.172502ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:11:28.873909Z","caller":"traceutil/trace.go:171","msg":"trace[1649503639] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"264.747663ms","start":"2026-07-14T05:11:28.609085Z","end":"2026-07-14T05:11:28.873832Z","steps":["trace[1649503639] 'process raft request' (duration: 264.430489ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:11:28.874041Z","caller":"traceutil/trace.go:171","msg":"trace[1444250527] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"258.480102ms","start":"2026-07-14T05:11:28.615468Z","end":"2026-07-14T05:11:28.873948Z","steps":["trace[1444250527] 'process raft request' (duration: 258.214608ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:11:28.873951Z","caller":"traceutil/trace.go:171","msg":"trace[1162148428] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"139.449724ms","start":"2026-07-14T05:11:28.734406Z","end":"2026-07-14T05:11:28.873856Z","steps":["trace[1162148428] 'process raft request' (duration: 139.329813ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:13:10.55677Z","caller":"traceutil/trace.go:171","msg":"trace[205180227] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"117.134205ms","start":"2026-07-14T05:13:10.43962Z","end":"2026-07-14T05:13:10.556754Z","steps":["trace[205180227] 'process raft request' (duration: 117.035674ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:13:10.724626Z","caller":"traceutil/trace.go:171","msg":"trace[1661033399] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"163.863339ms","start":"2026-07-14T05:13:10.56073Z","end":"2026-07-14T05:13:10.724593Z","steps":["trace[1661033399] 'process raft request' (duration: 163.646728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:07.282671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.675943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-14T05:17:07.282841Z","caller":"traceutil/trace.go:171","msg":"trace[1352171200] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"151.840185ms","start":"2026-07-14T05:17:07.130972Z","end":"2026-07-14T05:17:07.282812Z","steps":["trace[1352171200] 'process raft request' (duration: 30.933848ms)","trace[1352171200] 'compare' (duration: 120.42847ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:17:07.447296Z","caller":"traceutil/trace.go:171","msg":"trace[1195447674] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"151.090623ms","start":"2026-07-14T05:17:07.296183Z","end":"2026-07-14T05:17:07.447274Z","steps":["trace[1195447674] 'process raft request' (duration: 150.864069ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:17:07.447249Z","caller":"traceutil/trace.go:171","msg":"trace[397687730] linearizableReadLoop","detail":"{readStateIndex:4857; appliedIndex:4856; }","duration":"136.331615ms","start":"2026-07-14T05:17:07.310893Z","end":"2026-07-14T05:17:07.447224Z","steps":["trace[397687730] 'read index received' (duration: 136.144672ms)","trace[397687730] 'applied index is now lower than readState.Index' (duration: 184.793µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:17:07.447587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.736167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1652"} {"level":"warn","ts":"2026-07-14T05:17:07.447593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.117536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1652"} {"level":"info","ts":"2026-07-14T05:17:07.447655Z","caller":"traceutil/trace.go:171","msg":"trace[605056532] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4679; }","duration":"153.209257ms","start":"2026-07-14T05:17:07.29443Z","end":"2026-07-14T05:17:07.44764Z","steps":["trace[605056532] 'agreement among raft nodes before linearized reading' (duration: 152.987174ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:17:07.447647Z","caller":"traceutil/trace.go:171","msg":"trace[1084867317] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4679; }","duration":"157.837208ms","start":"2026-07-14T05:17:07.289794Z","end":"2026-07-14T05:17:07.447631Z","steps":["trace[1084867317] 'agreement among raft nodes before linearized reading' (duration: 157.550274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:07.457006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.417995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4cb0fb6f-3290-4d4b-b848-80e024dbfa22\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-07-14T05:17:07.457063Z","caller":"traceutil/trace.go:171","msg":"trace[80840376] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4cb0fb6f-3290-4d4b-b848-80e024dbfa22; range_end:; response_count:1; response_revision:4682; }","duration":"143.504565ms","start":"2026-07-14T05:17:07.313546Z","end":"2026-07-14T05:17:07.45705Z","steps":["trace[80840376] 'agreement among raft nodes before linearized reading' (duration: 143.351943ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:17:07.457309Z","caller":"traceutil/trace.go:171","msg":"trace[881616703] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"143.986234ms","start":"2026-07-14T05:17:07.313309Z","end":"2026-07-14T05:17:07.457295Z","steps":["trace[881616703] 'process raft request' (duration: 143.362404ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:17:08.076455Z","caller":"traceutil/trace.go:171","msg":"trace[728768613] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"316.703569ms","start":"2026-07-14T05:17:07.759703Z","end":"2026-07-14T05:17:08.076406Z","steps":["trace[728768613] 'process raft request' (duration: 316.290012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:08.076876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:17:07.75966Z","time spent":"316.911472ms","remote":"127.0.0.1:50848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":130730,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:17:08.07712Z","caller":"traceutil/trace.go:171","msg":"trace[150014697] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4871; }","duration":"171.491176ms","start":"2026-07-14T05:17:07.905595Z","end":"2026-07-14T05:17:08.077086Z","steps":["trace[150014697] 'read index received' (duration: 170.333408ms)","trace[150014697] 'applied index is now lower than readState.Index' (duration: 1.156178ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:17:08.077248Z","caller":"traceutil/trace.go:171","msg":"trace[1874758051] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"265.816723ms","start":"2026-07-14T05:17:07.811363Z","end":"2026-07-14T05:17:08.07718Z","steps":["trace[1874758051] 'process raft request' (duration: 265.482578ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:17:08.077287Z","caller":"traceutil/trace.go:171","msg":"trace[1447728566] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"226.352293ms","start":"2026-07-14T05:17:07.8509Z","end":"2026-07-14T05:17:08.077252Z","steps":["trace[1447728566] 'process raft request' (duration: 226.1098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:08.077367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.737139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:17:08.077431Z","caller":"traceutil/trace.go:171","msg":"trace[64588484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4696; }","duration":"171.884993ms","start":"2026-07-14T05:17:07.90553Z","end":"2026-07-14T05:17:08.077415Z","steps":["trace[64588484] 'agreement among raft nodes before linearized reading' (duration: 171.75937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:08.077536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.068134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T05:17:08.077577Z","caller":"traceutil/trace.go:171","msg":"trace[1536995778] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:4696; }","duration":"122.180816ms","start":"2026-07-14T05:17:07.955381Z","end":"2026-07-14T05:17:08.077562Z","steps":["trace[1536995778] 'agreement among raft nodes before linearized reading' (duration: 122.088034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:17:08.07779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.320704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-14T05:17:08.077852Z","caller":"traceutil/trace.go:171","msg":"trace[1939314764] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4696; }","duration":"116.412836ms","start":"2026-07-14T05:17:07.961413Z","end":"2026-07-14T05:17:08.077825Z","steps":["trace[1939314764] 'agreement among raft nodes before linearized reading' (duration: 116.220093ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:18:41.221559Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881} {"level":"info","ts":"2026-07-14T05:18:41.342514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"119.613152ms","hash":924748167,"current-db-size-bytes":55046144,"current-db-size":"55 MB","current-db-size-in-use-bytes":29323264,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-14T05:18:41.342571Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":924748167,"revision":2881,"compact-revision":-1} {"level":"warn","ts":"2026-07-14T05:20:06.486475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:06.987569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:07.487729Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:07.988808Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:08.489981Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:08.991128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:09.492438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:09.559546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000354334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-14T05:20:09.559649Z","caller":"traceutil/trace.go:171","msg":"trace[1492731203] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000496946s","start":"2026-07-14T05:20:07.559117Z","end":"2026-07-14T05:20:09.559614Z","steps":["trace[1492731203] 'agreement among raft nodes before linearized reading' (duration: 2.000381934s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:09.559703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.559104Z","time spent":"2.000588547s","remote":"127.0.0.1:50812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-14T05:20:09.994694Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:10.495203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:10.603593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.198078ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.603757Z","caller":"traceutil/trace.go:171","msg":"trace[1312716933] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6040; }","duration":"645.37527ms","start":"2026-07-14T05:20:09.958358Z","end":"2026-07-14T05:20:10.603733Z","steps":["trace[1312716933] 'range keys from in-memory index tree' (duration: 645.175258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.604962Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.683871994s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T05:20:10.605547Z","caller":"traceutil/trace.go:171","msg":"trace[1039744253] transaction","detail":"{read_only:false; response_revision:6041; number_of_response:1; }","duration":"4.684579342s","start":"2026-07-14T05:20:05.920947Z","end":"2026-07-14T05:20:10.605526Z","steps":["trace[1039744253] 'process raft request' (duration: 4.684214387s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.605779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:05.920919Z","time spent":"4.684671182s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:10.609271Z","caller":"traceutil/trace.go:171","msg":"trace[1039838182] transaction","detail":"{read_only:false; response_revision:6042; number_of_response:1; }","duration":"4.481133761s","start":"2026-07-14T05:20:06.128122Z","end":"2026-07-14T05:20:10.609255Z","steps":["trace[1039838182] 'process raft request' (duration: 4.480697515s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.60935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.128095Z","time spent":"4.481214331s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:10.609677Z","caller":"traceutil/trace.go:171","msg":"trace[1592830943] transaction","detail":"{read_only:false; response_revision:6043; number_of_response:1; }","duration":"4.160912278s","start":"2026-07-14T05:20:06.44873Z","end":"2026-07-14T05:20:10.609642Z","steps":["trace[1592830943] 'process raft request' (duration: 4.160153819s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.609759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.448705Z","time spent":"4.16102076s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:10.60978Z","caller":"traceutil/trace.go:171","msg":"trace[1288661449] transaction","detail":"{read_only:false; response_revision:6046; number_of_response:1; }","duration":"2.951231691s","start":"2026-07-14T05:20:07.658494Z","end":"2026-07-14T05:20:10.609726Z","steps":["trace[1288661449] 'process raft request' (duration: 2.950456862s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:10.609904Z","caller":"traceutil/trace.go:171","msg":"trace[799964997] transaction","detail":"{read_only:false; response_revision:6045; number_of_response:1; }","duration":"3.081478653s","start":"2026-07-14T05:20:07.528381Z","end":"2026-07-14T05:20:10.609859Z","steps":["trace[799964997] 'process raft request' (duration: 3.080550172s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:10.609929Z","caller":"traceutil/trace.go:171","msg":"trace[1241008676] transaction","detail":"{read_only:false; response_revision:6047; number_of_response:1; }","duration":"1.560915962s","start":"2026-07-14T05:20:09.048986Z","end":"2026-07-14T05:20:10.609902Z","steps":["trace[1241008676] 'process raft request' (duration: 1.559986832s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.610342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.528353Z","time spent":"3.081931317s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:10.610438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:09.048961Z","time spent":"1.561402828s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:10.610538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.658466Z","time spent":"2.951578335s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:10.611075Z","caller":"traceutil/trace.go:171","msg":"trace[860853290] transaction","detail":"{read_only:false; response_revision:6044; number_of_response:1; }","duration":"3.884920477s","start":"2026-07-14T05:20:06.726145Z","end":"2026-07-14T05:20:10.611065Z","steps":["trace[860853290] 'process raft request' (duration: 3.882764751s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.611182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.72612Z","time spent":"3.885031248s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:10.613748Z","caller":"traceutil/trace.go:171","msg":"trace[564828620] linearizableReadLoop","detail":"{readStateIndex:6268; appliedIndex:6261; }","duration":"4.627300814s","start":"2026-07-14T05:20:05.986421Z","end":"2026-07-14T05:20:10.613722Z","steps":["trace[564828620] 'read index received' (duration: 4.619397429s)","trace[564828620] 'applied index is now lower than readState.Index' (duration: 7.901975ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:20:10.613989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.627560697s","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-07-14T05:20:10.614021Z","caller":"traceutil/trace.go:171","msg":"trace[841603150] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6047; }","duration":"4.627615547s","start":"2026-07-14T05:20:05.986398Z","end":"2026-07-14T05:20:10.614014Z","steps":["trace[841603150] 'agreement among raft nodes before linearized reading' (duration: 4.627454985s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:05.986338Z","time spent":"4.627704918s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T05:20:10.614069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.621354303s","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-14T05:20:10.614119Z","caller":"traceutil/trace.go:171","msg":"trace[1489736666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6047; }","duration":"4.621434053s","start":"2026-07-14T05:20:05.992673Z","end":"2026-07-14T05:20:10.614107Z","steps":["trace[1489736666] 'agreement among raft nodes before linearized reading' (duration: 4.621248931s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:05.992658Z","time spent":"4.621479994s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T05:20:10.61417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.458963237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.614208Z","caller":"traceutil/trace.go:171","msg":"trace[1246759629] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:6047; }","duration":"3.459041108s","start":"2026-07-14T05:20:07.155159Z","end":"2026-07-14T05:20:10.6142Z","steps":["trace[1246759629] 'agreement among raft nodes before linearized reading' (duration: 3.458954517s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.61425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.641720139s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-14T05:20:10.614257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.155138Z","time spent":"3.459109429s","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-07-14T05:20:10.614272Z","caller":"traceutil/trace.go:171","msg":"trace[422827915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6047; }","duration":"3.64178254s","start":"2026-07-14T05:20:06.972484Z","end":"2026-07-14T05:20:10.614266Z","steps":["trace[422827915] 'agreement among raft nodes before linearized reading' (duration: 3.641721739s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.97246Z","time spent":"3.64183117s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T05:20:10.6144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.721416365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-07-14T05:20:10.61441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.476444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.614424Z","caller":"traceutil/trace.go:171","msg":"trace[2127486702] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6047; }","duration":"3.721440246s","start":"2026-07-14T05:20:06.892978Z","end":"2026-07-14T05:20:10.614419Z","steps":["trace[2127486702] 'agreement among raft nodes before linearized reading' (duration: 3.721356585s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:10.614433Z","caller":"traceutil/trace.go:171","msg":"trace[2096826076] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:6047; }","duration":"152.538595ms","start":"2026-07-14T05:20:10.461888Z","end":"2026-07-14T05:20:10.614426Z","steps":["trace[2096826076] 'agreement among raft nodes before linearized reading' (duration: 152.501034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.892919Z","time spent":"3.721518176s","remote":"127.0.0.1:50958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-14T05:20:10.614446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.985569104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.614482Z","caller":"traceutil/trace.go:171","msg":"trace[1830816520] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:6047; }","duration":"3.985649764s","start":"2026-07-14T05:20:06.628821Z","end":"2026-07-14T05:20:10.614471Z","steps":["trace[1830816520] 'agreement among raft nodes before linearized reading' (duration: 3.985596274s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.628797Z","time spent":"3.985709345s","remote":"127.0.0.1:43020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:10.614589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.075801576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.614618Z","caller":"traceutil/trace.go:171","msg":"trace[1397283973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:6047; }","duration":"4.075873149s","start":"2026-07-14T05:20:06.538738Z","end":"2026-07-14T05:20:10.614611Z","steps":["trace[1397283973] 'agreement among raft nodes before linearized reading' (duration: 4.075813288s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.538708Z","time spent":"4.075923399s","remote":"127.0.0.1:59438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:10.614697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.984556672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.614738Z","caller":"traceutil/trace.go:171","msg":"trace[435513096] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:6047; }","duration":"3.984612513s","start":"2026-07-14T05:20:06.630112Z","end":"2026-07-14T05:20:10.614724Z","steps":["trace[435513096] 'agreement among raft nodes before linearized reading' (duration: 3.984555342s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.614776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.630103Z","time spent":"3.984659234s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:10.614814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.157860571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T05:20:10.615053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.972509332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.615094Z","caller":"traceutil/trace.go:171","msg":"trace[1707643655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:6047; }","duration":"1.972604053s","start":"2026-07-14T05:20:08.64248Z","end":"2026-07-14T05:20:10.615084Z","steps":["trace[1707643655] 'agreement among raft nodes before linearized reading' (duration: 1.972539482s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.615152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:08.642451Z","time spent":"1.972690664s","remote":"127.0.0.1:59412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:10.615308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054463818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:10.615346Z","caller":"traceutil/trace.go:171","msg":"trace[729174815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6047; }","duration":"1.054537549s","start":"2026-07-14T05:20:09.560798Z","end":"2026-07-14T05:20:10.615336Z","steps":["trace[729174815] 'agreement among raft nodes before linearized reading' (duration: 1.054481058s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.615371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:09.560776Z","time spent":"1.054588459s","remote":"127.0.0.1:50806","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-14T05:20:10.615544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.702886501s","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-14T05:20:10.615583Z","caller":"traceutil/trace.go:171","msg":"trace[694966177] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:6047; }","duration":"1.702968623s","start":"2026-07-14T05:20:08.912604Z","end":"2026-07-14T05:20:10.615572Z","steps":["trace[694966177] 'agreement among raft nodes before linearized reading' (duration: 1.702886262s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.615612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:08.912578Z","time spent":"1.703024633s","remote":"127.0.0.1:59316","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-14T05:20:10.616246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.248216751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T05:20:10.616288Z","caller":"traceutil/trace.go:171","msg":"trace[1652775589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6047; }","duration":"3.248299662s","start":"2026-07-14T05:20:07.367978Z","end":"2026-07-14T05:20:10.616278Z","steps":["trace[1652775589] 'agreement among raft nodes before linearized reading' (duration: 3.24819589s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.61632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.367957Z","time spent":"3.248355092s","remote":"127.0.0.1:51050","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-14T05:20:10.616493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.054916453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-14T05:20:10.61653Z","caller":"traceutil/trace.go:171","msg":"trace[1093930646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6047; }","duration":"3.054998914s","start":"2026-07-14T05:20:07.561522Z","end":"2026-07-14T05:20:10.616521Z","steps":["trace[1093930646] 'agreement among raft nodes before linearized reading' (duration: 3.054911463s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.616563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:07.561511Z","time spent":"3.055045115s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T05:20:10.614839Z","caller":"traceutil/trace.go:171","msg":"trace[829175287] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:6047; }","duration":"4.157886001s","start":"2026-07-14T05:20:06.456947Z","end":"2026-07-14T05:20:10.614833Z","steps":["trace[829175287] 'agreement among raft nodes before linearized reading' (duration: 4.15778328s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:10.620956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:06.456919Z","time spent":"4.163990835s","remote":"127.0.0.1:50872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":61,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:15.06038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:15.560969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:16.061571Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:16.560241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999882979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-14T05:20:16.56034Z","caller":"traceutil/trace.go:171","msg":"trace[322932873] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000035761s","start":"2026-07-14T05:20:14.560284Z","end":"2026-07-14T05:20:16.560319Z","steps":["trace[322932873] 'agreement among raft nodes before linearized reading' (duration: 1.999915589s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:16.560441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.560265Z","time spent":"2.000130242s","remote":"127.0.0.1:50812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 05:20:16 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T05:20:16.562495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:17.063483Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186441727081583,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-14T05:20:17.346195Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.175441328s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-14T05:20:17.34686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.170647Z","time spent":"3.176208327s","remote":"127.0.0.1:50816","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-14T05:20:17.356748Z","caller":"traceutil/trace.go:171","msg":"trace[398942248] transaction","detail":"{read_only:false; response_revision:6064; number_of_response:1; }","duration":"2.73638356s","start":"2026-07-14T05:20:14.620348Z","end":"2026-07-14T05:20:17.356731Z","steps":["trace[398942248] 'process raft request' (duration: 2.736315669s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.356871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.620322Z","time spent":"2.736481001s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:17.357756Z","caller":"traceutil/trace.go:171","msg":"trace[1752355018] transaction","detail":"{read_only:false; response_revision:6067; number_of_response:1; }","duration":"2.732228811s","start":"2026-07-14T05:20:14.625498Z","end":"2026-07-14T05:20:17.357726Z","steps":["trace[1752355018] 'process raft request' (duration: 2.732035479s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:17.357902Z","caller":"traceutil/trace.go:171","msg":"trace[1150950091] linearizableReadLoop","detail":"{readStateIndex:6290; appliedIndex:6283; }","duration":"2.79755418s","start":"2026-07-14T05:20:14.560336Z","end":"2026-07-14T05:20:17.35789Z","steps":["trace[1150950091] 'read index received' (duration: 2.786266785s)","trace[1150950091] 'applied index is now lower than readState.Index' (duration: 11.285925ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T05:20:17.357919Z","caller":"traceutil/trace.go:171","msg":"trace[569791216] transaction","detail":"{read_only:false; response_revision:6068; number_of_response:1; }","duration":"1.850474086s","start":"2026-07-14T05:20:15.507423Z","end":"2026-07-14T05:20:17.357897Z","steps":["trace[569791216] 'process raft request' (duration: 1.850160692s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.62547Z","time spent":"2.732463583s","remote":"127.0.0.1:51050","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-14T05:20:17.358091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.722993861s","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-14T05:20:17.358085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:15.507396Z","time spent":"1.850601117s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:17.358145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.778832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:17.358181Z","caller":"traceutil/trace.go:171","msg":"trace[687408641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6069; }","duration":"797.859652ms","start":"2026-07-14T05:20:16.560316Z","end":"2026-07-14T05:20:17.358176Z","steps":["trace[687408641] 'agreement among raft nodes before linearized reading' (duration: 797.815411ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:17.357659Z","caller":"traceutil/trace.go:171","msg":"trace[92210139] transaction","detail":"{read_only:false; response_revision:6066; number_of_response:1; }","duration":"2.734933283s","start":"2026-07-14T05:20:14.622695Z","end":"2026-07-14T05:20:17.357628Z","steps":["trace[92210139] 'process raft request' (duration: 2.734657539s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:16.560291Z","time spent":"797.905853ms","remote":"127.0.0.1:50806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-14T05:20:17.357833Z","caller":"traceutil/trace.go:171","msg":"trace[663099447] transaction","detail":"{read_only:false; response_revision:6065; number_of_response:1; }","duration":"2.735848263s","start":"2026-07-14T05:20:14.621739Z","end":"2026-07-14T05:20:17.357587Z","steps":["trace[663099447] 'process raft request' (duration: 2.734965702s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.621712Z","time spent":"2.736541481s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:17.35833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.317602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T05:20:17.358299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.622688Z","time spent":"2.735531859s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:17.358487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.718306373s","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-14T05:20:17.358533Z","caller":"traceutil/trace.go:171","msg":"trace[581280889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6069; }","duration":"2.718381575s","start":"2026-07-14T05:20:14.64014Z","end":"2026-07-14T05:20:17.358522Z","steps":["trace[581280889] 'agreement among raft nodes before linearized reading' (duration: 2.718230533s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.640124Z","time spent":"2.718461736s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T05:20:17.358536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.722323782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-14T05:20:17.358549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.660871345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-14T05:20:17.358353Z","caller":"traceutil/trace.go:171","msg":"trace[455352114] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:6069; }","duration":"873.377422ms","start":"2026-07-14T05:20:16.484966Z","end":"2026-07-14T05:20:17.358343Z","steps":["trace[455352114] 'agreement among raft nodes before linearized reading' (duration: 873.341681ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:17.358648Z","caller":"traceutil/trace.go:171","msg":"trace[1242347728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6069; }","duration":"2.722466203s","start":"2026-07-14T05:20:14.636165Z","end":"2026-07-14T05:20:17.358632Z","steps":["trace[1242347728] 'agreement among raft nodes before linearized reading' (duration: 2.72221355s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:16.484944Z","time spent":"873.710715ms","remote":"127.0.0.1:46764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:17.358665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.718571526s","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-07-14T05:20:17.358691Z","caller":"traceutil/trace.go:171","msg":"trace[879154780] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6069; }","duration":"1.661052987s","start":"2026-07-14T05:20:15.697628Z","end":"2026-07-14T05:20:17.358681Z","steps":["trace[879154780] 'agreement among raft nodes before linearized reading' (duration: 1.660787784s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.636152Z","time spent":"2.722529354s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T05:20:17.358722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.718490666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-14T05:20:17.358737Z","caller":"traceutil/trace.go:171","msg":"trace[1437032287] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6069; }","duration":"2.718632928s","start":"2026-07-14T05:20:14.640061Z","end":"2026-07-14T05:20:17.358694Z","steps":["trace[1437032287] 'agreement among raft nodes before linearized reading' (duration: 2.718380835s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:15.697606Z","time spent":"1.661111768s","remote":"127.0.0.1:50958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-14T05:20:17.358754Z","caller":"traceutil/trace.go:171","msg":"trace[164073798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6069; }","duration":"2.718552606s","start":"2026-07-14T05:20:14.640193Z","end":"2026-07-14T05:20:17.358746Z","steps":["trace[164073798] 'agreement among raft nodes before linearized reading' (duration: 2.718467425s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.358781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.640179Z","time spent":"2.718595997s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T05:20:17.358114Z","caller":"traceutil/trace.go:171","msg":"trace[858161021] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6069; }","duration":"2.723055671s","start":"2026-07-14T05:20:14.635052Z","end":"2026-07-14T05:20:17.358108Z","steps":["trace[858161021] 'agreement among raft nodes before linearized reading' (duration: 2.72292494s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.35878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.640051Z","time spent":"2.718719629s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T05:20:17.358828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.635044Z","time spent":"2.723773189s","remote":"127.0.0.1:51050","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":"info","ts":"2026-07-14T05:20:17.358958Z","caller":"traceutil/trace.go:171","msg":"trace[1706554229] transaction","detail":"{read_only:false; response_revision:6063; number_of_response:1; }","duration":"3.109609882s","start":"2026-07-14T05:20:14.249324Z","end":"2026-07-14T05:20:17.358934Z","steps":["trace[1706554229] 'process raft request' (duration: 3.106841249s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:17.359282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:14.249285Z","time spent":"3.109918145s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:50.559565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000184682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-14T05:20:50.559642Z","caller":"traceutil/trace.go:171","msg":"trace[335109047] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000321783s","start":"2026-07-14T05:20:48.559307Z","end":"2026-07-14T05:20:50.559628Z","steps":["trace[335109047] 'agreement among raft nodes before linearized reading' (duration: 2.000210032s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:50.559685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:48.559291Z","time spent":"2.000385094s","remote":"127.0.0.1:50812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 05:20:50 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T05:20:52.536297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:47.536738Z","time spent":"4.999516497s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/14 05:20:52 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T05:20:52.559759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999645992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-14T05:20:52.559851Z","caller":"traceutil/trace.go:171","msg":"trace[1565383903] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999796894s","start":"2026-07-14T05:20:50.560033Z","end":"2026-07-14T05:20:52.55983Z","steps":["trace[1565383903] 'agreement among raft nodes before linearized reading' (duration: 1.999684693s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:52.55991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:50.560011Z","time spent":"1.999882275s","remote":"127.0.0.1:50806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/14 05:20:52 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-14T05:20:53.658897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.699863634s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:53.659067Z","caller":"traceutil/trace.go:171","msg":"trace[907293476] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6357; }","duration":"3.700025436s","start":"2026-07-14T05:20:49.958994Z","end":"2026-07-14T05:20:53.659019Z","steps":["trace[907293476] 'range keys from in-memory index tree' (duration: 3.699838494s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.659619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.068268879s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T05:20:53.659749Z","caller":"traceutil/trace.go:171","msg":"trace[882201299] transaction","detail":"{read_only:false; response_revision:6358; number_of_response:1; }","duration":"6.126099565s","start":"2026-07-14T05:20:47.533584Z","end":"2026-07-14T05:20:53.659684Z","steps":["trace[882201299] 'process raft request' (duration: 57.691984ms)","trace[882201299] 'compare' (duration: 6.065964433s)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:20:53.659861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:47.533567Z","time spent":"6.126223026s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:53.665173Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.073726963s","expected-duration":"1s"} {"level":"info","ts":"2026-07-14T05:20:53.665862Z","caller":"traceutil/trace.go:171","msg":"trace[617587141] linearizableReadLoop","detail":"{readStateIndex:6591; appliedIndex:6589; }","duration":"6.117664787s","start":"2026-07-14T05:20:47.548167Z","end":"2026-07-14T05:20:53.665832Z","steps":["trace[617587141] 'read index received' (duration: 43.118174ms)","trace[617587141] 'applied index is now lower than readState.Index' (duration: 6.074544713s)"],"step_count":2} {"level":"warn","ts":"2026-07-14T05:20:53.666443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.118243734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-07-14T05:20:53.66654Z","caller":"traceutil/trace.go:171","msg":"trace[1535451961] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6359; }","duration":"6.118368175s","start":"2026-07-14T05:20:47.548138Z","end":"2026-07-14T05:20:53.666506Z","steps":["trace[1535451961] 'agreement among raft nodes before linearized reading' (duration: 6.118113102s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.666588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:47.548128Z","time spent":"6.118451325s","remote":"127.0.0.1:50872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3528,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"info","ts":"2026-07-14T05:20:53.668177Z","caller":"traceutil/trace.go:171","msg":"trace[197080279] transaction","detail":"{read_only:false; response_revision:6360; number_of_response:1; }","duration":"6.052773878s","start":"2026-07-14T05:20:47.61535Z","end":"2026-07-14T05:20:53.668124Z","steps":["trace[197080279] 'process raft request' (duration: 6.052604886s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:53.668234Z","caller":"traceutil/trace.go:171","msg":"trace[1966090941] transaction","detail":"{read_only:false; response_revision:6362; number_of_response:1; }","duration":"4.191888978s","start":"2026-07-14T05:20:49.476321Z","end":"2026-07-14T05:20:53.66821Z","steps":["trace[1966090941] 'process raft request' (duration: 4.191790147s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:53.668242Z","caller":"traceutil/trace.go:171","msg":"trace[1215332936] transaction","detail":"{read_only:false; response_revision:6361; number_of_response:1; }","duration":"5.526894131s","start":"2026-07-14T05:20:48.141318Z","end":"2026-07-14T05:20:53.668212Z","steps":["trace[1215332936] 'process raft request' (duration: 5.526737159s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.66831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:47.615333Z","time spent":"6.05291175s","remote":"127.0.0.1:46802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1533,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T05:20:53.668386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:48.141295Z","time spent":"5.527011592s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:53.668521Z","caller":"traceutil/trace.go:171","msg":"trace[169778481] transaction","detail":"{read_only:false; response_revision:6364; number_of_response:1; }","duration":"4.168556207s","start":"2026-07-14T05:20:49.499948Z","end":"2026-07-14T05:20:53.668504Z","steps":["trace[169778481] 'process raft request' (duration: 4.168231463s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:53.668583Z","caller":"traceutil/trace.go:171","msg":"trace[347898571] transaction","detail":"{read_only:false; response_revision:6365; number_of_response:1; }","duration":"4.167817648s","start":"2026-07-14T05:20:49.500753Z","end":"2026-07-14T05:20:53.668571Z","steps":["trace[347898571] 'process raft request' (duration: 4.167465473s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.668623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.499931Z","time spent":"4.168633638s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:53.668658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.500727Z","time spent":"4.167877508s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:20:53.668702Z","caller":"traceutil/trace.go:171","msg":"trace[303847274] transaction","detail":"{read_only:false; response_revision:6363; number_of_response:1; }","duration":"4.170832873s","start":"2026-07-14T05:20:49.497858Z","end":"2026-07-14T05:20:53.668691Z","steps":["trace[303847274] 'process raft request' (duration: 4.170287126s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.668761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.497831Z","time spent":"4.170904014s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:53.670927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.476295Z","time spent":"4.19197859s","remote":"127.0.0.1:51050","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-14T05:20:53.671657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.826904968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-14T05:20:53.671687Z","caller":"traceutil/trace.go:171","msg":"trace[63702333] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6367; }","duration":"5.826965548s","start":"2026-07-14T05:20:47.844714Z","end":"2026-07-14T05:20:53.671679Z","steps":["trace[63702333] 'agreement among raft nodes before linearized reading' (duration: 5.826868177s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.671708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:47.844698Z","time spent":"5.827002949s","remote":"127.0.0.1:50958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-14T05:20:53.671811Z","caller":"traceutil/trace.go:171","msg":"trace[732398301] transaction","detail":"{read_only:false; response_revision:6366; number_of_response:1; }","duration":"2.812801422s","start":"2026-07-14T05:20:50.859004Z","end":"2026-07-14T05:20:53.671806Z","steps":["trace[732398301] 'process raft request' (duration: 2.812475959s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.671983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104686142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:53.672005Z","caller":"traceutil/trace.go:171","msg":"trace[880694330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6367; }","duration":"1.104727124s","start":"2026-07-14T05:20:52.56727Z","end":"2026-07-14T05:20:53.671997Z","steps":["trace[880694330] 'agreement among raft nodes before linearized reading' (duration: 1.104696533s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:52.567259Z","time spent":"1.104758924s","remote":"127.0.0.1:50812","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-14T05:20:53.672036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.761715366s","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-07-14T05:20:53.672095Z","caller":"traceutil/trace.go:171","msg":"trace[1494872772] 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:6367; }","duration":"2.761830516s","start":"2026-07-14T05:20:50.910246Z","end":"2026-07-14T05:20:53.672077Z","steps":["trace[1494872772] 'agreement among raft nodes before linearized reading' (duration: 2.761673755s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:53.672111Z","caller":"traceutil/trace.go:171","msg":"trace[81176066] transaction","detail":"{read_only:false; response_revision:6367; number_of_response:1; }","duration":"2.300484986s","start":"2026-07-14T05:20:51.37162Z","end":"2026-07-14T05:20:53.672106Z","steps":["trace[81176066] 'process raft request' (duration: 2.29992862s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:51.3716Z","time spent":"2.300525536s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T05:20:53.672133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:50.910226Z","time spent":"2.761896967s","remote":"127.0.0.1:50918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-07-14T05:20:53.672227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109408957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c21060ddd730fe\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-07-14T05:20:53.672256Z","caller":"traceutil/trace.go:171","msg":"trace[2087961939] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18c21060ddd730fe; range_end:; response_count:1; response_revision:6367; }","duration":"1.109470228s","start":"2026-07-14T05:20:52.562776Z","end":"2026-07-14T05:20:53.672247Z","steps":["trace[2087961939] 'agreement among raft nodes before linearized reading' (duration: 1.109379887s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:52.562759Z","time spent":"1.109516959s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c21060ddd730fe\" "} {"level":"warn","ts":"2026-07-14T05:20:53.672355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.631196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-14T05:20:53.672385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.169432017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-14T05:20:53.672401Z","caller":"traceutil/trace.go:171","msg":"trace[860810188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6367; }","duration":"4.169493157s","start":"2026-07-14T05:20:49.502903Z","end":"2026-07-14T05:20:53.672396Z","steps":["trace[860810188] 'agreement among raft nodes before linearized reading' (duration: 4.169445836s)"],"step_count":1} {"level":"info","ts":"2026-07-14T05:20:53.672398Z","caller":"traceutil/trace.go:171","msg":"trace[1547468074] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:6367; }","duration":"654.705777ms","start":"2026-07-14T05:20:53.017679Z","end":"2026-07-14T05:20:53.672384Z","steps":["trace[1547468074] 'agreement among raft nodes before linearized reading' (duration: 654.625146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.50288Z","time spent":"4.169529878s","remote":"127.0.0.1:51050","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-14T05:20:53.672429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:53.017663Z","time spent":"654.758447ms","remote":"127.0.0.1:51246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":18,"response size":29,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.672484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.121600536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T05:20:53.672497Z","caller":"traceutil/trace.go:171","msg":"trace[1125539250] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:6367; }","duration":"3.121645076s","start":"2026-07-14T05:20:50.550848Z","end":"2026-07-14T05:20:53.672493Z","steps":["trace[1125539250] 'agreement among raft nodes before linearized reading' (duration: 3.121612076s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:50.550831Z","time spent":"3.121674876s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":19,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.6725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338379495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T05:20:53.672532Z","caller":"traceutil/trace.go:171","msg":"trace[1942158234] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:6367; }","duration":"1.338453266s","start":"2026-07-14T05:20:52.33407Z","end":"2026-07-14T05:20:53.672523Z","steps":["trace[1942158234] 'agreement among raft nodes before linearized reading' (duration: 1.338389175s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:52.33405Z","time spent":"1.338504118s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.672601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.161707707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-14T05:20:53.672614Z","caller":"traceutil/trace.go:171","msg":"trace[580850185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6367; }","duration":"4.161761407s","start":"2026-07-14T05:20:49.510848Z","end":"2026-07-14T05:20:53.67261Z","steps":["trace[580850185] 'agreement among raft nodes before linearized reading' (duration: 4.161721687s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.510827Z","time spent":"4.161797707s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T05:20:53.672684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.161877259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-14T05:20:53.672694Z","caller":"traceutil/trace.go:171","msg":"trace[1587896944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6367; }","duration":"4.161909209s","start":"2026-07-14T05:20:49.510782Z","end":"2026-07-14T05:20:53.672691Z","steps":["trace[1587896944] 'agreement among raft nodes before linearized reading' (duration: 4.161874959s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.510771Z","time spent":"4.161931689s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-14T05:20:53.672766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.319263906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:53.672795Z","caller":"traceutil/trace.go:171","msg":"trace[757044553] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:6367; }","duration":"2.319327746s","start":"2026-07-14T05:20:51.353459Z","end":"2026-07-14T05:20:53.672787Z","steps":["trace[757044553] 'agreement among raft nodes before linearized reading' (duration: 2.319281586s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.672819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:51.35344Z","time spent":"2.319372167s","remote":"127.0.0.1:50910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.672848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.037075779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T05:20:53.672866Z","caller":"traceutil/trace.go:171","msg":"trace[1175016090] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:6367; }","duration":"5.03713007s","start":"2026-07-14T05:20:48.635728Z","end":"2026-07-14T05:20:53.672858Z","steps":["trace[1175016090] 'agreement among raft nodes before linearized reading' (duration: 5.03710265s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.67288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:48.635705Z","time spent":"5.03717121s","remote":"127.0.0.1:51188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.672974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.393981438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T05:20:53.672987Z","caller":"traceutil/trace.go:171","msg":"trace[848779761] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:6367; }","duration":"4.394039548s","start":"2026-07-14T05:20:49.278944Z","end":"2026-07-14T05:20:53.672984Z","steps":["trace[848779761] 'agreement among raft nodes before linearized reading' (duration: 4.393996298s)"],"step_count":1} {"level":"warn","ts":"2026-07-14T05:20:53.673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:49.278924Z","time spent":"4.39407294s","remote":"127.0.0.1:46772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":23,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-14T05:20:53.671849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T05:20:50.85898Z","time spent":"2.812842583s","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T05:23:41.229435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5554} {"level":"info","ts":"2026-07-14T05:23:41.305459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5554,"took":"74.530035ms","hash":1812776518,"current-db-size-bytes":55046144,"current-db-size":"55 MB","current-db-size-in-use-bytes":18452480,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-14T05:23:41.305518Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1812776518,"revision":5554,"compact-revision":2881}