{"level":"warn","ts":"2026-05-19T13:21:54.843709Z","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-19T13:21:54.843796Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-19T13:21:54.843858Z","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-19T13:21:54.843873Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-19T13:21:54.843892Z","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-19T13:21:54.844506Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-05-19T13:21:54.844577Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-19T13:21:54.849967Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.17263ms"} {"level":"info","ts":"2026-05-19T13:21:54.858675Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-05-19T13:21:54.858742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T13:21:54.858769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-05-19T13:21:54.858779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T13:21:54.858796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-05-19T13:21:54.858833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-05-19T13:21:54.864039Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T13:21:54.865134Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T13:21:54.866031Z","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-19T13:21:54.867947Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T13:21:54.869059Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T13:21:54.869218Z","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-19T13:21:54.869294Z","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-19T13:21:54.869302Z","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-19T13:21:54.871674Z","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-19T13:21:54.871868Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T13:21:54.871899Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T13:21:54.870422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-05-19T13:21:54.872041Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-19T13:21:54.872027Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-19T13:21:54.87208Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-19T13:21:55.159933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T13:21:55.159992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T13:21:55.160025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-05-19T13:21:55.160045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-05-19T13:21:55.160056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-19T13:21:55.160075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-05-19T13:21:55.160096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-19T13:21:55.160994Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:21:55.161903Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:21:55.161897Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T13:21:55.16195Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:21:55.162301Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:21:55.162322Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T13:21:55.162384Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T13:21:55.162415Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:21:55.162607Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:21:55.165592Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-05-19T13:21:55.165789Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T13:21:57.319485Z","caller":"traceutil/trace.go:171","msg":"trace[1773052698] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"228.641082ms","start":"2026-05-19T13:21:57.090818Z","end":"2026-05-19T13:21:57.319459Z","steps":["trace[1773052698] 'process raft request' (duration: 228.501726ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:25.404174Z","caller":"traceutil/trace.go:171","msg":"trace[126890441] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"108.831604ms","start":"2026-05-19T13:22:25.295319Z","end":"2026-05-19T13:22:25.404151Z","steps":["trace[126890441] 'process raft request' (duration: 108.73316ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:25.411959Z","caller":"traceutil/trace.go:171","msg":"trace[918254207] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"110.000413ms","start":"2026-05-19T13:22:25.301935Z","end":"2026-05-19T13:22:25.411936Z","steps":["trace[918254207] 'process raft request' (duration: 109.04641ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:25.412496Z","caller":"traceutil/trace.go:171","msg":"trace[714576492] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"110.482401ms","start":"2026-05-19T13:22:25.301986Z","end":"2026-05-19T13:22:25.412468Z","steps":["trace[714576492] 'process raft request' (duration: 109.090562ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:31.11053Z","caller":"traceutil/trace.go:171","msg":"trace[466752839] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"175.024122ms","start":"2026-05-19T13:22:30.935438Z","end":"2026-05-19T13:22:31.110462Z","steps":["trace[466752839] 'process raft request' (duration: 172.004774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:22:31.45588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.282228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:22:31.456019Z","caller":"traceutil/trace.go:171","msg":"trace[421495730] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"154.446833ms","start":"2026-05-19T13:22:31.301555Z","end":"2026-05-19T13:22:31.456001Z","steps":["trace[421495730] 'compare' (duration: 145.172123ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:31.97556Z","caller":"traceutil/trace.go:171","msg":"trace[1011542804] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"237.302222ms","start":"2026-05-19T13:22:31.738172Z","end":"2026-05-19T13:22:31.975474Z","steps":["trace[1011542804] 'read index received' (duration: 236.898289ms)","trace[1011542804] 'applied index is now lower than readState.Index' (duration: 402.213µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:22:31.975646Z","caller":"traceutil/trace.go:171","msg":"trace[247526012] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"316.481322ms","start":"2026-05-19T13:22:31.659131Z","end":"2026-05-19T13:22:31.975613Z","steps":["trace[247526012] 'process raft request' (duration: 316.08395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:22:31.975909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:22:31.659104Z","time spent":"316.609597ms","remote":"127.0.0.1:55208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T13:22:31.976051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.821229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4v2lj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T13:22:31.97614Z","caller":"traceutil/trace.go:171","msg":"trace[984875246] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4v2lj; range_end:; response_count:1; response_revision:623; }","duration":"237.995515ms","start":"2026-05-19T13:22:31.738126Z","end":"2026-05-19T13:22:31.976121Z","steps":["trace[984875246] 'agreement among raft nodes before linearized reading' (duration: 237.549769ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:32.153976Z","caller":"traceutil/trace.go:171","msg":"trace[1461472713] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"161.894418ms","start":"2026-05-19T13:22:31.992042Z","end":"2026-05-19T13:22:32.153937Z","steps":["trace[1461472713] 'process raft request' (duration: 155.321978ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:47.590313Z","caller":"traceutil/trace.go:171","msg":"trace[1437942165] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"100.355081ms","start":"2026-05-19T13:22:47.489924Z","end":"2026-05-19T13:22:47.590279Z","steps":["trace[1437942165] 'process raft request' (duration: 100.023441ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:47.7832Z","caller":"traceutil/trace.go:171","msg":"trace[634276436] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"188.054637ms","start":"2026-05-19T13:22:47.595113Z","end":"2026-05-19T13:22:47.783167Z","steps":["trace[634276436] 'process raft request' (duration: 143.413001ms)","trace[634276436] 'compare' (duration: 44.488851ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:23:19.190465Z","caller":"traceutil/trace.go:171","msg":"trace[622785343] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"272.666301ms","start":"2026-05-19T13:23:18.917782Z","end":"2026-05-19T13:23:19.190449Z","steps":["trace[622785343] 'process raft request' (duration: 272.505108ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:23:19.191325Z","caller":"traceutil/trace.go:171","msg":"trace[1527898882] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1223; }","duration":"188.26817ms","start":"2026-05-19T13:23:19.00303Z","end":"2026-05-19T13:23:19.191298Z","steps":["trace[1527898882] 'read index received' (duration: 187.270578ms)","trace[1527898882] 'applied index is now lower than readState.Index' (duration: 996.452µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:23:19.191528Z","caller":"traceutil/trace.go:171","msg":"trace[1129442423] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"273.333176ms","start":"2026-05-19T13:23:18.918099Z","end":"2026-05-19T13:23:19.191432Z","steps":["trace[1129442423] 'process raft request' (duration: 273.080291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:23:19.191721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.147347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T13:23:19.191829Z","caller":"traceutil/trace.go:171","msg":"trace[1918769669] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"170.349901ms","start":"2026-05-19T13:23:19.021455Z","end":"2026-05-19T13:23:19.191805Z","steps":["trace[1918769669] 'agreement among raft nodes before linearized reading' (duration: 170.092416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:23:19.192072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.029547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"warn","ts":"2026-05-19T13:23:19.192103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.48004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:23:19.192163Z","caller":"traceutil/trace.go:171","msg":"trace[1307334818] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1194; }","duration":"140.543782ms","start":"2026-05-19T13:23:19.051604Z","end":"2026-05-19T13:23:19.192148Z","steps":["trace[1307334818] 'agreement among raft nodes before linearized reading' (duration: 140.45372ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:23:19.192135Z","caller":"traceutil/trace.go:171","msg":"trace[227592944] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1194; }","duration":"189.129759ms","start":"2026-05-19T13:23:19.00298Z","end":"2026-05-19T13:23:19.19211Z","steps":["trace[227592944] 'agreement among raft nodes before linearized reading' (duration: 189.015126ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:07.236233Z","caller":"traceutil/trace.go:171","msg":"trace[2137876333] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"104.954226ms","start":"2026-05-19T13:24:07.131258Z","end":"2026-05-19T13:24:07.236212Z","steps":["trace[2137876333] 'process raft request' (duration: 104.835764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:07.629052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.959738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:24:07.629149Z","caller":"traceutil/trace.go:171","msg":"trace[1776951088] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"204.260729ms","start":"2026-05-19T13:24:07.424872Z","end":"2026-05-19T13:24:07.629132Z","steps":["trace[1776951088] 'read index received' (duration: 93.131858ms)","trace[1776951088] 'applied index is now lower than readState.Index' (duration: 111.127871ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:24:07.629322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.845215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-19T13:24:07.629351Z","caller":"traceutil/trace.go:171","msg":"trace[1126061250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1875; }","duration":"202.902086ms","start":"2026-05-19T13:24:07.426437Z","end":"2026-05-19T13:24:07.629339Z","steps":["trace[1126061250] 'agreement among raft nodes before linearized reading' (duration: 202.785824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:07.629525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.577384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-19T13:24:07.629613Z","caller":"traceutil/trace.go:171","msg":"trace[1954961286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1875; }","duration":"204.778937ms","start":"2026-05-19T13:24:07.424811Z","end":"2026-05-19T13:24:07.62959Z","steps":["trace[1954961286] 'agreement among raft nodes before linearized reading' (duration: 204.396351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:07.629741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.956228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:24:07.629765Z","caller":"traceutil/trace.go:171","msg":"trace[1862866453] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"294.65439ms","start":"2026-05-19T13:24:07.335067Z","end":"2026-05-19T13:24:07.629721Z","steps":["trace[1862866453] 'process raft request' (duration: 182.945499ms)","trace[1862866453] 'compare' (duration: 110.873287ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:24:07.629825Z","caller":"traceutil/trace.go:171","msg":"trace[514688046] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1875; }","duration":"133.086391ms","start":"2026-05-19T13:24:07.496721Z","end":"2026-05-19T13:24:07.629808Z","steps":["trace[514688046] 'agreement among raft nodes before linearized reading' (duration: 132.949559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:07.629844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.658841ms","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-19T13:24:07.629893Z","caller":"traceutil/trace.go:171","msg":"trace[48770417] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1875; }","duration":"202.720772ms","start":"2026-05-19T13:24:07.427158Z","end":"2026-05-19T13:24:07.629879Z","steps":["trace[48770417] 'agreement among raft nodes before linearized reading' (duration: 202.543169ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:07.763523Z","caller":"traceutil/trace.go:171","msg":"trace[841556719] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"115.038407ms","start":"2026-05-19T13:24:07.648453Z","end":"2026-05-19T13:24:07.763491Z","steps":["trace[841556719] 'process raft request' (duration: 109.019225ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:55.954575Z","caller":"traceutil/trace.go:171","msg":"trace[522446862] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"141.906417ms","start":"2026-05-19T13:24:55.812627Z","end":"2026-05-19T13:24:55.954533Z","steps":["trace[522446862] 'process raft request' (duration: 141.659944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:57.011167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.982385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T13:24:57.011286Z","caller":"traceutil/trace.go:171","msg":"trace[1403628339] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2196; }","duration":"173.148977ms","start":"2026-05-19T13:24:56.83811Z","end":"2026-05-19T13:24:57.011259Z","steps":["trace[1403628339] 'count revisions from in-memory index tree' (duration: 172.888733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:26:19.167499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.979533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-19T13:26:19.167588Z","caller":"traceutil/trace.go:171","msg":"trace[1558162833] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2751; }","duration":"213.143519ms","start":"2026-05-19T13:26:18.954426Z","end":"2026-05-19T13:26:19.167569Z","steps":["trace[1558162833] 'count revisions from in-memory index tree' (duration: 212.863258ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:26:19.168225Z","caller":"traceutil/trace.go:171","msg":"trace[860068380] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"191.445324ms","start":"2026-05-19T13:26:18.976743Z","end":"2026-05-19T13:26:19.168189Z","steps":["trace[860068380] 'process raft request' (duration: 176.073313ms)","trace[860068380] 'compare' (duration: 15.238676ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:26:19.168332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.681436ms","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-19T13:26:19.168401Z","caller":"traceutil/trace.go:171","msg":"trace[929738006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2751; }","duration":"195.78215ms","start":"2026-05-19T13:26:18.972606Z","end":"2026-05-19T13:26:19.168389Z","steps":["trace[929738006] 'range keys from in-memory index tree' (duration: 194.607011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:26:19.16844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.629745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-19T13:26:19.168505Z","caller":"traceutil/trace.go:171","msg":"trace[674271923] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2752; }","duration":"188.75866ms","start":"2026-05-19T13:26:18.979729Z","end":"2026-05-19T13:26:19.168488Z","steps":["trace[674271923] 'agreement among raft nodes before linearized reading' (duration: 188.550221ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:26:19.168686Z","caller":"traceutil/trace.go:171","msg":"trace[348790469] linearizableReadLoop","detail":"{readStateIndex:2847; appliedIndex:2846; }","duration":"188.877965ms","start":"2026-05-19T13:26:18.979795Z","end":"2026-05-19T13:26:19.168673Z","steps":["trace[348790469] 'read index received' (duration: 172.991162ms)","trace[348790469] 'applied index is now lower than readState.Index' (duration: 15.360701ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:26:19.169005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.789191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:26:19.169058Z","caller":"traceutil/trace.go:171","msg":"trace[486104199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2752; }","duration":"161.882924ms","start":"2026-05-19T13:26:19.007163Z","end":"2026-05-19T13:26:19.169046Z","steps":["trace[486104199] 'agreement among raft nodes before linearized reading' (duration: 161.654755ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:11.359557Z","caller":"traceutil/trace.go:171","msg":"trace[1624165058] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"270.094012ms","start":"2026-05-19T13:30:11.089436Z","end":"2026-05-19T13:30:11.35953Z","steps":["trace[1624165058] 'process raft request' (duration: 269.883038ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:11.43062Z","caller":"traceutil/trace.go:171","msg":"trace[1261247628] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4914; }","duration":"138.265728ms","start":"2026-05-19T13:30:11.292335Z","end":"2026-05-19T13:30:11.430601Z","steps":["trace[1261247628] 'read index received' (duration: 67.140224ms)","trace[1261247628] 'applied index is now lower than readState.Index' (duration: 71.124634ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:30:11.430707Z","caller":"traceutil/trace.go:171","msg":"trace[1470871517] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"321.832142ms","start":"2026-05-19T13:30:11.108846Z","end":"2026-05-19T13:30:11.430679Z","steps":["trace[1470871517] 'process raft request' (duration: 303.732974ms)","trace[1470871517] 'compare' (duration: 17.874504ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:30:11.430839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:11.108827Z","time spent":"321.940384ms","remote":"127.0.0.1:54968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T13:30:11.43092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.566913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:30:11.430998Z","caller":"traceutil/trace.go:171","msg":"trace[582724975] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4743; }","duration":"138.665465ms","start":"2026-05-19T13:30:11.292314Z","end":"2026-05-19T13:30:11.43098Z","steps":["trace[582724975] 'agreement among raft nodes before linearized reading' (duration: 138.3951ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:11.978063Z","caller":"traceutil/trace.go:171","msg":"trace[1003322456] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"123.470576ms","start":"2026-05-19T13:30:11.854569Z","end":"2026-05-19T13:30:11.97804Z","steps":["trace[1003322456] 'process raft request' (duration: 109.172316ms)","trace[1003322456] 'compare' (duration: 13.881952ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:30:25.379418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.007069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:30:25.37951Z","caller":"traceutil/trace.go:171","msg":"trace[905246207] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:4940; }","duration":"141.156492ms","start":"2026-05-19T13:30:25.238333Z","end":"2026-05-19T13:30:25.379489Z","steps":["trace[905246207] 'count revisions from in-memory index tree' (duration: 140.908878ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:31:55.186662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2942} {"level":"info","ts":"2026-05-19T13:31:55.296515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2942,"took":"107.603788ms","hash":3215934206,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":29769728,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-19T13:31:55.296598Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3215934206,"revision":2942,"compact-revision":-1} {"level":"info","ts":"2026-05-19T13:36:55.193553Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5672} {"level":"info","ts":"2026-05-19T13:36:55.281114Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5672,"took":"86.374273ms","hash":1095267141,"current-db-size-bytes":54460416,"current-db-size":"54 MB","current-db-size-in-use-bytes":18432000,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T13:36:55.281186Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1095267141,"revision":5672,"compact-revision":2942}