{"level":"warn","ts":"2026-05-07T00:41:44.725799Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:41:44.725877Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-07T00:41:44.725941Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:41:44.725956Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-07T00:41:44.725974Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-07T00:41:44.726642Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-05-07T00:41:44.72671Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-07T00:41:44.731409Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.382983ms"} {"level":"info","ts":"2026-05-07T00:41:44.741797Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-05-07T00:41:44.741874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T00:41:44.741895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-05-07T00:41:44.741908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T00:41:44.741924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-05-07T00:41:44.741964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-05-07T00:41:44.748937Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T00:41:44.750644Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T00:41:44.752665Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-07T00:41:44.755445Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T00:41:44.755679Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T00:41:44.755667Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-07T00:41:44.756036Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-07T00:41:44.756055Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-07T00:41:44.757067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-05-07T00:41:44.758817Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-07T00:41:44.761162Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-07T00:41:44.761267Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-07T00:41:44.7613Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-07T00:41:44.761683Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T00:41:44.761773Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T00:41:45.142306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T00:41:45.142363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T00:41:45.142402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-05-07T00:41:45.142415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-05-07T00:41:45.142422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-07T00:41:45.142432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-05-07T00:41:45.142441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-07T00:41:45.144719Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T00:41:45.14476Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:41:45.144902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:41:45.145422Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:41:45.146756Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T00:41:45.146797Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T00:41:45.147931Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T00:41:45.148693Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-05-07T00:41:45.14884Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:41:45.148967Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:41:45.149041Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:42:00.943791Z","caller":"traceutil/trace.go:171","msg":"trace[893040659] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"101.015546ms","start":"2026-05-07T00:42:00.842745Z","end":"2026-05-07T00:42:00.943761Z","steps":["trace[893040659] 'read index received' (duration: 100.843174ms)","trace[893040659] 'applied index is now lower than readState.Index' (duration: 171.332µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:42:00.943853Z","caller":"traceutil/trace.go:171","msg":"trace[755380222] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"191.384827ms","start":"2026-05-07T00:42:00.75243Z","end":"2026-05-07T00:42:00.943815Z","steps":["trace[755380222] 'process raft request' (duration: 191.182025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:00.944007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.194638ms","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-05-07T00:42:00.944121Z","caller":"traceutil/trace.go:171","msg":"trace[1846957627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"101.390819ms","start":"2026-05-07T00:42:00.842714Z","end":"2026-05-07T00:42:00.944104Z","steps":["trace[1846957627] 'agreement among raft nodes before linearized reading' (duration: 101.185137ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:13.786671Z","caller":"traceutil/trace.go:171","msg":"trace[1888208463] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"104.467526ms","start":"2026-05-07T00:42:13.682186Z","end":"2026-05-07T00:42:13.786654Z","steps":["trace[1888208463] 'process raft request' (duration: 104.439256ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:13.787107Z","caller":"traceutil/trace.go:171","msg":"trace[1443060913] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"111.59213ms","start":"2026-05-07T00:42:13.675504Z","end":"2026-05-07T00:42:13.787096Z","steps":["trace[1443060913] 'process raft request' (duration: 86.760492ms)","trace[1443060913] 'compare' (duration: 24.179293ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:42:13.787231Z","caller":"traceutil/trace.go:171","msg":"trace[769857506] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"111.6647ms","start":"2026-05-07T00:42:13.675558Z","end":"2026-05-07T00:42:13.787223Z","steps":["trace[769857506] 'process raft request' (duration: 110.988705ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:13.787388Z","caller":"traceutil/trace.go:171","msg":"trace[1318319234] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"109.31012ms","start":"2026-05-07T00:42:13.67807Z","end":"2026-05-07T00:42:13.78738Z","steps":["trace[1318319234] 'process raft request' (duration: 108.510113ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:13.787494Z","caller":"traceutil/trace.go:171","msg":"trace[1100950236] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"107.242072ms","start":"2026-05-07T00:42:13.680246Z","end":"2026-05-07T00:42:13.787488Z","steps":["trace[1100950236] 'process raft request' (duration: 106.355004ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:13.787868Z","caller":"traceutil/trace.go:171","msg":"trace[498486581] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"104.890592ms","start":"2026-05-07T00:42:13.682964Z","end":"2026-05-07T00:42:13.787855Z","steps":["trace[498486581] 'process raft request' (duration: 104.622128ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:19.723923Z","caller":"traceutil/trace.go:171","msg":"trace[1044210815] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"222.903838ms","start":"2026-05-07T00:42:19.500994Z","end":"2026-05-07T00:42:19.723898Z","steps":["trace[1044210815] 'process raft request' (duration: 216.846218ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:20.024846Z","caller":"traceutil/trace.go:171","msg":"trace[2042540786] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"131.097321ms","start":"2026-05-07T00:42:19.893696Z","end":"2026-05-07T00:42:20.024793Z","steps":["trace[2042540786] 'read index received' (duration: 131.065501ms)","trace[2042540786] 'applied index is now lower than readState.Index' (duration: 30.84µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:42:20.024978Z","caller":"traceutil/trace.go:171","msg":"trace[1441203440] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"252.634927ms","start":"2026-05-07T00:42:19.772289Z","end":"2026-05-07T00:42:20.024924Z","steps":["trace[1441203440] 'process raft request' (duration: 252.362675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:20.025129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.411404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8cxlq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-07T00:42:20.025211Z","caller":"traceutil/trace.go:171","msg":"trace[978290113] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8cxlq; range_end:; response_count:1; response_revision:616; }","duration":"131.507695ms","start":"2026-05-07T00:42:19.893685Z","end":"2026-05-07T00:42:20.025192Z","steps":["trace[978290113] 'agreement among raft nodes before linearized reading' (duration: 131.235963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:20.554012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.72076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:42:20.554113Z","caller":"traceutil/trace.go:171","msg":"trace[1877461475] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"170.86095ms","start":"2026-05-07T00:42:20.383236Z","end":"2026-05-07T00:42:20.554097Z","steps":["trace[1877461475] 'read index received' (duration: 46.191µs)","trace[1877461475] 'applied index is now lower than readState.Index' (duration: 170.813659ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:42:20.554168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.93591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:42:20.554147Z","caller":"traceutil/trace.go:171","msg":"trace[99116632] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"513.585236ms","start":"2026-05-07T00:42:20.040527Z","end":"2026-05-07T00:42:20.554112Z","steps":["trace[99116632] 'process raft request' (duration: 56.232051ms)","trace[99116632] 'compare' (duration: 456.570429ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:42:20.554191Z","caller":"traceutil/trace.go:171","msg":"trace[1074908413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"170.98701ms","start":"2026-05-07T00:42:20.383196Z","end":"2026-05-07T00:42:20.554183Z","steps":["trace[1074908413] 'agreement among raft nodes before linearized reading' (duration: 170.94381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:20.554314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:20.040505Z","time spent":"513.717027ms","remote":"127.0.0.1:56192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:42:20.583324Z","caller":"traceutil/trace.go:171","msg":"trace[451464489] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"139.893811ms","start":"2026-05-07T00:42:20.44339Z","end":"2026-05-07T00:42:20.583284Z","steps":["trace[451464489] 'process raft request' (duration: 139.145585ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:09.528579Z","caller":"traceutil/trace.go:171","msg":"trace[392292983] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1225; }","duration":"166.47602ms","start":"2026-05-07T00:43:09.362075Z","end":"2026-05-07T00:43:09.528551Z","steps":["trace[392292983] 'read index received' (duration: 166.3952ms)","trace[392292983] 'applied index is now lower than readState.Index' (duration: 79.37µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:43:09.528777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.672501ms","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-05-07T00:43:09.52886Z","caller":"traceutil/trace.go:171","msg":"trace[966798782] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1191; }","duration":"166.808913ms","start":"2026-05-07T00:43:09.362024Z","end":"2026-05-07T00:43:09.528833Z","steps":["trace[966798782] 'agreement among raft nodes before linearized reading' (duration: 166.690672ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:09.528788Z","caller":"traceutil/trace.go:171","msg":"trace[898173242] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"214.317387ms","start":"2026-05-07T00:43:09.314439Z","end":"2026-05-07T00:43:09.528757Z","steps":["trace[898173242] 'process raft request' (duration: 213.959094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:09.529035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.175642ms","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-05-07T00:43:09.529095Z","caller":"traceutil/trace.go:171","msg":"trace[102847978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1191; }","duration":"129.285982ms","start":"2026-05-07T00:43:09.399793Z","end":"2026-05-07T00:43:09.529079Z","steps":["trace[102847978] 'agreement among raft nodes before linearized reading' (duration: 129.115971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:09.529057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.122907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:43:09.529197Z","caller":"traceutil/trace.go:171","msg":"trace[667649409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1191; }","duration":"146.317127ms","start":"2026-05-07T00:43:09.382837Z","end":"2026-05-07T00:43:09.529154Z","steps":["trace[667649409] 'agreement among raft nodes before linearized reading' (duration: 146.059066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:56.373967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.922727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:43:56.374023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.448375ms","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-05-07T00:43:56.374089Z","caller":"traceutil/trace.go:171","msg":"trace[1455721289] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1861; }","duration":"127.110629ms","start":"2026-05-07T00:43:56.246957Z","end":"2026-05-07T00:43:56.374068Z","steps":["trace[1455721289] 'count revisions from in-memory index tree' (duration: 126.846156ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:56.374106Z","caller":"traceutil/trace.go:171","msg":"trace[16710878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1861; }","duration":"141.601628ms","start":"2026-05-07T00:43:56.232486Z","end":"2026-05-07T00:43:56.374088Z","steps":["trace[16710878] 'range keys from in-memory index tree' (duration: 141.255242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:56.374149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.707227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-05-07T00:43:56.374349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.705047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-07T00:43:56.374379Z","caller":"traceutil/trace.go:171","msg":"trace[1387913079] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1861; }","duration":"161.786498ms","start":"2026-05-07T00:43:56.212584Z","end":"2026-05-07T00:43:56.37437Z","steps":["trace[1387913079] 'range keys from in-memory index tree' (duration: 161.533664ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:56.374224Z","caller":"traceutil/trace.go:171","msg":"trace[2143629264] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1861; }","duration":"125.809359ms","start":"2026-05-07T00:43:56.248397Z","end":"2026-05-07T00:43:56.374206Z","steps":["trace[2143629264] 'range keys from in-memory index tree' (duration: 125.584045ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:56.51311Z","caller":"traceutil/trace.go:171","msg":"trace[2003723856] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"135.55368ms","start":"2026-05-07T00:43:56.377533Z","end":"2026-05-07T00:43:56.513086Z","steps":["trace[2003723856] 'process raft request' (duration: 135.398346ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:56.754246Z","caller":"traceutil/trace.go:171","msg":"trace[728200453] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1930; }","duration":"371.592803ms","start":"2026-05-07T00:43:56.382619Z","end":"2026-05-07T00:43:56.754212Z","steps":["trace[728200453] 'read index received' (duration: 130.373994ms)","trace[728200453] 'applied index is now lower than readState.Index' (duration: 241.217399ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:43:56.754361Z","caller":"traceutil/trace.go:171","msg":"trace[2088640864] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"375.980886ms","start":"2026-05-07T00:43:56.378331Z","end":"2026-05-07T00:43:56.754312Z","steps":["trace[2088640864] 'process raft request' (duration: 346.214778ms)","trace[2088640864] 'compare' (duration: 29.400972ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:43:56.754523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:56.378295Z","time spent":"376.144889ms","remote":"127.0.0.1:56274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:43:56.754623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.98113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-43d4d4b3-5237-41de-8f3e-cdcdf9a8f64d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-07T00:43:56.754662Z","caller":"traceutil/trace.go:171","msg":"trace[1336071529] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-43d4d4b3-5237-41de-8f3e-cdcdf9a8f64d; range_end:; response_count:1; response_revision:1863; }","duration":"110.045633ms","start":"2026-05-07T00:43:56.644602Z","end":"2026-05-07T00:43:56.754648Z","steps":["trace[1336071529] 'agreement among raft nodes before linearized reading' (duration: 109.959212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:56.75477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.127641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:43:56.754938Z","caller":"traceutil/trace.go:171","msg":"trace[1108058330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1863; }","duration":"372.294415ms","start":"2026-05-07T00:43:56.382593Z","end":"2026-05-07T00:43:56.754887Z","steps":["trace[1108058330] 'agreement among raft nodes before linearized reading' (duration: 371.727286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:56.755039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:56.382584Z","time spent":"372.420137ms","remote":"127.0.0.1:56022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:43:56.754514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.941537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-43d4d4b3-5237-41de-8f3e-cdcdf9a8f64d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-07T00:43:56.755278Z","caller":"traceutil/trace.go:171","msg":"trace[42326897] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-43d4d4b3-5237-41de-8f3e-cdcdf9a8f64d; range_end:; response_count:1; response_revision:1863; }","duration":"331.755481ms","start":"2026-05-07T00:43:56.423501Z","end":"2026-05-07T00:43:56.755256Z","steps":["trace[42326897] 'agreement among raft nodes before linearized reading' (duration: 330.875577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:56.755413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:56.423476Z","time spent":"331.919903ms","remote":"127.0.0.1:56192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-43d4d4b3-5237-41de-8f3e-cdcdf9a8f64d\" "} {"level":"warn","ts":"2026-05-07T00:43:56.755682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.43734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:43:56.756Z","caller":"traceutil/trace.go:171","msg":"trace[1356647033] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1863; }","duration":"138.311084ms","start":"2026-05-07T00:43:56.617666Z","end":"2026-05-07T00:43:56.755977Z","steps":["trace[1356647033] 'agreement among raft nodes before linearized reading' (duration: 137.4376ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:30.033964Z","caller":"traceutil/trace.go:171","msg":"trace[1195693081] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"105.309583ms","start":"2026-05-07T00:44:29.928596Z","end":"2026-05-07T00:44:30.033905Z","steps":["trace[1195693081] 'process raft request' (duration: 86.164532ms)","trace[1195693081] 'compare' (duration: 18.767155ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:44:30.03417Z","caller":"traceutil/trace.go:171","msg":"trace[1886128915] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"104.585784ms","start":"2026-05-07T00:44:29.92956Z","end":"2026-05-07T00:44:30.034145Z","steps":["trace[1886128915] 'process raft request' (duration: 104.197698ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:44:31.701835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.199786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:44:31.702142Z","caller":"traceutil/trace.go:171","msg":"trace[915787065] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"282.576624ms","start":"2026-05-07T00:44:31.419479Z","end":"2026-05-07T00:44:31.702056Z","steps":["trace[915787065] 'process raft request' (duration: 165.055414ms)","trace[915787065] 'compare' (duration: 117.100645ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:46:08.536649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.585734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-07T00:46:08.536731Z","caller":"traceutil/trace.go:171","msg":"trace[1738489648] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2740; }","duration":"162.710085ms","start":"2026-05-07T00:46:08.374005Z","end":"2026-05-07T00:46:08.536715Z","steps":["trace[1738489648] 'range keys from in-memory index tree' (duration: 162.492943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:46:08.536801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.249794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:46:08.537059Z","caller":"traceutil/trace.go:171","msg":"trace[837122680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2740; }","duration":"154.526227ms","start":"2026-05-07T00:46:08.382513Z","end":"2026-05-07T00:46:08.537039Z","steps":["trace[837122680] 'range keys from in-memory index tree' (duration: 154.206493ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:46:08.537593Z","caller":"traceutil/trace.go:171","msg":"trace[852573968] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"149.340274ms","start":"2026-05-07T00:46:08.38824Z","end":"2026-05-07T00:46:08.53758Z","steps":["trace[852573968] 'process raft request' (duration: 138.797165ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:52.309495Z","caller":"traceutil/trace.go:171","msg":"trace[310118939] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"181.561233ms","start":"2026-05-07T00:49:52.127912Z","end":"2026-05-07T00:49:52.309473Z","steps":["trace[310118939] 'process raft request' (duration: 181.414722ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:52.323919Z","caller":"traceutil/trace.go:171","msg":"trace[1271507210] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4810; }","duration":"166.410791ms","start":"2026-05-07T00:49:52.157489Z","end":"2026-05-07T00:49:52.3239Z","steps":["trace[1271507210] 'read index received' (duration: 151.826766ms)","trace[1271507210] 'applied index is now lower than readState.Index' (duration: 14.583175ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:49:52.323953Z","caller":"traceutil/trace.go:171","msg":"trace[1184906176] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"167.341918ms","start":"2026-05-07T00:49:52.156588Z","end":"2026-05-07T00:49:52.32393Z","steps":["trace[1184906176] 'process raft request' (duration: 167.217527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:52.324102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.598073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-07T00:49:52.324126Z","caller":"traceutil/trace.go:171","msg":"trace[608571269] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4639; }","duration":"166.663293ms","start":"2026-05-07T00:49:52.157455Z","end":"2026-05-07T00:49:52.324118Z","steps":["trace[608571269] 'agreement among raft nodes before linearized reading' (duration: 166.537482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:52.324199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.630185ms","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-05-07T00:49:52.324254Z","caller":"traceutil/trace.go:171","msg":"trace[1138052540] 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:4639; }","duration":"121.723456ms","start":"2026-05-07T00:49:52.202514Z","end":"2026-05-07T00:49:52.324238Z","steps":["trace[1138052540] 'agreement among raft nodes before linearized reading' (duration: 121.550225ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:56.420005Z","caller":"traceutil/trace.go:171","msg":"trace[1228517867] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"100.414781ms","start":"2026-05-07T00:49:56.319568Z","end":"2026-05-07T00:49:56.419983Z","steps":["trace[1228517867] 'process raft request' (duration: 100.233429ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:56.555008Z","caller":"traceutil/trace.go:171","msg":"trace[1453021781] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"129.816966ms","start":"2026-05-07T00:49:56.425145Z","end":"2026-05-07T00:49:56.554962Z","steps":["trace[1453021781] 'process raft request' (duration: 127.199467ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:45.36313Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2937} {"level":"info","ts":"2026-05-07T00:51:45.4414Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2937,"took":"76.653306ms","hash":962410575,"current-db-size-bytes":53084160,"current-db-size":"53 MB","current-db-size-in-use-bytes":29646848,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-07T00:51:45.441485Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":962410575,"revision":2937,"compact-revision":-1} {"level":"info","ts":"2026-05-07T00:56:45.370832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5662} {"level":"info","ts":"2026-05-07T00:56:45.458218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5662,"took":"84.630063ms","hash":3923905435,"current-db-size-bytes":53084160,"current-db-size":"53 MB","current-db-size-in-use-bytes":18333696,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-07T00:56:45.45828Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3923905435,"revision":5662,"compact-revision":2937}