{"level":"warn","ts":"2026-05-12T11:12:16.729164Z","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-12T11:12:16.729269Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-12T11:12:16.729333Z","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-12T11:12:16.729341Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-12T11:12:16.729367Z","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-12T11:12:16.730052Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-05-12T11:12:16.730145Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-12T11:12:16.73646Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.095635ms"} {"level":"info","ts":"2026-05-12T11:12:16.745311Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-05-12T11:12:16.745451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:12:16.745507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-05-12T11:12:16.745529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:12:16.745539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-05-12T11:12:16.745615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-05-12T11:12:16.751738Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:12:16.755956Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:12:16.757374Z","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-12T11:12:16.759673Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:12:16.759903Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:12:16.760074Z","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-12T11:12:16.760228Z","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-12T11:12:16.760262Z","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-12T11:12:16.761169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-05-12T11:12:16.761416Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-12T11:12:16.763477Z","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-12T11:12:16.763637Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-12T11:12:16.763715Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-12T11:12:16.764169Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:12:16.764239Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:12:17.14685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:12:17.14692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:12:17.146957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-05-12T11:12:17.146976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:12:17.146993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-12T11:12:17.147007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-05-12T11:12:17.147024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-12T11:12:17.15788Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:12:17.157976Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:12:17.157924Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:12:17.158006Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:12:17.158283Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:12:17.158367Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:12:17.161848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-05-12T11:12:17.162094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:12:17.16731Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:12:17.167566Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:12:17.167624Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:12:18.986611Z","caller":"traceutil/trace.go:171","msg":"trace[586419195] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"128.496216ms","start":"2026-05-12T11:12:18.858084Z","end":"2026-05-12T11:12:18.98658Z","steps":["trace[586419195] 'process raft request' (duration: 127.221049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:12:48.627315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.92833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:12:48.627447Z","caller":"traceutil/trace.go:171","msg":"trace[584769903] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"266.731679ms","start":"2026-05-12T11:12:48.360697Z","end":"2026-05-12T11:12:48.627429Z","steps":["trace[584769903] 'process raft request' (duration: 162.144165ms)","trace[584769903] 'compare' (duration: 103.784917ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:12:48.632062Z","caller":"traceutil/trace.go:171","msg":"trace[284359655] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"216.802903ms","start":"2026-05-12T11:12:48.415233Z","end":"2026-05-12T11:12:48.632036Z","steps":["trace[284359655] 'process raft request' (duration: 216.62479ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.632065Z","caller":"traceutil/trace.go:171","msg":"trace[1742270972] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"220.347428ms","start":"2026-05-12T11:12:48.411677Z","end":"2026-05-12T11:12:48.632024Z","steps":["trace[1742270972] 'process raft request' (duration: 220.005621ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.632158Z","caller":"traceutil/trace.go:171","msg":"trace[1292236177] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"216.562438ms","start":"2026-05-12T11:12:48.415576Z","end":"2026-05-12T11:12:48.632138Z","steps":["trace[1292236177] 'process raft request' (duration: 216.330893ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.632247Z","caller":"traceutil/trace.go:171","msg":"trace[806568834] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"206.553054ms","start":"2026-05-12T11:12:48.425669Z","end":"2026-05-12T11:12:48.632221Z","steps":["trace[806568834] 'process raft request' (duration: 206.36441ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.632669Z","caller":"traceutil/trace.go:171","msg":"trace[982607247] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"206.969402ms","start":"2026-05-12T11:12:48.425679Z","end":"2026-05-12T11:12:48.632649Z","steps":["trace[982607247] 'process raft request' (duration: 206.701927ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.632997Z","caller":"traceutil/trace.go:171","msg":"trace[470028977] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"207.253359ms","start":"2026-05-12T11:12:48.4257Z","end":"2026-05-12T11:12:48.632953Z","steps":["trace[470028977] 'process raft request' (duration: 206.888561ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.633097Z","caller":"traceutil/trace.go:171","msg":"trace[792085122] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"206.729038ms","start":"2026-05-12T11:12:48.426331Z","end":"2026-05-12T11:12:48.63306Z","steps":["trace[792085122] 'process raft request' (duration: 206.455542ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.633285Z","caller":"traceutil/trace.go:171","msg":"trace[2121416476] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"206.933081ms","start":"2026-05-12T11:12:48.426337Z","end":"2026-05-12T11:12:48.63327Z","steps":["trace[2121416476] 'process raft request' (duration: 206.579944ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.633409Z","caller":"traceutil/trace.go:171","msg":"trace[1473524276] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"197.667683ms","start":"2026-05-12T11:12:48.435727Z","end":"2026-05-12T11:12:48.633395Z","steps":["trace[1473524276] 'process raft request' (duration: 197.299425ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.633962Z","caller":"traceutil/trace.go:171","msg":"trace[397327559] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"157.596787ms","start":"2026-05-12T11:12:48.476346Z","end":"2026-05-12T11:12:48.633943Z","steps":["trace[397327559] 'process raft request' (duration: 157.483045ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:48.63397Z","caller":"traceutil/trace.go:171","msg":"trace[1337150476] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"183.398099ms","start":"2026-05-12T11:12:48.45055Z","end":"2026-05-12T11:12:48.633948Z","steps":["trace[1337150476] 'process raft request' (duration: 182.867827ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:57.880133Z","caller":"traceutil/trace.go:171","msg":"trace[88914249] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"134.138207ms","start":"2026-05-12T11:12:57.745962Z","end":"2026-05-12T11:12:57.880101Z","steps":["trace[88914249] 'read index received' (duration: 133.878701ms)","trace[88914249] 'applied index is now lower than readState.Index' (duration: 258.326µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:12:57.880214Z","caller":"traceutil/trace.go:171","msg":"trace[1448405089] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"138.857147ms","start":"2026-05-12T11:12:57.741299Z","end":"2026-05-12T11:12:57.880156Z","steps":["trace[1448405089] 'process raft request' (duration: 138.615872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:12:57.880387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.221068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:12:57.880447Z","caller":"traceutil/trace.go:171","msg":"trace[1606506821] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"134.366842ms","start":"2026-05-12T11:12:57.746062Z","end":"2026-05-12T11:12:57.880429Z","steps":["trace[1606506821] 'agreement among raft nodes before linearized reading' (duration: 134.209878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:12:57.880432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.890962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:12:57.880454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.373522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:12:57.88066Z","caller":"traceutil/trace.go:171","msg":"trace[1060865994] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"134.681318ms","start":"2026-05-12T11:12:57.745937Z","end":"2026-05-12T11:12:57.880619Z","steps":["trace[1060865994] 'agreement among raft nodes before linearized reading' (duration: 134.31994ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:57.880547Z","caller":"traceutil/trace.go:171","msg":"trace[313331900] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:683; }","duration":"134.026385ms","start":"2026-05-12T11:12:57.746495Z","end":"2026-05-12T11:12:57.880522Z","steps":["trace[313331900] 'agreement among raft nodes before linearized reading' (duration: 133.841731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:12:58.371346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.769294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-12T11:12:58.371403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.267435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:12:58.371449Z","caller":"traceutil/trace.go:171","msg":"trace[581003037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"137.924688ms","start":"2026-05-12T11:12:58.233501Z","end":"2026-05-12T11:12:58.371426Z","steps":["trace[581003037] 'range keys from in-memory index tree' (duration: 137.558169ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:12:58.371494Z","caller":"traceutil/trace.go:171","msg":"trace[825239762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"102.428348ms","start":"2026-05-12T11:12:58.269041Z","end":"2026-05-12T11:12:58.37147Z","steps":["trace[825239762] 'range keys from in-memory index tree' (duration: 102.160962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:13:22.686077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.548051ms","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-05-12T11:13:22.686179Z","caller":"traceutil/trace.go:171","msg":"trace[1367330315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:821; }","duration":"153.761676ms","start":"2026-05-12T11:13:22.532394Z","end":"2026-05-12T11:13:22.686156Z","steps":["trace[1367330315] 'range keys from in-memory index tree' (duration: 153.272456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:13:22.68619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.314195ms","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-12T11:13:22.686285Z","caller":"traceutil/trace.go:171","msg":"trace[562275984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:821; }","duration":"101.493198ms","start":"2026-05-12T11:13:22.584767Z","end":"2026-05-12T11:13:22.686261Z","steps":["trace[562275984] 'range keys from in-memory index tree' (duration: 101.06713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:13:22.686332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.591146ms","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-05-12T11:13:22.686467Z","caller":"traceutil/trace.go:171","msg":"trace[44809065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:821; }","duration":"141.81799ms","start":"2026-05-12T11:13:22.544624Z","end":"2026-05-12T11:13:22.686442Z","steps":["trace[44809065] 'range keys from in-memory index tree' (duration: 141.32917ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:14:51.621412Z","caller":"traceutil/trace.go:171","msg":"trace[1032051104] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"186.328146ms","start":"2026-05-12T11:14:51.435048Z","end":"2026-05-12T11:14:51.621376Z","steps":["trace[1032051104] 'process raft request' (duration: 186.05798ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:14:51.621381Z","caller":"traceutil/trace.go:171","msg":"trace[1544685158] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2055; }","duration":"130.696361ms","start":"2026-05-12T11:14:51.490655Z","end":"2026-05-12T11:14:51.621352Z","steps":["trace[1544685158] 'read index received' (duration: 32.15943ms)","trace[1544685158] 'applied index is now lower than readState.Index' (duration: 98.535561ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:14:51.621672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.004208ms","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-05-12T11:14:51.621743Z","caller":"traceutil/trace.go:171","msg":"trace[2020292679] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1977; }","duration":"131.142841ms","start":"2026-05-12T11:14:51.490588Z","end":"2026-05-12T11:14:51.621731Z","steps":["trace[2020292679] 'agreement among raft nodes before linearized reading' (duration: 130.898816ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:14:51.621587Z","caller":"traceutil/trace.go:171","msg":"trace[630248201] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"144.610794ms","start":"2026-05-12T11:14:51.476929Z","end":"2026-05-12T11:14:51.62154Z","steps":["trace[630248201] 'process raft request' (duration: 144.352569ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:15:36.8513Z","caller":"traceutil/trace.go:171","msg":"trace[680402930] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"101.035567ms","start":"2026-05-12T11:15:36.750221Z","end":"2026-05-12T11:15:36.851256Z","steps":["trace[680402930] 'process raft request' (duration: 100.808532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:15:43.268849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.295556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:15:43.269159Z","caller":"traceutil/trace.go:171","msg":"trace[1492656437] linearizableReadLoop","detail":"{readStateIndex:2386; appliedIndex:2385; }","duration":"133.686647ms","start":"2026-05-12T11:15:43.135446Z","end":"2026-05-12T11:15:43.269133Z","steps":["trace[1492656437] 'read index received' (duration: 63.741µs)","trace[1492656437] 'applied index is now lower than readState.Index' (duration: 133.621206ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:15:43.26928Z","caller":"traceutil/trace.go:171","msg":"trace[87989364] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"116.228579ms","start":"2026-05-12T11:15:43.153014Z","end":"2026-05-12T11:15:43.269243Z","steps":["trace[87989364] 'process raft request' (duration: 115.989454ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:15:43.269258Z","caller":"traceutil/trace.go:171","msg":"trace[801472707] transaction","detail":"{read_only:false; response_revision:2293; number_of_response:1; }","duration":"200.010791ms","start":"2026-05-12T11:15:43.069201Z","end":"2026-05-12T11:15:43.269212Z","steps":["trace[801472707] 'process raft request' (duration: 52.926368ms)","trace[801472707] 'compare' (duration: 145.695514ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:15:43.269317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.862251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:15:43.269367Z","caller":"traceutil/trace.go:171","msg":"trace[1515577041] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2294; }","duration":"133.968423ms","start":"2026-05-12T11:15:43.135381Z","end":"2026-05-12T11:15:43.269349Z","steps":["trace[1515577041] 'agreement among raft nodes before linearized reading' (duration: 133.82708ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:16:52.477051Z","caller":"traceutil/trace.go:171","msg":"trace[1442522099] transaction","detail":"{read_only:false; response_revision:2869; number_of_response:1; }","duration":"106.06894ms","start":"2026-05-12T11:16:52.370948Z","end":"2026-05-12T11:16:52.477017Z","steps":["trace[1442522099] 'process raft request' (duration: 105.868926ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:21:12.688062Z","caller":"traceutil/trace.go:171","msg":"trace[283585045] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"113.532935ms","start":"2026-05-12T11:21:12.5745Z","end":"2026-05-12T11:21:12.688033Z","steps":["trace[283585045] 'process raft request' (duration: 76.048328ms)","trace[283585045] 'compare' (duration: 37.340214ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:21:12.695029Z","caller":"traceutil/trace.go:171","msg":"trace[1311742479] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"119.904334ms","start":"2026-05-12T11:21:12.575106Z","end":"2026-05-12T11:21:12.69501Z","steps":["trace[1311742479] 'process raft request' (duration: 119.856723ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:21:12.695103Z","caller":"traceutil/trace.go:171","msg":"trace[1987658316] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"120.005836ms","start":"2026-05-12T11:21:12.575069Z","end":"2026-05-12T11:21:12.695075Z","steps":["trace[1987658316] 'process raft request' (duration: 119.767252ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:21:13.182464Z","caller":"traceutil/trace.go:171","msg":"trace[673162203] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"101.941817ms","start":"2026-05-12T11:21:13.080488Z","end":"2026-05-12T11:21:13.18243Z","steps":["trace[673162203] 'process raft request' (duration: 101.57341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:21:20.947486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.859207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:21:20.947823Z","caller":"traceutil/trace.go:171","msg":"trace[1259053670] linearizableReadLoop","detail":"{readStateIndex:5733; appliedIndex:5731; }","duration":"181.663859ms","start":"2026-05-12T11:21:20.766138Z","end":"2026-05-12T11:21:20.947802Z","steps":["trace[1259053670] 'read index received' (duration: 58.541588ms)","trace[1259053670] 'applied index is now lower than readState.Index' (duration: 123.120861ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:21:20.947995Z","caller":"traceutil/trace.go:171","msg":"trace[1135678762] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"221.944475ms","start":"2026-05-12T11:21:20.72603Z","end":"2026-05-12T11:21:20.947974Z","steps":["trace[1135678762] 'process raft request' (duration: 221.644959ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:21:20.948152Z","caller":"traceutil/trace.go:171","msg":"trace[1153575807] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"222.867154ms","start":"2026-05-12T11:21:20.725242Z","end":"2026-05-12T11:21:20.948109Z","steps":["trace[1153575807] 'process raft request' (duration: 34.287402ms)","trace[1153575807] 'compare' (duration: 187.602642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:21:20.948293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.468112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:21:20.948357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.217061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-78897f78-c870-4771-a53e-0823a6507137\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-05-12T11:21:20.948393Z","caller":"traceutil/trace.go:171","msg":"trace[1965255626] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5524; }","duration":"172.628916ms","start":"2026-05-12T11:21:20.775746Z","end":"2026-05-12T11:21:20.948375Z","steps":["trace[1965255626] 'agreement among raft nodes before linearized reading' (duration: 172.472963ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:21:20.948418Z","caller":"traceutil/trace.go:171","msg":"trace[702554205] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-78897f78-c870-4771-a53e-0823a6507137; range_end:; response_count:1; response_revision:5524; }","duration":"182.333533ms","start":"2026-05-12T11:21:20.766068Z","end":"2026-05-12T11:21:20.948402Z","steps":["trace[702554205] 'agreement among raft nodes before linearized reading' (duration: 182.16097ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:22:17.194073Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3004} {"level":"info","ts":"2026-05-12T11:22:17.279264Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3004,"took":"83.763219ms","hash":3193712667,"current-db-size-bytes":57839616,"current-db-size":"58 MB","current-db-size-in-use-bytes":31305728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-12T11:22:17.279335Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3193712667,"revision":3004,"compact-revision":-1} {"level":"info","ts":"2026-05-12T11:27:17.200799Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6069} {"level":"info","ts":"2026-05-12T11:27:17.303113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6069,"took":"100.479387ms","hash":601944060,"current-db-size-bytes":57839616,"current-db-size":"58 MB","current-db-size-in-use-bytes":18280448,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-12T11:27:17.303202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":601944060,"revision":6069,"compact-revision":3004}