{"level":"warn","ts":"2026-05-06T09:19:52.104165Z","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-06T09:19:52.104256Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-06T09:19:52.104343Z","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-06T09:19:52.10436Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-06T09:19:52.104385Z","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-06T09:19:52.10533Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-05-06T09:19:52.105428Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-06T09:19:52.145671Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"33.713112ms"} {"level":"info","ts":"2026-05-06T09:19:52.155666Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-05-06T09:19:52.155853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T09:19:52.155963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-05-06T09:19:52.155984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T09:19:52.157394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-05-06T09:19:52.158177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-05-06T09:19:52.163683Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T09:19:52.164966Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T09:19:52.165945Z","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-06T09:19:52.167991Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T09:19:52.168431Z","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-06T09:19:52.168516Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T09:19:52.168559Z","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-06T09:19:52.168693Z","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-06T09:19:52.170358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-05-06T09:19:52.170555Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-06T09:19:52.175692Z","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-06T09:19:52.175889Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-06T09:19:52.175908Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-06T09:19:52.176564Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T09:19:52.176603Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T09:19:52.558578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T09:19:52.558639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T09:19:52.558661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-05-06T09:19:52.558681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-05-06T09:19:52.558693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-06T09:19:52.558776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-05-06T09:19:52.558795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-06T09:19:52.563181Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T09:19:52.574391Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T09:19:52.574445Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T09:19:52.574555Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T09:19:52.574774Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T09:19:52.574942Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T09:19:52.575166Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T09:19:52.57534Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T09:19:52.575387Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T09:19:52.57803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-05-06T09:19:52.578115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-06T09:20:10.980951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.713852ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-06T09:20:26.525091Z","caller":"traceutil/trace.go:171","msg":"trace[2030228362] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"151.180198ms","start":"2026-05-06T09:20:26.373878Z","end":"2026-05-06T09:20:26.525058Z","steps":["trace[2030228362] 'process raft request' (duration: 150.812983ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:20:26.662806Z","caller":"traceutil/trace.go:171","msg":"trace[158856314] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"125.276706ms","start":"2026-05-06T09:20:26.53751Z","end":"2026-05-06T09:20:26.662787Z","steps":["trace[158856314] 'read index received' (duration: 124.496846ms)","trace[158856314] 'applied index is now lower than readState.Index' (duration: 778.91µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:20:26.662822Z","caller":"traceutil/trace.go:171","msg":"trace[1575964542] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"215.419429ms","start":"2026-05-06T09:20:26.447387Z","end":"2026-05-06T09:20:26.662807Z","steps":["trace[1575964542] 'process raft request' (duration: 214.89755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:20:26.663231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.699422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T09:20:26.663414Z","caller":"traceutil/trace.go:171","msg":"trace[1199940961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"125.836816ms","start":"2026-05-06T09:20:26.537461Z","end":"2026-05-06T09:20:26.663298Z","steps":["trace[1199940961] 'agreement among raft nodes before linearized reading' (duration: 125.40123ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:20:27.007702Z","caller":"traceutil/trace.go:171","msg":"trace[1482315300] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"289.043675ms","start":"2026-05-06T09:20:26.718636Z","end":"2026-05-06T09:20:27.007679Z","steps":["trace[1482315300] 'process raft request' (duration: 288.881419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:20:41.578003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.360824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lmbs8\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-06T09:20:41.578094Z","caller":"traceutil/trace.go:171","msg":"trace[1706711177] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lmbs8; range_end:; response_count:1; response_revision:775; }","duration":"157.503548ms","start":"2026-05-06T09:20:41.420571Z","end":"2026-05-06T09:20:41.578074Z","steps":["trace[1706711177] 'range keys from in-memory index tree' (duration: 157.171419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:20:41.578456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.809363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T09:20:41.578544Z","caller":"traceutil/trace.go:171","msg":"trace[525678076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"136.910916ms","start":"2026-05-06T09:20:41.441614Z","end":"2026-05-06T09:20:41.578525Z","steps":["trace[525678076] 'range keys from in-memory index tree' (duration: 136.743851ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:21:59.944825Z","caller":"traceutil/trace.go:171","msg":"trace[1949229706] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"157.307342ms","start":"2026-05-06T09:21:59.787494Z","end":"2026-05-06T09:21:59.944801Z","steps":["trace[1949229706] 'process raft request' (duration: 157.149596ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:22:00.153542Z","caller":"traceutil/trace.go:171","msg":"trace[864256472] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"297.139639ms","start":"2026-05-06T09:21:59.856371Z","end":"2026-05-06T09:22:00.153511Z","steps":["trace[864256472] 'process raft request' (duration: 296.876309ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:22:15.107506Z","caller":"traceutil/trace.go:171","msg":"trace[2060124643] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"150.30795ms","start":"2026-05-06T09:22:14.957155Z","end":"2026-05-06T09:22:15.107463Z","steps":["trace[2060124643] 'process raft request' (duration: 119.52283ms)","trace[2060124643] 'compare' (duration: 30.451659ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:22:32.439919Z","caller":"traceutil/trace.go:171","msg":"trace[1799078130] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"108.357455ms","start":"2026-05-06T09:22:32.331495Z","end":"2026-05-06T09:22:32.439852Z","steps":["trace[1799078130] 'process raft request' (duration: 108.143299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:22:39.178563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.347418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T09:22:39.178722Z","caller":"traceutil/trace.go:171","msg":"trace[2047246402] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"256.425103ms","start":"2026-05-06T09:22:38.922235Z","end":"2026-05-06T09:22:39.178661Z","steps":["trace[2047246402] 'read index received' (duration: 79.360285ms)","trace[2047246402] 'applied index is now lower than readState.Index' (duration: 177.063498ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T09:22:39.178943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.715181ms","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-06T09:22:39.178975Z","caller":"traceutil/trace.go:171","msg":"trace[1547173628] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2128; }","duration":"256.791043ms","start":"2026-05-06T09:22:38.922174Z","end":"2026-05-06T09:22:39.178965Z","steps":["trace[1547173628] 'agreement among raft nodes before linearized reading' (duration: 256.584757ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:22:39.179276Z","caller":"traceutil/trace.go:171","msg":"trace[989324685] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"339.576776ms","start":"2026-05-06T09:22:38.839671Z","end":"2026-05-06T09:22:39.179248Z","steps":["trace[989324685] 'process raft request' (duration: 161.966192ms)","trace[989324685] 'compare' (duration: 176.02616ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T09:22:39.179391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:22:38.839656Z","time spent":"339.687369ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T09:22:39.323599Z","caller":"traceutil/trace.go:171","msg":"trace[60080350] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"139.62818ms","start":"2026-05-06T09:22:39.183945Z","end":"2026-05-06T09:22:39.323573Z","steps":["trace[60080350] 'process raft request' (duration: 119.729413ms)","trace[60080350] 'compare' (duration: 19.760863ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:22:39.350384Z","caller":"traceutil/trace.go:171","msg":"trace[467519996] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2210; }","duration":"135.747242ms","start":"2026-05-06T09:22:39.214608Z","end":"2026-05-06T09:22:39.350356Z","steps":["trace[467519996] 'read index received' (duration: 88.944071ms)","trace[467519996] 'applied index is now lower than readState.Index' (duration: 46.801711ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:22:39.350484Z","caller":"traceutil/trace.go:171","msg":"trace[1978731523] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"148.246511ms","start":"2026-05-06T09:22:39.202211Z","end":"2026-05-06T09:22:39.350457Z","steps":["trace[1978731523] 'process raft request' (duration: 148.084587ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:22:39.350466Z","caller":"traceutil/trace.go:171","msg":"trace[1591285587] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"152.701927ms","start":"2026-05-06T09:22:39.197729Z","end":"2026-05-06T09:22:39.350431Z","steps":["trace[1591285587] 'process raft request' (duration: 152.387748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:22:39.350782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.105612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-06T09:22:39.350812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.136452ms","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-05-06T09:22:39.350851Z","caller":"traceutil/trace.go:171","msg":"trace[443584761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2131; }","duration":"136.200374ms","start":"2026-05-06T09:22:39.214631Z","end":"2026-05-06T09:22:39.350832Z","steps":["trace[443584761] 'agreement among raft nodes before linearized reading' (duration: 136.04994ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:22:39.350866Z","caller":"traceutil/trace.go:171","msg":"trace[763409348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2131; }","duration":"136.276006ms","start":"2026-05-06T09:22:39.214575Z","end":"2026-05-06T09:22:39.350851Z","steps":["trace[763409348] 'agreement among raft nodes before linearized reading' (duration: 135.926727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:22:39.544621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.462174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T09:22:39.544733Z","caller":"traceutil/trace.go:171","msg":"trace[298554235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2134; }","duration":"100.652968ms","start":"2026-05-06T09:22:39.444055Z","end":"2026-05-06T09:22:39.544708Z","steps":["trace[298554235] 'range keys from in-memory index tree' (duration: 100.34598ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:24:07.97725Z","caller":"traceutil/trace.go:171","msg":"trace[1931490792] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"164.277578ms","start":"2026-05-06T09:24:07.812943Z","end":"2026-05-06T09:24:07.97722Z","steps":["trace[1931490792] 'process raft request' (duration: 140.061738ms)","trace[1931490792] 'compare' (duration: 23.975575ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:27:50.742102Z","caller":"traceutil/trace.go:171","msg":"trace[1072493529] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"136.601148ms","start":"2026-05-06T09:27:50.605446Z","end":"2026-05-06T09:27:50.742047Z","steps":["trace[1072493529] 'process raft request' (duration: 136.332451ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:27:50.74222Z","caller":"traceutil/trace.go:171","msg":"trace[1653120502] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"136.484085ms","start":"2026-05-06T09:27:50.605693Z","end":"2026-05-06T09:27:50.742177Z","steps":["trace[1653120502] 'process raft request' (duration: 136.281609ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:27:50.742323Z","caller":"traceutil/trace.go:171","msg":"trace[2115576188] linearizableReadLoop","detail":"{readStateIndex:4800; appliedIndex:4797; }","duration":"136.012862ms","start":"2026-05-06T09:27:50.606288Z","end":"2026-05-06T09:27:50.742301Z","steps":["trace[2115576188] 'read index received' (duration: 42.882546ms)","trace[2115576188] 'applied index is now lower than readState.Index' (duration: 93.129326ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:27:50.742518Z","caller":"traceutil/trace.go:171","msg":"trace[741930838] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"135.996302ms","start":"2026-05-06T09:27:50.606506Z","end":"2026-05-06T09:27:50.742502Z","steps":["trace[741930838] 'process raft request' (duration: 135.55953ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:27:50.742531Z","caller":"traceutil/trace.go:171","msg":"trace[945168187] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"135.698873ms","start":"2026-05-06T09:27:50.606727Z","end":"2026-05-06T09:27:50.742426Z","steps":["trace[945168187] 'process raft request' (duration: 135.390815ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:27:50.742615Z","caller":"traceutil/trace.go:171","msg":"trace[185412307] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"128.458274ms","start":"2026-05-06T09:27:50.614147Z","end":"2026-05-06T09:27:50.742605Z","steps":["trace[185412307] 'process raft request' (duration: 128.061324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:27:50.742908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.589119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f9a6dd7d-5700-4c4e-afd4-2f7aad6c5745\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-05-06T09:27:50.742957Z","caller":"traceutil/trace.go:171","msg":"trace[397244028] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f9a6dd7d-5700-4c4e-afd4-2f7aad6c5745; range_end:; response_count:1; response_revision:4626; }","duration":"136.676931ms","start":"2026-05-06T09:27:50.606264Z","end":"2026-05-06T09:27:50.742941Z","steps":["trace[397244028] 'agreement among raft nodes before linearized reading' (duration: 136.522727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:28:03.372118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.369471ms","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-06T09:28:03.372236Z","caller":"traceutil/trace.go:171","msg":"trace[961129292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4846; }","duration":"279.526205ms","start":"2026-05-06T09:28:03.092685Z","end":"2026-05-06T09:28:03.372211Z","steps":["trace[961129292] 'range keys from in-memory index tree' (duration: 279.159256ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:29:52.612107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2953} {"level":"info","ts":"2026-05-06T09:29:52.707455Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2953,"took":"94.085562ms","hash":1271936411,"current-db-size-bytes":54480896,"current-db-size":"54 MB","current-db-size-in-use-bytes":29585408,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-06T09:29:52.707531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1271936411,"revision":2953,"compact-revision":-1} {"level":"info","ts":"2026-05-06T09:32:08.853644Z","caller":"traceutil/trace.go:171","msg":"trace[1545608578] transaction","detail":"{read_only:false; response_revision:6620; number_of_response:1; }","duration":"123.436543ms","start":"2026-05-06T09:32:08.730187Z","end":"2026-05-06T09:32:08.853624Z","steps":["trace[1545608578] 'process raft request' (duration: 123.31499ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:34:52.6191Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5671} {"level":"info","ts":"2026-05-06T09:34:52.733421Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5671,"took":"113.068135ms","hash":2358371312,"current-db-size-bytes":54480896,"current-db-size":"54 MB","current-db-size-in-use-bytes":18313216,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-06T09:34:52.733483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2358371312,"revision":5671,"compact-revision":2953} {"level":"warn","ts":"2026-05-06T09:35:25.444889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853970296427490368,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-06T09:35:25.676341Z","caller":"traceutil/trace.go:171","msg":"trace[1834917690] linearizableReadLoop","detail":"{readStateIndex:7918; appliedIndex:7917; }","duration":"731.952047ms","start":"2026-05-06T09:35:24.944358Z","end":"2026-05-06T09:35:25.67631Z","steps":["trace[1834917690] 'read index received' (duration: 731.733389ms)","trace[1834917690] 'applied index is now lower than readState.Index' (duration: 217.498µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:35:25.67643Z","caller":"traceutil/trace.go:171","msg":"trace[167571133] transaction","detail":"{read_only:false; response_revision:7634; number_of_response:1; }","duration":"733.688372ms","start":"2026-05-06T09:35:24.942712Z","end":"2026-05-06T09:35:25.676401Z","steps":["trace[167571133] 'process raft request' (duration: 733.409952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.676554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.166715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/default\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-06T09:35:25.676618Z","caller":"traceutil/trace.go:171","msg":"trace[1405671430] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/default; range_end:; response_count:1; response_revision:7634; }","duration":"732.260609ms","start":"2026-05-06T09:35:24.944343Z","end":"2026-05-06T09:35:25.676603Z","steps":["trace[1405671430] 'agreement among raft nodes before linearized reading' (duration: 732.087332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.676565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:24.94269Z","time spent":"733.806076ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T09:35:25.676673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:24.944335Z","time spent":"732.324861ms","remote":"127.0.0.1:39546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/local-path-storage/default\" "} {"level":"info","ts":"2026-05-06T09:35:25.677995Z","caller":"traceutil/trace.go:171","msg":"trace[2095948154] transaction","detail":"{read_only:false; response_revision:7635; number_of_response:1; }","duration":"212.329519ms","start":"2026-05-06T09:35:25.465654Z","end":"2026-05-06T09:35:25.677984Z","steps":["trace[2095948154] 'process raft request' (duration: 212.179814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.678041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.317055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-06T09:35:25.678119Z","caller":"traceutil/trace.go:171","msg":"trace[839105300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7635; }","duration":"213.424769ms","start":"2026-05-06T09:35:25.464686Z","end":"2026-05-06T09:35:25.678111Z","steps":["trace[839105300] 'agreement among raft nodes before linearized reading' (duration: 213.267613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.678131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.766913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"warn","ts":"2026-05-06T09:35:25.678162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.769891ms","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-05-06T09:35:25.678186Z","caller":"traceutil/trace.go:171","msg":"trace[39390183] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:7635; }","duration":"711.95047ms","start":"2026-05-06T09:35:24.966227Z","end":"2026-05-06T09:35:25.678178Z","steps":["trace[39390183] 'agreement among raft nodes before linearized reading' (duration: 711.691961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.678221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.930747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-06T09:35:25.678247Z","caller":"traceutil/trace.go:171","msg":"trace[887683744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7635; }","duration":"457.002789ms","start":"2026-05-06T09:35:25.221238Z","end":"2026-05-06T09:35:25.678241Z","steps":["trace[887683744] 'agreement among raft nodes before linearized reading' (duration: 456.933767ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:35:25.67822Z","caller":"traceutil/trace.go:171","msg":"trace[1775708055] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:7635; }","duration":"588.855344ms","start":"2026-05-06T09:35:25.089351Z","end":"2026-05-06T09:35:25.678206Z","steps":["trace[1775708055] 'agreement among raft nodes before linearized reading' (duration: 588.74565ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.67827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.221222Z","time spent":"457.04281ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-06T09:35:25.678277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.089338Z","time spent":"588.931288ms","remote":"127.0.0.1:55800","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-05-06T09:35:25.678353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.879957ms","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-05-06T09:35:25.678441Z","caller":"traceutil/trace.go:171","msg":"trace[369698042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7635; }","duration":"711.986111ms","start":"2026-05-06T09:35:24.966432Z","end":"2026-05-06T09:35:25.678418Z","steps":["trace[369698042] 'agreement among raft nodes before linearized reading' (duration: 711.725251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.678911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:24.966428Z","time spent":"712.463348ms","remote":"127.0.0.1:39610","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-05-06T09:35:25.678818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:24.96621Z","time spent":"712.026532ms","remote":"127.0.0.1:39546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"info","ts":"2026-05-06T09:35:25.989615Z","caller":"traceutil/trace.go:171","msg":"trace[1663480888] linearizableReadLoop","detail":"{readStateIndex:7924; appliedIndex:7920; }","duration":"241.493143ms","start":"2026-05-06T09:35:25.748105Z","end":"2026-05-06T09:35:25.989598Z","steps":["trace[1663480888] 'read index received' (duration: 239.534251ms)","trace[1663480888] 'applied index is now lower than readState.Index' (duration: 1.958072ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T09:35:25.989723Z","caller":"traceutil/trace.go:171","msg":"trace[1184765481] transaction","detail":"{read_only:false; response_revision:7636; number_of_response:1; }","duration":"305.443028ms","start":"2026-05-06T09:35:25.684251Z","end":"2026-05-06T09:35:25.989694Z","steps":["trace[1184765481] 'process raft request' (duration: 303.415743ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:35:25.989709Z","caller":"traceutil/trace.go:171","msg":"trace[1095792322] transaction","detail":"{read_only:false; response_revision:7637; number_of_response:1; }","duration":"305.402777ms","start":"2026-05-06T09:35:25.684273Z","end":"2026-05-06T09:35:25.989675Z","steps":["trace[1095792322] 'process raft request' (duration: 305.21551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.989815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.615683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"warn","ts":"2026-05-06T09:35:25.989822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.708451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/default\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-06T09:35:25.989852Z","caller":"traceutil/trace.go:171","msg":"trace[528079156] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:7639; }","duration":"236.694996ms","start":"2026-05-06T09:35:25.753145Z","end":"2026-05-06T09:35:25.98984Z","steps":["trace[528079156] 'agreement among raft nodes before linearized reading' (duration: 236.568042ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T09:35:25.989684Z","caller":"traceutil/trace.go:171","msg":"trace[811955390] transaction","detail":"{read_only:false; response_revision:7638; number_of_response:1; }","duration":"305.374606ms","start":"2026-05-06T09:35:25.684289Z","end":"2026-05-06T09:35:25.989663Z","steps":["trace[811955390] 'process raft request' (duration: 305.257041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.989904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.684263Z","time spent":"305.546562ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T09:35:25.989952Z","caller":"traceutil/trace.go:171","msg":"trace[2133624876] transaction","detail":"{read_only:false; response_revision:7639; number_of_response:1; }","duration":"305.514501ms","start":"2026-05-06T09:35:25.684399Z","end":"2026-05-06T09:35:25.989914Z","steps":["trace[2133624876] 'process raft request' (duration: 305.174378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.990067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.684382Z","time spent":"305.662506ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T09:35:25.990077Z","caller":"traceutil/trace.go:171","msg":"trace[90277049] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/default; range_end:; response_count:1; response_revision:7639; }","duration":"241.798474ms","start":"2026-05-06T09:35:25.748067Z","end":"2026-05-06T09:35:25.989866Z","steps":["trace[90277049] 'agreement among raft nodes before linearized reading' (duration: 241.637068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T09:35:25.989998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.68423Z","time spent":"305.681527ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T09:35:25.989881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T09:35:25.68423Z","time spent":"305.573743ms","remote":"127.0.0.1:39366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}