{"level":"warn","ts":"2026-04-09T13:22:45.007669Z","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-09T13:22:45.00775Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.48: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.19.213.48:2380","--initial-cluster=instance=https://199.19.213.48:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.48:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.48: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-09T13:22:45.007819Z","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-09T13:22:45.007833Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-04-09T13:22:45.007849Z","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-09T13:22:45.008459Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"]} {"level":"info","ts":"2026-04-09T13:22:45.008527Z","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.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.48: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-09T13:22:45.012555Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.819256ms"} {"level":"info","ts":"2026-04-09T13:22:45.018867Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7317567213c7319d","cluster-id":"d22ed1e1757a8527"} {"level":"info","ts":"2026-04-09T13:22:45.019003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T13:22:45.019045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 0"} {"level":"info","ts":"2026-04-09T13:22:45.019113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7317567213c7319d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T13:22:45.019144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 1"} {"level":"info","ts":"2026-04-09T13:22:45.019257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"warn","ts":"2026-04-09T13:22:45.024844Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T13:22:45.026088Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T13:22:45.027148Z","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-09T13:22:45.029197Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7317567213c7319d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T13:22:45.029386Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7317567213c7319d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T13:22:45.02957Z","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-09T13:22:45.029632Z","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-09T13:22:45.029646Z","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-09T13:22:45.031421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"info","ts":"2026-04-09T13:22:45.032039Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","added-peer-id":"7317567213c7319d","added-peer-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-04-09T13:22:45.033871Z","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-09T13:22:45.033997Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-04-09T13:22:45.03406Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-04-09T13:22:45.034198Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7317567213c7319d","initial-advertise-peer-urls":["https://199.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T13:22:45.034244Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T13:22:45.42023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T13:22:45.420289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T13:22:45.420325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgPreVoteResp from 7317567213c7319d at term 1"} {"level":"info","ts":"2026-04-09T13:22:45.420345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became candidate at term 2"} {"level":"info","ts":"2026-04-09T13:22:45.420356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgVoteResp from 7317567213c7319d at term 2"} {"level":"info","ts":"2026-04-09T13:22:45.420526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became leader at term 2"} {"level":"info","ts":"2026-04-09T13:22:45.42057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7317567213c7319d elected leader 7317567213c7319d at term 2"} {"level":"info","ts":"2026-04-09T13:22:45.429613Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7317567213c7319d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.48:2379]}","request-path":"/0/members/7317567213c7319d/attributes","cluster-id":"d22ed1e1757a8527","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T13:22:45.429626Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T13:22:45.429705Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T13:22:45.429746Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T13:22:45.430135Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T13:22:45.430177Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T13:22:45.430807Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T13:22:45.430947Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T13:22:45.431026Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T13:22:45.433547Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T13:22:45.433938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.48:2379"} {"level":"info","ts":"2026-04-09T13:22:55.688781Z","caller":"traceutil/trace.go:171","msg":"trace[1432188878] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"101.494527ms","start":"2026-04-09T13:22:55.587256Z","end":"2026-04-09T13:22:55.68875Z","steps":["trace[1432188878] 'process raft request' (duration: 101.336695ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:22:55.689515Z","caller":"traceutil/trace.go:171","msg":"trace[1287796207] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"102.125594ms","start":"2026-04-09T13:22:55.586557Z","end":"2026-04-09T13:22:55.688683Z","steps":["trace[1287796207] 'process raft request' (duration: 70.628564ms)","trace[1287796207] 'compare' (duration: 31.329908ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:03.572748Z","caller":"traceutil/trace.go:171","msg":"trace[1610127673] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"115.400312ms","start":"2026-04-09T13:23:03.457321Z","end":"2026-04-09T13:23:03.572722Z","steps":["trace[1610127673] 'process raft request' (duration: 115.098995ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.473563Z","caller":"traceutil/trace.go:171","msg":"trace[46389054] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"259.479843ms","start":"2026-04-09T13:23:15.21406Z","end":"2026-04-09T13:23:15.47354Z","steps":["trace[46389054] 'process raft request' (duration: 259.323786ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.483601Z","caller":"traceutil/trace.go:171","msg":"trace[44948103] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"265.445956ms","start":"2026-04-09T13:23:15.218139Z","end":"2026-04-09T13:23:15.483585Z","steps":["trace[44948103] 'process raft request' (duration: 265.290649ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.48365Z","caller":"traceutil/trace.go:171","msg":"trace[639084981] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"255.963756ms","start":"2026-04-09T13:23:15.227664Z","end":"2026-04-09T13:23:15.483628Z","steps":["trace[639084981] 'process raft request' (duration: 255.876592ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.483824Z","caller":"traceutil/trace.go:171","msg":"trace[870257667] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"254.215943ms","start":"2026-04-09T13:23:15.229601Z","end":"2026-04-09T13:23:15.483817Z","steps":["trace[870257667] 'process raft request' (duration: 253.966312ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.483859Z","caller":"traceutil/trace.go:171","msg":"trace[828944888] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"265.662496ms","start":"2026-04-09T13:23:15.218189Z","end":"2026-04-09T13:23:15.483852Z","steps":["trace[828944888] 'process raft request' (duration: 265.3249ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484005Z","caller":"traceutil/trace.go:171","msg":"trace[830800615] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"252.117564ms","start":"2026-04-09T13:23:15.231881Z","end":"2026-04-09T13:23:15.483998Z","steps":["trace[830800615] 'process raft request' (duration: 251.769577ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484135Z","caller":"traceutil/trace.go:171","msg":"trace[497628143] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"246.870305ms","start":"2026-04-09T13:23:15.237255Z","end":"2026-04-09T13:23:15.484125Z","steps":["trace[497628143] 'process raft request' (duration: 246.425494ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484155Z","caller":"traceutil/trace.go:171","msg":"trace[1198825501] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"252.314913ms","start":"2026-04-09T13:23:15.231831Z","end":"2026-04-09T13:23:15.484146Z","steps":["trace[1198825501] 'process raft request' (duration: 251.787108ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484288Z","caller":"traceutil/trace.go:171","msg":"trace[1952896580] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"202.365925ms","start":"2026-04-09T13:23:15.281907Z","end":"2026-04-09T13:23:15.484273Z","steps":["trace[1952896580] 'process raft request' (duration: 201.897313ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484325Z","caller":"traceutil/trace.go:171","msg":"trace[1030671054] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:491; }","duration":"240.855ms","start":"2026-04-09T13:23:15.243417Z","end":"2026-04-09T13:23:15.484272Z","steps":["trace[1030671054] 'read index received' (duration: 229.994435ms)","trace[1030671054] 'applied index is now lower than readState.Index' (duration: 10.860055ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:15.484348Z","caller":"traceutil/trace.go:171","msg":"trace[812744862] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"242.463406ms","start":"2026-04-09T13:23:15.241879Z","end":"2026-04-09T13:23:15.484342Z","steps":["trace[812744862] 'process raft request' (duration: 241.865828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:15.484439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.000287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-09T13:23:15.484515Z","caller":"traceutil/trace.go:171","msg":"trace[1824532135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:485; }","duration":"241.108782ms","start":"2026-04-09T13:23:15.243394Z","end":"2026-04-09T13:23:15.484503Z","steps":["trace[1824532135] 'agreement among raft nodes before linearized reading' (duration: 240.970645ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:15.484493Z","caller":"traceutil/trace.go:171","msg":"trace[2078248830] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"254.14724ms","start":"2026-04-09T13:23:15.230158Z","end":"2026-04-09T13:23:15.484305Z","steps":["trace[2078248830] 'process raft request' (duration: 253.435057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:16.0385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.028004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T13:23:16.038639Z","caller":"traceutil/trace.go:171","msg":"trace[180627551] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"211.883139ms","start":"2026-04-09T13:23:15.826733Z","end":"2026-04-09T13:23:16.038616Z","steps":["trace[180627551] 'process raft request' (duration: 87.125942ms)","trace[180627551] 'compare' (duration: 123.829894ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:16.040115Z","caller":"traceutil/trace.go:171","msg":"trace[411237156] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"167.63891ms","start":"2026-04-09T13:23:15.872454Z","end":"2026-04-09T13:23:16.040093Z","steps":["trace[411237156] 'process raft request' (duration: 167.507874ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:16.040535Z","caller":"traceutil/trace.go:171","msg":"trace[335457357] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"206.424468ms","start":"2026-04-09T13:23:15.834099Z","end":"2026-04-09T13:23:16.040524Z","steps":["trace[335457357] 'process raft request' (duration: 205.668163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:20.888132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.909544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T13:23:20.88827Z","caller":"traceutil/trace.go:171","msg":"trace[1812983592] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"217.492373ms","start":"2026-04-09T13:23:20.670749Z","end":"2026-04-09T13:23:20.888241Z","steps":["trace[1812983592] 'process raft request' (duration: 90.384851ms)","trace[1812983592] 'compare' (duration: 126.776607ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T13:23:22.907727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575186793912377311,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-09T13:23:22.976733Z","caller":"traceutil/trace.go:171","msg":"trace[1220991605] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"569.756346ms","start":"2026-04-09T13:23:22.406912Z","end":"2026-04-09T13:23:22.976669Z","steps":["trace[1220991605] 'read index received' (duration: 563.330485ms)","trace[1220991605] 'applied index is now lower than readState.Index' (duration: 6.424851ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:22.976779Z","caller":"traceutil/trace.go:171","msg":"trace[954339258] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"940.50135ms","start":"2026-04-09T13:23:22.036227Z","end":"2026-04-09T13:23:22.976728Z","steps":["trace[954339258] 'process raft request' (duration: 939.058187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:22.976941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.985365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tj665\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-09T13:23:22.977039Z","caller":"traceutil/trace.go:171","msg":"trace[1751206486] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tj665; range_end:; response_count:1; response_revision:582; }","duration":"570.146923ms","start":"2026-04-09T13:23:22.406872Z","end":"2026-04-09T13:23:22.977019Z","steps":["trace[1751206486] 'agreement among raft nodes before linearized reading' (duration: 569.925773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:22.977081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:22.406851Z","time spent":"570.223666ms","remote":"127.0.0.1:52928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-tj665\" "} {"level":"warn","ts":"2026-04-09T13:23:22.976961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:22.036204Z","time spent":"940.671208ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036381,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T13:23:23.422272Z","caller":"traceutil/trace.go:171","msg":"trace[874260485] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"429.990743ms","start":"2026-04-09T13:23:22.992253Z","end":"2026-04-09T13:23:23.422243Z","steps":["trace[874260485] 'process raft request' (duration: 429.818455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:23.422425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:22.992228Z","time spent":"430.117358ms","remote":"127.0.0.1:52928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T13:23:23.547934Z","caller":"traceutil/trace.go:171","msg":"trace[794096908] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"500.430198ms","start":"2026-04-09T13:23:23.047474Z","end":"2026-04-09T13:23:23.547904Z","steps":["trace[794096908] 'read index received' (duration: 374.696129ms)","trace[794096908] 'applied index is now lower than readState.Index' (duration: 125.732729ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:23.547966Z","caller":"traceutil/trace.go:171","msg":"trace[1576347416] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"511.831539ms","start":"2026-04-09T13:23:23.036089Z","end":"2026-04-09T13:23:23.547921Z","steps":["trace[1576347416] 'process raft request' (duration: 503.98143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:23.548204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.036039Z","time spent":"512.092691ms","remote":"127.0.0.1:53258","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-04-09T13:23:23.54824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.753701ms","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-04-09T13:23:23.548276Z","caller":"traceutil/trace.go:171","msg":"trace[1183745572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"500.849365ms","start":"2026-04-09T13:23:23.047416Z","end":"2026-04-09T13:23:23.548265Z","steps":["trace[1183745572] 'agreement among raft nodes before linearized reading' (duration: 500.628776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:23.548325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.392863ms","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-09T13:23:23.548361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.450706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-09T13:23:23.548389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.047397Z","time spent":"500.902578ms","remote":"127.0.0.1:53010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-09T13:23:23.548394Z","caller":"traceutil/trace.go:171","msg":"trace[1887736591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"496.606602ms","start":"2026-04-09T13:23:23.051773Z","end":"2026-04-09T13:23:23.548379Z","steps":["trace[1887736591] 'agreement among raft nodes before linearized reading' (duration: 496.380022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:23.548503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.051745Z","time spent":"496.745018ms","remote":"127.0.0.1:53010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-09T13:23:23.548418Z","caller":"traceutil/trace.go:171","msg":"trace[1167350925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"496.55627ms","start":"2026-04-09T13:23:23.051845Z","end":"2026-04-09T13:23:23.548401Z","steps":["trace[1167350925] 'agreement among raft nodes before linearized reading' (duration: 496.341451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:23.548667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.051803Z","time spent":"496.810231ms","remote":"127.0.0.1:53010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T13:23:24.387253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.000769ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-09T13:23:24.387408Z","caller":"traceutil/trace.go:171","msg":"trace[495996848] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"798.266778ms","start":"2026-04-09T13:23:23.58912Z","end":"2026-04-09T13:23:24.387387Z","steps":["trace[495996848] 'read index received' (duration: 402.217196ms)","trace[495996848] 'applied index is now lower than readState.Index' (duration: 396.047432ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T13:23:24.387671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.544309ms","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-09T13:23:24.387729Z","caller":"traceutil/trace.go:171","msg":"trace[656831527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"798.651594ms","start":"2026-04-09T13:23:23.589063Z","end":"2026-04-09T13:23:24.387715Z","steps":["trace[656831527] 'agreement among raft nodes before linearized reading' (duration: 798.439615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:24.388398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.589039Z","time spent":"799.345044ms","remote":"127.0.0.1:53010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-09T13:23:24.389632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.336888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:24.389739Z","caller":"traceutil/trace.go:171","msg":"trace[1647793297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"700.505476ms","start":"2026-04-09T13:23:23.689218Z","end":"2026-04-09T13:23:24.389723Z","steps":["trace[1647793297] 'agreement among raft nodes before linearized reading' (duration: 700.310467ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:24.389654Z","caller":"traceutil/trace.go:171","msg":"trace[1625207309] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"418.807354ms","start":"2026-04-09T13:23:23.970819Z","end":"2026-04-09T13:23:24.389627Z","steps":["trace[1625207309] 'process raft request' (duration: 417.916046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:24.389837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.689199Z","time spent":"700.627171ms","remote":"127.0.0.1:52712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-09T13:23:24.389945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:23.970784Z","time spent":"419.071814ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036405,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T13:23:24.681033Z","caller":"traceutil/trace.go:171","msg":"trace[571534828] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"146.261232ms","start":"2026-04-09T13:23:24.534731Z","end":"2026-04-09T13:23:24.680992Z","steps":["trace[571534828] 'process raft request' (duration: 51.997349ms)","trace[571534828] 'compare' (duration: 92.580542ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:25.72218Z","caller":"traceutil/trace.go:171","msg":"trace[981013552] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"148.966686ms","start":"2026-04-09T13:23:25.573181Z","end":"2026-04-09T13:23:25.722148Z","steps":["trace[981013552] 'process raft request' (duration: 148.752927ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:25.723197Z","caller":"traceutil/trace.go:171","msg":"trace[322226992] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:625; }","duration":"136.96039ms","start":"2026-04-09T13:23:25.586217Z","end":"2026-04-09T13:23:25.723177Z","steps":["trace[322226992] 'read index received' (duration: 135.681426ms)","trace[322226992] 'applied index is now lower than readState.Index' (duration: 1.278164ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:25.723311Z","caller":"traceutil/trace.go:171","msg":"trace[1710184979] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"146.884688ms","start":"2026-04-09T13:23:25.576415Z","end":"2026-04-09T13:23:25.7233Z","steps":["trace[1710184979] 'process raft request' (duration: 146.738442ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:25.723299Z","caller":"traceutil/trace.go:171","msg":"trace[1308914450] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"147.536836ms","start":"2026-04-09T13:23:25.575714Z","end":"2026-04-09T13:23:25.723251Z","steps":["trace[1308914450] 'process raft request' (duration: 147.360048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.723491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.253062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.723525Z","caller":"traceutil/trace.go:171","msg":"trace[1707714719] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:602; }","duration":"137.307124ms","start":"2026-04-09T13:23:25.58621Z","end":"2026-04-09T13:23:25.723517Z","steps":["trace[1707714719] 'agreement among raft nodes before linearized reading' (duration: 137.222991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.723676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.371807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.723712Z","caller":"traceutil/trace.go:171","msg":"trace[1096674683] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:602; }","duration":"137.415379ms","start":"2026-04-09T13:23:25.586285Z","end":"2026-04-09T13:23:25.7237Z","steps":["trace[1096674683] 'agreement among raft nodes before linearized reading' (duration: 137.375977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.724102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.808416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.724124Z","caller":"traceutil/trace.go:171","msg":"trace[2001659011] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:602; }","duration":"110.848038ms","start":"2026-04-09T13:23:25.613271Z","end":"2026-04-09T13:23:25.724119Z","steps":["trace[2001659011] 'agreement among raft nodes before linearized reading' (duration: 110.812736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.724206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.667142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.724226Z","caller":"traceutil/trace.go:171","msg":"trace[1169135070] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:602; }","duration":"111.711414ms","start":"2026-04-09T13:23:25.61251Z","end":"2026-04-09T13:23:25.724221Z","steps":["trace[1169135070] 'agreement among raft nodes before linearized reading' (duration: 111.682703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.72429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.935004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.724309Z","caller":"traceutil/trace.go:171","msg":"trace[110774773] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:602; }","duration":"111.955864ms","start":"2026-04-09T13:23:25.612348Z","end":"2026-04-09T13:23:25.724304Z","steps":["trace[110774773] 'agreement among raft nodes before linearized reading' (duration: 111.924533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:25.724379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.811545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:25.724398Z","caller":"traceutil/trace.go:171","msg":"trace[1856582901] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:602; }","duration":"137.834476ms","start":"2026-04-09T13:23:25.586558Z","end":"2026-04-09T13:23:25.724393Z","steps":["trace[1856582901] 'agreement among raft nodes before linearized reading' (duration: 137.801045ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:46.495817Z","caller":"traceutil/trace.go:171","msg":"trace[602621631] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"239.699228ms","start":"2026-04-09T13:23:46.256097Z","end":"2026-04-09T13:23:46.495796Z","steps":["trace[602621631] 'process raft request' (duration: 239.672297ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:46.496073Z","caller":"traceutil/trace.go:171","msg":"trace[1475482152] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"552.276179ms","start":"2026-04-09T13:23:45.943791Z","end":"2026-04-09T13:23:46.496067Z","steps":["trace[1475482152] 'process raft request' (duration: 551.806063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:46.496143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T13:23:45.943769Z","time spent":"552.315511ms","remote":"127.0.0.1:53010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T13:23:46.496216Z","caller":"traceutil/trace.go:171","msg":"trace[55717912] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:827; }","duration":"243.375292ms","start":"2026-04-09T13:23:46.252832Z","end":"2026-04-09T13:23:46.496207Z","steps":["trace[55717912] 'read index received' (duration: 242.699549ms)","trace[55717912] 'applied index is now lower than readState.Index' (duration: 675.103µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T13:23:46.496251Z","caller":"traceutil/trace.go:171","msg":"trace[1423922814] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"242.400778ms","start":"2026-04-09T13:23:46.253846Z","end":"2026-04-09T13:23:46.496246Z","steps":["trace[1423922814] 'process raft request' (duration: 241.902271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:46.496356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.523247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T13:23:46.496375Z","caller":"traceutil/trace.go:171","msg":"trace[13053107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"243.576448ms","start":"2026-04-09T13:23:46.252791Z","end":"2026-04-09T13:23:46.496368Z","steps":["trace[13053107] 'agreement among raft nodes before linearized reading' (duration: 243.544877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T13:23:46.496517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.474654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-09T13:23:46.496532Z","caller":"traceutil/trace.go:171","msg":"trace[1955473186] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"240.504985ms","start":"2026-04-09T13:23:46.256021Z","end":"2026-04-09T13:23:46.496526Z","steps":["trace[1955473186] 'agreement among raft nodes before linearized reading' (duration: 240.424422ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T13:23:48.24378Z","caller":"traceutil/trace.go:171","msg":"trace[404668631] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"121.175546ms","start":"2026-04-09T13:23:48.12257Z","end":"2026-04-09T13:23:48.243745Z","steps":["trace[404668631] 'process raft request' (duration: 120.98907ms)"],"step_count":1}