{"level":"warn","ts":"2026-04-16T22:50:14.1361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T22:50:14.136234Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-04-16T22:50:14.136308Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T22:50:14.136321Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-16T22:50:14.136341Z","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-04-16T22:50:14.137006Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-04-16T22:50:14.137095Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-04-16T22:50:14.140488Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.153939ms"} {"level":"info","ts":"2026-04-16T22:50:14.146706Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-04-16T22:50:14.146847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T22:50:14.146881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-04-16T22:50:14.146892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T22:50:14.146902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-04-16T22:50:14.146986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-04-16T22:50:14.152925Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T22:50:14.155644Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T22:50:14.157165Z","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-04-16T22:50:14.159701Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T22:50:14.160067Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T22:50:14.160173Z","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-04-16T22:50:14.160287Z","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-04-16T22:50:14.160298Z","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-04-16T22:50:14.161334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-04-16T22:50:14.161693Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-16T22:50:14.163061Z","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-04-16T22:50:14.163136Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-16T22:50:14.163185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-16T22:50:14.16344Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T22:50:14.163503Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T22:50:15.147752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T22:50:15.147852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T22:50:15.147884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-04-16T22:50:15.147912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-04-16T22:50:15.147931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-16T22:50:15.14795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-04-16T22:50:15.147971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-16T22:50:15.149298Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:50:15.150192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:50:15.150183Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T22:50:15.150326Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:50:15.150626Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:50:15.15067Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T22:50:15.150747Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T22:50:15.150758Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:50:15.150793Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:50:15.154443Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-04-16T22:50:15.154913Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-16T22:50:16.697109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.573203ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-16T22:50:16.697374Z","caller":"traceutil/trace.go:171","msg":"trace[1681143250] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"130.028456ms","start":"2026-04-16T22:50:16.567324Z","end":"2026-04-16T22:50:16.697352Z","steps":["trace[1681143250] 'process raft request' (duration: 129.945575ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:16.697602Z","caller":"traceutil/trace.go:171","msg":"trace[391891686] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"135.379735ms","start":"2026-04-16T22:50:16.562153Z","end":"2026-04-16T22:50:16.697533Z","steps":["trace[391891686] 'compare' (duration: 131.351849ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:28.253492Z","caller":"traceutil/trace.go:171","msg":"trace[1179315963] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:369; }","duration":"130.075906ms","start":"2026-04-16T22:50:28.12338Z","end":"2026-04-16T22:50:28.253456Z","steps":["trace[1179315963] 'read index received' (duration: 129.965654ms)","trace[1179315963] 'applied index is now lower than readState.Index' (duration: 108.772µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:50:28.25367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.256889ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T22:50:28.253803Z","caller":"traceutil/trace.go:171","msg":"trace[1221414365] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:360; }","duration":"130.413522ms","start":"2026-04-16T22:50:28.12337Z","end":"2026-04-16T22:50:28.253784Z","steps":["trace[1221414365] 'agreement among raft nodes before linearized reading' (duration: 130.225158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:56.752941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.106233ms","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-04-16T22:50:56.75303Z","caller":"traceutil/trace.go:171","msg":"trace[973274814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"227.248665ms","start":"2026-04-16T22:50:56.525763Z","end":"2026-04-16T22:50:56.753012Z","steps":["trace[973274814] 'range keys from in-memory index tree' (duration: 226.918609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:56.753033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.521174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T22:50:56.75294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.280883ms","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-04-16T22:50:56.753115Z","caller":"traceutil/trace.go:171","msg":"trace[1599769998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"169.673067ms","start":"2026-04-16T22:50:56.583421Z","end":"2026-04-16T22:50:56.753094Z","steps":["trace[1599769998] 'range keys from in-memory index tree' (duration: 169.430363ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:56.753147Z","caller":"traceutil/trace.go:171","msg":"trace[1049002431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"245.529018ms","start":"2026-04-16T22:50:56.507601Z","end":"2026-04-16T22:50:56.75313Z","steps":["trace[1049002431] 'range keys from in-memory index tree' (duration: 245.10105ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:56.826427Z","caller":"traceutil/trace.go:171","msg":"trace[1591806453] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"122.80779ms","start":"2026-04-16T22:50:56.70359Z","end":"2026-04-16T22:50:56.826397Z","steps":["trace[1591806453] 'process raft request' (duration: 121.039797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:57.321177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.634539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:50:57.321473Z","caller":"traceutil/trace.go:171","msg":"trace[822307998] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"563.867379ms","start":"2026-04-16T22:50:56.757551Z","end":"2026-04-16T22:50:57.321418Z","steps":["trace[822307998] 'process raft request' (duration: 403.623608ms)","trace[822307998] 'compare' (duration: 159.478337ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:50:57.321628Z","caller":"traceutil/trace.go:171","msg":"trace[2070935264] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"563.962851ms","start":"2026-04-16T22:50:56.75764Z","end":"2026-04-16T22:50:57.321603Z","steps":["trace[2070935264] 'process raft request' (duration: 563.677036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:57.321668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:50:56.757529Z","time spent":"564.037743ms","remote":"127.0.0.1:49342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T22:50:57.321702Z","caller":"traceutil/trace.go:171","msg":"trace[336801479] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:606; }","duration":"351.451931ms","start":"2026-04-16T22:50:56.970158Z","end":"2026-04-16T22:50:57.32161Z","steps":["trace[336801479] 'read index received' (duration: 191.033828ms)","trace[336801479] 'applied index is now lower than readState.Index' (duration: 160.416803ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:50:57.321775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:50:56.757613Z","time spent":"564.078943ms","remote":"127.0.0.1:49342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T22:50:57.321889Z","caller":"traceutil/trace.go:171","msg":"trace[2134423634] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"438.323669ms","start":"2026-04-16T22:50:56.883553Z","end":"2026-04-16T22:50:57.321877Z","steps":["trace[2134423634] 'process raft request' (duration: 437.942231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:57.321937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:50:56.883524Z","time spent":"438.38969ms","remote":"127.0.0.1:49312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T22:50:57.322015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.844999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-snhvz\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-16T22:50:57.322103Z","caller":"traceutil/trace.go:171","msg":"trace[1617065143] range","detail":"{range_begin:/registry/pods/kube-system/cilium-snhvz; range_end:; response_count:1; response_revision:590; }","duration":"351.971262ms","start":"2026-04-16T22:50:56.970116Z","end":"2026-04-16T22:50:57.322088Z","steps":["trace[1617065143] 'agreement among raft nodes before linearized reading' (duration: 351.684947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:57.322191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:50:56.970097Z","time spent":"352.080554ms","remote":"127.0.0.1:49270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-snhvz\" "} {"level":"info","ts":"2026-04-16T22:50:57.374257Z","caller":"traceutil/trace.go:171","msg":"trace[1287246494] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"104.535507ms","start":"2026-04-16T22:50:57.269688Z","end":"2026-04-16T22:50:57.374224Z","steps":["trace[1287246494] 'process raft request' (duration: 104.373994ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:12.896995Z","caller":"traceutil/trace.go:171","msg":"trace[76742433] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"117.516415ms","start":"2026-04-16T22:51:12.779452Z","end":"2026-04-16T22:51:12.896968Z","steps":["trace[76742433] 'process raft request' (duration: 117.286521ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:39.175725Z","caller":"traceutil/trace.go:171","msg":"trace[350645951] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"139.009788ms","start":"2026-04-16T22:51:39.03669Z","end":"2026-04-16T22:51:39.1757Z","steps":["trace[350645951] 'process raft request' (duration: 138.866395ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:52:24.595691Z","caller":"traceutil/trace.go:171","msg":"trace[1862209084] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"174.95318ms","start":"2026-04-16T22:52:24.420687Z","end":"2026-04-16T22:52:24.59564Z","steps":["trace[1862209084] 'process raft request' (duration: 174.679444ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.296773Z","caller":"traceutil/trace.go:171","msg":"trace[1078803297] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"280.28111ms","start":"2026-04-16T22:53:16.016462Z","end":"2026-04-16T22:53:16.296743Z","steps":["trace[1078803297] 'read index received' (duration: 280.119117ms)","trace[1078803297] 'applied index is now lower than readState.Index' (duration: 160.553µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:53:16.296843Z","caller":"traceutil/trace.go:171","msg":"trace[1181622556] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"300.467999ms","start":"2026-04-16T22:53:15.996341Z","end":"2026-04-16T22:53:16.296809Z","steps":["trace[1181622556] 'process raft request' (duration: 300.241815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.297095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.622596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-16T22:53:16.297122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:53:15.996308Z","time spent":"300.614032ms","remote":"127.0.0.1:49342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T22:53:16.297194Z","caller":"traceutil/trace.go:171","msg":"trace[1234114764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2136; }","duration":"280.767558ms","start":"2026-04-16T22:53:16.016391Z","end":"2026-04-16T22:53:16.297159Z","steps":["trace[1234114764] 'agreement among raft nodes before linearized reading' (duration: 280.527634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.320405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.02297ms","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-04-16T22:53:16.320501Z","caller":"traceutil/trace.go:171","msg":"trace[2094564419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2137; }","duration":"300.141043ms","start":"2026-04-16T22:53:16.020342Z","end":"2026-04-16T22:53:16.320483Z","steps":["trace[2094564419] 'agreement among raft nodes before linearized reading' (duration: 299.903779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.320568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:53:16.020334Z","time spent":"300.224095ms","remote":"127.0.0.1:49342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T22:53:16.320721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.635003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:53:16.320762Z","caller":"traceutil/trace.go:171","msg":"trace[939931970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2137; }","duration":"291.728094ms","start":"2026-04-16T22:53:16.029024Z","end":"2026-04-16T22:53:16.320752Z","steps":["trace[939931970] 'agreement among raft nodes before linearized reading' (duration: 291.663993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.32078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.067983ms","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-04-16T22:53:16.320798Z","caller":"traceutil/trace.go:171","msg":"trace[995218385] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"269.610719ms","start":"2026-04-16T22:53:16.051143Z","end":"2026-04-16T22:53:16.320754Z","steps":["trace[995218385] 'process raft request' (duration: 268.968197ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.320895Z","caller":"traceutil/trace.go:171","msg":"trace[1376893896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2137; }","duration":"241.202715ms","start":"2026-04-16T22:53:16.07965Z","end":"2026-04-16T22:53:16.320852Z","steps":["trace[1376893896] 'agreement among raft nodes before linearized reading' (duration: 241.017782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.32146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.467624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-16T22:53:16.321499Z","caller":"traceutil/trace.go:171","msg":"trace[1564643046] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2137; }","duration":"229.528516ms","start":"2026-04-16T22:53:16.091959Z","end":"2026-04-16T22:53:16.321487Z","steps":["trace[1564643046] 'agreement among raft nodes before linearized reading' (duration: 228.880094ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.548729Z","caller":"traceutil/trace.go:171","msg":"trace[1278923713] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"223.34814ms","start":"2026-04-16T22:53:16.325356Z","end":"2026-04-16T22:53:16.548704Z","steps":["trace[1278923713] 'process raft request' (duration: 223.135496ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.549131Z","caller":"traceutil/trace.go:171","msg":"trace[1388606347] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"223.619103ms","start":"2026-04-16T22:53:16.325497Z","end":"2026-04-16T22:53:16.549116Z","steps":["trace[1388606347] 'process raft request' (duration: 223.4596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.54933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.50621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-04-16T22:53:16.549375Z","caller":"traceutil/trace.go:171","msg":"trace[1137764607] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2142; }","duration":"124.600262ms","start":"2026-04-16T22:53:16.424766Z","end":"2026-04-16T22:53:16.549366Z","steps":["trace[1137764607] 'agreement among raft nodes before linearized reading' (duration: 124.403608ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.54912Z","caller":"traceutil/trace.go:171","msg":"trace[939383525] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2214; }","duration":"124.287986ms","start":"2026-04-16T22:53:16.424813Z","end":"2026-04-16T22:53:16.549101Z","steps":["trace[939383525] 'read index received' (duration: 123.618984ms)","trace[939383525] 'applied index is now lower than readState.Index' (duration: 667.952µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:53:16.549568Z","caller":"traceutil/trace.go:171","msg":"trace[963597894] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"223.772837ms","start":"2026-04-16T22:53:16.325785Z","end":"2026-04-16T22:53:16.549558Z","steps":["trace[963597894] 'process raft request' (duration: 223.265067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:16.549695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.779272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:91495"} {"level":"info","ts":"2026-04-16T22:53:16.54909Z","caller":"traceutil/trace.go:171","msg":"trace[1143411643] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"223.688404ms","start":"2026-04-16T22:53:16.325372Z","end":"2026-04-16T22:53:16.54906Z","steps":["trace[1143411643] 'process raft request' (duration: 223.292077ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:16.549763Z","caller":"traceutil/trace.go:171","msg":"trace[567717969] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2142; }","duration":"119.895484ms","start":"2026-04-16T22:53:16.429851Z","end":"2026-04-16T22:53:16.549746Z","steps":["trace[567717969] 'agreement among raft nodes before linearized reading' (duration: 119.67373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:54:44.542189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.206194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:54:44.542329Z","caller":"traceutil/trace.go:171","msg":"trace[1414444526] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"216.477937ms","start":"2026-04-16T22:54:44.325828Z","end":"2026-04-16T22:54:44.542306Z","steps":["trace[1414444526] 'process raft request' (duration: 78.888166ms)","trace[1414444526] 'compare' (duration: 136.99274ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:57:09.746382Z","caller":"traceutil/trace.go:171","msg":"trace[1817546773] transaction","detail":"{read_only:false; response_revision:3777; number_of_response:1; }","duration":"105.209571ms","start":"2026-04-16T22:57:09.641151Z","end":"2026-04-16T22:57:09.746361Z","steps":["trace[1817546773] 'process raft request' (duration: 105.036728ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:09.747528Z","caller":"traceutil/trace.go:171","msg":"trace[2026421705] transaction","detail":"{read_only:false; response_revision:3778; number_of_response:1; }","duration":"105.661429ms","start":"2026-04-16T22:57:09.64184Z","end":"2026-04-16T22:57:09.747502Z","steps":["trace[2026421705] 'process raft request' (duration: 105.550727ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:26.661902Z","caller":"traceutil/trace.go:171","msg":"trace[719090294] linearizableReadLoop","detail":"{readStateIndex:4958; appliedIndex:4955; }","duration":"111.726264ms","start":"2026-04-16T22:58:26.550161Z","end":"2026-04-16T22:58:26.661887Z","steps":["trace[719090294] 'read index received' (duration: 110.306608ms)","trace[719090294] 'applied index is now lower than readState.Index' (duration: 1.418646ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:58:26.661908Z","caller":"traceutil/trace.go:171","msg":"trace[1060731341] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"133.615827ms","start":"2026-04-16T22:58:26.528264Z","end":"2026-04-16T22:58:26.66188Z","steps":["trace[1060731341] 'process raft request' (duration: 132.259152ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:26.661995Z","caller":"traceutil/trace.go:171","msg":"trace[2002796167] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"131.054418ms","start":"2026-04-16T22:58:26.530934Z","end":"2026-04-16T22:58:26.661988Z","steps":["trace[2002796167] 'process raft request' (duration: 130.872584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:26.662189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.715652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-04-16T22:58:26.662234Z","caller":"traceutil/trace.go:171","msg":"trace[1140414693] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4780; }","duration":"112.760023ms","start":"2026-04-16T22:58:26.54946Z","end":"2026-04-16T22:58:26.66222Z","steps":["trace[1140414693] 'agreement among raft nodes before linearized reading' (duration: 112.60924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:26.662327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.273278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:58:26.662358Z","caller":"traceutil/trace.go:171","msg":"trace[245137479] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4780; }","duration":"117.492562ms","start":"2026-04-16T22:58:26.544855Z","end":"2026-04-16T22:58:26.662348Z","steps":["trace[245137479] 'agreement among raft nodes before linearized reading' (duration: 117.280768ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:26.66251Z","caller":"traceutil/trace.go:171","msg":"trace[1993660600] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"123.18405ms","start":"2026-04-16T22:58:26.539315Z","end":"2026-04-16T22:58:26.662499Z","steps":["trace[1993660600] 'process raft request' (duration: 122.523808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:26.662566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.911123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:75462"} {"level":"info","ts":"2026-04-16T22:58:26.66259Z","caller":"traceutil/trace.go:171","msg":"trace[1144585794] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4780; }","duration":"105.957795ms","start":"2026-04-16T22:58:26.556627Z","end":"2026-04-16T22:58:26.662585Z","steps":["trace[1144585794] 'agreement among raft nodes before linearized reading' (duration: 105.841553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:26.825862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.451651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-16T22:58:26.825958Z","caller":"traceutil/trace.go:171","msg":"trace[1608347318] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4783; }","duration":"101.559343ms","start":"2026-04-16T22:58:26.724379Z","end":"2026-04-16T22:58:26.825938Z","steps":["trace[1608347318] 'agreement among raft nodes before linearized reading' (duration: 101.254447ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:26.861592Z","caller":"traceutil/trace.go:171","msg":"trace[1181574992] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"115.054876ms","start":"2026-04-16T22:58:26.746512Z","end":"2026-04-16T22:58:26.861567Z","steps":["trace[1181574992] 'process raft request' (duration: 114.906253ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:42.254988Z","caller":"traceutil/trace.go:171","msg":"trace[310413233] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"188.338986ms","start":"2026-04-16T22:58:42.066611Z","end":"2026-04-16T22:58:42.25495Z","steps":["trace[310413233] 'process raft request' (duration: 188.01029ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:49.654296Z","caller":"traceutil/trace.go:171","msg":"trace[2104621103] linearizableReadLoop","detail":"{readStateIndex:5476; appliedIndex:5475; }","duration":"154.618492ms","start":"2026-04-16T22:58:49.49965Z","end":"2026-04-16T22:58:49.654269Z","steps":["trace[2104621103] 'read index received' (duration: 154.436889ms)","trace[2104621103] 'applied index is now lower than readState.Index' (duration: 180.423µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:58:49.654364Z","caller":"traceutil/trace.go:171","msg":"trace[1319305147] transaction","detail":"{read_only:false; response_revision:5284; number_of_response:1; }","duration":"185.36107ms","start":"2026-04-16T22:58:49.468972Z","end":"2026-04-16T22:58:49.654333Z","steps":["trace[1319305147] 'process raft request' (duration: 185.097356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:49.654533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.071744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-16T22:58:49.654575Z","caller":"traceutil/trace.go:171","msg":"trace[1753458552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5284; }","duration":"212.184146ms","start":"2026-04-16T22:58:49.442381Z","end":"2026-04-16T22:58:49.654565Z","steps":["trace[1753458552] 'agreement among raft nodes before linearized reading' (duration: 212.015263ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:49.733425Z","caller":"traceutil/trace.go:171","msg":"trace[1756495623] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"225.782241ms","start":"2026-04-16T22:58:49.507542Z","end":"2026-04-16T22:58:49.733324Z","steps":["trace[1756495623] 'process raft request' (duration: 225.560157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:49.733497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.522485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:58:49.733601Z","caller":"traceutil/trace.go:171","msg":"trace[313087904] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5285; }","duration":"218.645117ms","start":"2026-04-16T22:58:49.514904Z","end":"2026-04-16T22:58:49.73355Z","steps":["trace[313087904] 'agreement among raft nodes before linearized reading' (duration: 218.367111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:58:49.733552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.052433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T22:58:49.733904Z","caller":"traceutil/trace.go:171","msg":"trace[454298966] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5285; }","duration":"161.473791ms","start":"2026-04-16T22:58:49.572405Z","end":"2026-04-16T22:58:49.733878Z","steps":["trace[454298966] 'agreement among raft nodes before linearized reading' (duration: 161.021322ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:01.820145Z","caller":"traceutil/trace.go:171","msg":"trace[1674463336] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"185.928261ms","start":"2026-04-16T22:59:01.63417Z","end":"2026-04-16T22:59:01.820098Z","steps":["trace[1674463336] 'process raft request' (duration: 185.84961ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:01.820167Z","caller":"traceutil/trace.go:171","msg":"trace[1627299624] transaction","detail":"{read_only:false; response_revision:5481; number_of_response:1; }","duration":"186.037403ms","start":"2026-04-16T22:59:01.634093Z","end":"2026-04-16T22:59:01.820131Z","steps":["trace[1627299624] 'process raft request' (duration: 130.566629ms)","trace[1627299624] 'compare' (duration: 55.069336ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:59:01.820136Z","caller":"traceutil/trace.go:171","msg":"trace[72380092] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"122.362973ms","start":"2026-04-16T22:59:01.697749Z","end":"2026-04-16T22:59:01.820112Z","steps":["trace[72380092] 'process raft request' (duration: 122.314472ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:01.820189Z","caller":"traceutil/trace.go:171","msg":"trace[1479596763] linearizableReadLoop","detail":"{readStateIndex:5680; appliedIndex:5676; }","duration":"165.239531ms","start":"2026-04-16T22:59:01.654926Z","end":"2026-04-16T22:59:01.820165Z","steps":["trace[1479596763] 'read index received' (duration: 39.492313ms)","trace[1479596763] 'applied index is now lower than readState.Index' (duration: 125.743928ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:59:01.820552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.583778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3eed7dd0-fca1-4781-a747-e3be139588ff\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-16T22:59:01.820596Z","caller":"traceutil/trace.go:171","msg":"trace[1032002290] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3eed7dd0-fca1-4781-a747-e3be139588ff; range_end:; response_count:1; response_revision:5484; }","duration":"165.68729ms","start":"2026-04-16T22:59:01.654896Z","end":"2026-04-16T22:59:01.820583Z","steps":["trace[1032002290] 'agreement among raft nodes before linearized reading' (duration: 165.513257ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:59:01.820376Z","caller":"traceutil/trace.go:171","msg":"trace[539520869] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"186.206817ms","start":"2026-04-16T22:59:01.634153Z","end":"2026-04-16T22:59:01.82036Z","steps":["trace[539520869] 'process raft request' (duration: 185.783038ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:00:15.182894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2977} {"level":"info","ts":"2026-04-16T23:00:15.252086Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2977,"took":"67.462423ms","hash":2306047784,"current-db-size-bytes":57126912,"current-db-size":"57 MB","current-db-size-in-use-bytes":33988608,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-16T23:00:15.252163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2306047784,"revision":2977,"compact-revision":-1} {"level":"info","ts":"2026-04-16T23:04:57.731908Z","caller":"traceutil/trace.go:171","msg":"trace[660213015] linearizableReadLoop","detail":"{readStateIndex:8447; appliedIndex:8446; }","duration":"183.876127ms","start":"2026-04-16T23:04:57.548002Z","end":"2026-04-16T23:04:57.731878Z","steps":["trace[660213015] 'read index received' (duration: 183.832046ms)","trace[660213015] 'applied index is now lower than readState.Index' (duration: 42.861µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:57.73207Z","caller":"traceutil/trace.go:171","msg":"trace[1064320772] transaction","detail":"{read_only:false; response_revision:8165; number_of_response:1; }","duration":"300.180311ms","start":"2026-04-16T23:04:57.431819Z","end":"2026-04-16T23:04:57.731999Z","steps":["trace[1064320772] 'process raft request' (duration: 299.901985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:57.73217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.148833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-16T23:04:57.732219Z","caller":"traceutil/trace.go:171","msg":"trace[955734225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8165; }","duration":"184.258284ms","start":"2026-04-16T23:04:57.547949Z","end":"2026-04-16T23:04:57.732207Z","steps":["trace[955734225] 'agreement among raft nodes before linearized reading' (duration: 184.072741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:57.732306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:04:57.431786Z","time spent":"300.414295ms","remote":"127.0.0.1:49268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T23:04:57.802723Z","caller":"traceutil/trace.go:171","msg":"trace[1733773254] transaction","detail":"{read_only:false; response_revision:8166; number_of_response:1; }","duration":"243.002142ms","start":"2026-04-16T23:04:57.559688Z","end":"2026-04-16T23:04:57.80269Z","steps":["trace[1733773254] 'process raft request' (duration: 229.772973ms)","trace[1733773254] 'compare' (duration: 13.093326ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:04:57.802949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.391375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T23:04:57.802955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.59777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T23:04:57.803052Z","caller":"traceutil/trace.go:171","msg":"trace[1234269990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8167; }","duration":"220.495857ms","start":"2026-04-16T23:04:57.582534Z","end":"2026-04-16T23:04:57.80303Z","steps":["trace[1234269990] 'agreement among raft nodes before linearized reading' (duration: 220.161591ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:57.803099Z","caller":"traceutil/trace.go:171","msg":"trace[314682203] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:8167; }","duration":"185.796794ms","start":"2026-04-16T23:04:57.61728Z","end":"2026-04-16T23:04:57.803077Z","steps":["trace[314682203] 'agreement among raft nodes before linearized reading' (duration: 185.437177ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:05:15.191747Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6092} {"level":"info","ts":"2026-04-16T23:05:15.325926Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6092,"took":"132.009271ms","hash":2678219289,"current-db-size-bytes":57126912,"current-db-size":"57 MB","current-db-size-in-use-bytes":23101440,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-16T23:05:15.326004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2678219289,"revision":6092,"compact-revision":2977} {"level":"info","ts":"2026-04-16T23:05:51.085347Z","caller":"traceutil/trace.go:171","msg":"trace[1289701853] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"240.429284ms","start":"2026-04-16T23:05:50.844891Z","end":"2026-04-16T23:05:51.08532Z","steps":["trace[1289701853] 'process raft request' (duration: 240.23815ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:06:42.386459Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246d.wal"} {"level":"info","ts":"2026-04-16T23:07:09.150419Z","caller":"traceutil/trace.go:171","msg":"trace[1132280418] linearizableReadLoop","detail":"{readStateIndex:9633; appliedIndex:9631; }","duration":"160.937427ms","start":"2026-04-16T23:07:08.989448Z","end":"2026-04-16T23:07:09.150386Z","steps":["trace[1132280418] 'read index received' (duration: 62.058291ms)","trace[1132280418] 'applied index is now lower than readState.Index' (duration: 98.877586ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:07:09.150478Z","caller":"traceutil/trace.go:171","msg":"trace[852769059] transaction","detail":"{read_only:false; response_revision:9311; number_of_response:1; }","duration":"173.070265ms","start":"2026-04-16T23:07:08.977368Z","end":"2026-04-16T23:07:09.150438Z","steps":["trace[852769059] 'process raft request' (duration: 142.016469ms)","trace[852769059] 'compare' (duration: 30.863673ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:07:09.150652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.189282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-qlb6c\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-16T23:07:09.150697Z","caller":"traceutil/trace.go:171","msg":"trace[679977048] range","detail":"{range_begin:/registry/pods/openstack/keepalived-qlb6c; range_end:; response_count:1; response_revision:9311; }","duration":"161.281973ms","start":"2026-04-16T23:07:08.989405Z","end":"2026-04-16T23:07:09.150687Z","steps":["trace[679977048] 'agreement among raft nodes before linearized reading' (duration: 161.1119ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:07:09.616177Z","caller":"traceutil/trace.go:171","msg":"trace[1394765495] transaction","detail":"{read_only:false; response_revision:9313; number_of_response:1; }","duration":"134.265104ms","start":"2026-04-16T23:07:09.481842Z","end":"2026-04-16T23:07:09.616107Z","steps":["trace[1394765495] 'process raft request' (duration: 116.500548ms)","trace[1394765495] 'compare' (duration: 17.525172ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:07:59.389834Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T23:07:59.395669Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T23:07:59.395787Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T23:10:15.197343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8268} {"level":"info","ts":"2026-04-16T23:10:15.274229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8268,"took":"74.798101ms","hash":761842387,"current-db-size-bytes":57126912,"current-db-size":"57 MB","current-db-size-in-use-bytes":24932352,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T23:10:15.274305Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":761842387,"revision":8268,"compact-revision":6092} {"level":"info","ts":"2026-04-16T23:15:15.203202Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10659} {"level":"info","ts":"2026-04-16T23:15:15.277963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10659,"took":"72.399706ms","hash":3184952393,"current-db-size-bytes":57126912,"current-db-size":"57 MB","current-db-size-in-use-bytes":20344832,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-16T23:15:15.278022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3184952393,"revision":10659,"compact-revision":8268}