{"level":"warn","ts":"2026-02-03T10:23:15.561299Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-03T10:23:15.561401Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.122: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.122:2380","--initial-cluster=instance=https://199.19.213.122:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.122:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.122: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-02-03T10:23:15.561485Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-03T10:23:15.561497Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.122:2380"]} {"level":"info","ts":"2026-02-03T10:23:15.561513Z","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-02-03T10:23:15.56455Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"]} {"level":"info","ts":"2026-02-03T10:23:15.565205Z","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":2,"max-cpu-available":2,"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.122:2380"],"listen-peer-urls":["https://199.19.213.122:2380"],"advertise-client-urls":["https://199.19.213.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.122: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-02-03T10:23:15.570398Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.282911ms"} {"level":"info","ts":"2026-02-03T10:23:15.577881Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f9ba8c11acfbc749","cluster-id":"ca7c3e103d4cd533"} {"level":"info","ts":"2026-02-03T10:23:15.578003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=()"} {"level":"info","ts":"2026-02-03T10:23:15.578075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became follower at term 0"} {"level":"info","ts":"2026-02-03T10:23:15.578118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f9ba8c11acfbc749 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-03T10:23:15.578172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became follower at term 1"} {"level":"info","ts":"2026-02-03T10:23:15.578243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=(17994849268656752457)"} {"level":"warn","ts":"2026-02-03T10:23:15.59078Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-03T10:23:15.593393Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-03T10:23:15.60367Z","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-02-03T10:23:15.613061Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f9ba8c11acfbc749","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-03T10:23:15.613572Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f9ba8c11acfbc749","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-03T10:23:15.614228Z","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-02-03T10:23:15.614286Z","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-02-03T10:23:15.614297Z","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-02-03T10:23:15.614967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 switched to configuration voters=(17994849268656752457)"} {"level":"info","ts":"2026-02-03T10:23:15.615267Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ca7c3e103d4cd533","local-member-id":"f9ba8c11acfbc749","added-peer-id":"f9ba8c11acfbc749","added-peer-peer-urls":["https://199.19.213.122:2380"]} {"level":"info","ts":"2026-02-03T10:23:15.636957Z","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-02-03T10:23:15.637966Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f9ba8c11acfbc749","initial-advertise-peer-urls":["https://199.19.213.122:2380"],"listen-peer-urls":["https://199.19.213.122:2380"],"advertise-client-urls":["https://199.19.213.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-03T10:23:15.637985Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-03T10:23:15.638007Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.122:2380"} {"level":"info","ts":"2026-02-03T10:23:15.638014Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.122:2380"} {"level":"info","ts":"2026-02-03T10:23:16.279279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 is starting a new election at term 1"} {"level":"info","ts":"2026-02-03T10:23:16.279321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-03T10:23:16.279354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 received MsgPreVoteResp from f9ba8c11acfbc749 at term 1"} {"level":"info","ts":"2026-02-03T10:23:16.279371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became candidate at term 2"} {"level":"info","ts":"2026-02-03T10:23:16.279376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 received MsgVoteResp from f9ba8c11acfbc749 at term 2"} {"level":"info","ts":"2026-02-03T10:23:16.279385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f9ba8c11acfbc749 became leader at term 2"} {"level":"info","ts":"2026-02-03T10:23:16.279392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f9ba8c11acfbc749 elected leader f9ba8c11acfbc749 at term 2"} {"level":"info","ts":"2026-02-03T10:23:16.282515Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:23:16.285706Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ca7c3e103d4cd533","local-member-id":"f9ba8c11acfbc749","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:23:16.285766Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:23:16.285781Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-03T10:23:16.285801Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f9ba8c11acfbc749","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.122:2379]}","request-path":"/0/members/f9ba8c11acfbc749/attributes","cluster-id":"ca7c3e103d4cd533","publish-timeout":"7s"} {"level":"info","ts":"2026-02-03T10:23:16.286747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T10:23:16.287037Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-03T10:23:16.288392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.122:2379"} {"level":"info","ts":"2026-02-03T10:23:16.296352Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-03T10:23:16.296369Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-03T10:23:16.296934Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-03T10:23:26.151255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.04448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-03T10:23:26.151397Z","caller":"traceutil/trace.go:171","msg":"trace[2108062642] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"136.964678ms","start":"2026-02-03T10:23:26.01439Z","end":"2026-02-03T10:23:26.151355Z","steps":["trace[2108062642] 'process raft request' (duration: 31.289601ms)","trace[2108062642] 'compare' (duration: 104.938129ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:23:26.167977Z","caller":"traceutil/trace.go:171","msg":"trace[357140807] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"114.827504ms","start":"2026-02-03T10:23:26.053135Z","end":"2026-02-03T10:23:26.167962Z","steps":["trace[357140807] 'read index received' (duration: 114.743993ms)","trace[357140807] 'applied index is now lower than readState.Index' (duration: 82.531µs)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:23:26.168082Z","caller":"traceutil/trace.go:171","msg":"trace[926724339] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"152.27058ms","start":"2026-02-03T10:23:26.015801Z","end":"2026-02-03T10:23:26.168072Z","steps":["trace[926724339] 'process raft request' (duration: 152.064568ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:26.168203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.054887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-03T10:23:26.168233Z","caller":"traceutil/trace.go:171","msg":"trace[986891306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:364; }","duration":"115.114117ms","start":"2026-02-03T10:23:26.053107Z","end":"2026-02-03T10:23:26.168221Z","steps":["trace[986891306] 'agreement among raft nodes before linearized reading' (duration: 115.050117ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:26.324319Z","caller":"traceutil/trace.go:171","msg":"trace[1895573673] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"100.656084ms","start":"2026-02-03T10:23:26.22364Z","end":"2026-02-03T10:23:26.324296Z","steps":["trace[1895573673] 'process raft request' (duration: 46.511312ms)","trace[1895573673] 'compare' (duration: 54.053401ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:23:26.348277Z","caller":"traceutil/trace.go:171","msg":"trace[1873576295] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"121.696007ms","start":"2026-02-03T10:23:26.226559Z","end":"2026-02-03T10:23:26.348255Z","steps":["trace[1873576295] 'process raft request' (duration: 121.484614ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:26.349032Z","caller":"traceutil/trace.go:171","msg":"trace[1127201744] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"122.422255ms","start":"2026-02-03T10:23:26.226597Z","end":"2026-02-03T10:23:26.349019Z","steps":["trace[1127201744] 'process raft request' (duration: 122.049891ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:26.35027Z","caller":"traceutil/trace.go:171","msg":"trace[973764497] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"123.619737ms","start":"2026-02-03T10:23:26.226641Z","end":"2026-02-03T10:23:26.350261Z","steps":["trace[973764497] 'process raft request' (duration: 122.091381ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:33.031562Z","caller":"traceutil/trace.go:171","msg":"trace[229226140] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"159.858807ms","start":"2026-02-03T10:23:32.871678Z","end":"2026-02-03T10:23:33.031536Z","steps":["trace[229226140] 'process raft request' (duration: 120.673167ms)","trace[229226140] 'compare' (duration: 37.307012ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:23:33.033332Z","caller":"traceutil/trace.go:171","msg":"trace[1987939808] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"161.172311ms","start":"2026-02-03T10:23:32.872147Z","end":"2026-02-03T10:23:33.033319Z","steps":["trace[1987939808] 'process raft request' (duration: 158.556155ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:33.040749Z","caller":"traceutil/trace.go:171","msg":"trace[2094299438] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"159.419732ms","start":"2026-02-03T10:23:32.881314Z","end":"2026-02-03T10:23:33.040734Z","steps":["trace[2094299438] 'process raft request' (duration: 149.433884ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:33.041129Z","caller":"traceutil/trace.go:171","msg":"trace[2098006141] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"134.24863ms","start":"2026-02-03T10:23:32.906861Z","end":"2026-02-03T10:23:33.04111Z","steps":["trace[2098006141] 'process raft request' (duration: 124.033979ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:47.290512Z","caller":"traceutil/trace.go:171","msg":"trace[1424499477] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"143.763292ms","start":"2026-02-03T10:23:47.146726Z","end":"2026-02-03T10:23:47.290489Z","steps":["trace[1424499477] 'process raft request' (duration: 143.656271ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:47.622062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.628031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:23:47.622118Z","caller":"traceutil/trace.go:171","msg":"trace[161823822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"153.717741ms","start":"2026-02-03T10:23:47.468387Z","end":"2026-02-03T10:23:47.622105Z","steps":["trace[161823822] 'range keys from in-memory index tree' (duration: 153.57928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:48.487079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.419206ms","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-02-03T10:23:48.487224Z","caller":"traceutil/trace.go:171","msg":"trace[1433000042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"402.591468ms","start":"2026-02-03T10:23:48.08462Z","end":"2026-02-03T10:23:48.487211Z","steps":["trace[1433000042] 'range keys from in-memory index tree' (duration: 402.359175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:48.487557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:48.084609Z","time spent":"402.933081ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-03T10:23:48.48801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.038975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:23:48.488128Z","caller":"traceutil/trace.go:171","msg":"trace[1605862324] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:522; }","duration":"418.192247ms","start":"2026-02-03T10:23:48.069917Z","end":"2026-02-03T10:23:48.48811Z","steps":["trace[1605862324] 'range keys from in-memory index tree' (duration: 417.976315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:48.488331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:48.069899Z","time spent":"418.338148ms","remote":"127.0.0.1:45114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-03T10:23:48.487116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.803382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-03T10:23:48.489382Z","caller":"traceutil/trace.go:171","msg":"trace[2004975559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"412.117872ms","start":"2026-02-03T10:23:48.077253Z","end":"2026-02-03T10:23:48.489371Z","steps":["trace[2004975559] 'range keys from in-memory index tree' (duration: 409.63756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:48.495465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:48.077244Z","time spent":"418.200236ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-03T10:23:54.746714Z","caller":"traceutil/trace.go:171","msg":"trace[1101265386] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"308.183028ms","start":"2026-02-03T10:23:54.438513Z","end":"2026-02-03T10:23:54.746696Z","steps":["trace[1101265386] 'process raft request' (duration: 308.078287ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:54.746943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:54.438498Z","time spent":"308.267018ms","remote":"127.0.0.1:45196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-03T10:23:54.747382Z","caller":"traceutil/trace.go:171","msg":"trace[1083422775] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:582; }","duration":"282.286023ms","start":"2026-02-03T10:23:54.465079Z","end":"2026-02-03T10:23:54.747365Z","steps":["trace[1083422775] 'read index received' (duration: 282.276333ms)","trace[1083422775] 'applied index is now lower than readState.Index' (duration: 6.83µs)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:23:54.747492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.403464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:23:54.747543Z","caller":"traceutil/trace.go:171","msg":"trace[2144720781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"282.465165ms","start":"2026-02-03T10:23:54.465048Z","end":"2026-02-03T10:23:54.747513Z","steps":["trace[2144720781] 'agreement among raft nodes before linearized reading' (duration: 282.405154ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:54.979573Z","caller":"traceutil/trace.go:171","msg":"trace[47304213] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"232.127959ms","start":"2026-02-03T10:23:54.74743Z","end":"2026-02-03T10:23:54.979558Z","steps":["trace[47304213] 'read index received' (duration: 167.791972ms)","trace[47304213] 'applied index is now lower than readState.Index' (duration: 64.335097ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:23:54.979665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.117807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-03T10:23:54.979667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.419197ms","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-02-03T10:23:54.97968Z","caller":"traceutil/trace.go:171","msg":"trace[1135277145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:563; }","duration":"457.149897ms","start":"2026-02-03T10:23:54.522525Z","end":"2026-02-03T10:23:54.979675Z","steps":["trace[1135277145] 'agreement among raft nodes before linearized reading' (duration: 457.085976ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:54.979694Z","caller":"traceutil/trace.go:171","msg":"trace[1018149788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"451.464777ms","start":"2026-02-03T10:23:54.528223Z","end":"2026-02-03T10:23:54.979688Z","steps":["trace[1018149788] 'agreement among raft nodes before linearized reading' (duration: 451.346136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:54.979699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:54.522491Z","time spent":"457.203487ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-03T10:23:54.979709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:54.528218Z","time spent":"451.487367ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-03T10:23:55.656945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.223617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-03T10:23:55.657005Z","caller":"traceutil/trace.go:171","msg":"trace[678944951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"191.331758ms","start":"2026-02-03T10:23:55.465657Z","end":"2026-02-03T10:23:55.656989Z","steps":["trace[678944951] 'range keys from in-memory index tree' (duration: 191.157166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:55.657248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.639427ms","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-02-03T10:23:55.657265Z","caller":"traceutil/trace.go:171","msg":"trace[1300419060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"345.682047ms","start":"2026-02-03T10:23:55.311577Z","end":"2026-02-03T10:23:55.657259Z","steps":["trace[1300419060] 'range keys from in-memory index tree' (duration: 345.547587ms)"],"step_count":1} {"level":"warn","ts":"2026-02-03T10:23:55.65728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:55.311562Z","time spent":"345.713097ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-03T10:23:56.150785Z","caller":"traceutil/trace.go:171","msg":"trace[2032253240] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"489.959483ms","start":"2026-02-03T10:23:55.660799Z","end":"2026-02-03T10:23:56.150759Z","steps":["trace[2032253240] 'process raft request' (duration: 489.5309ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:23:56.15084Z","caller":"traceutil/trace.go:171","msg":"trace[201042790] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"227.268311ms","start":"2026-02-03T10:23:55.923198Z","end":"2026-02-03T10:23:56.150466Z","steps":["trace[201042790] 'read index received' (duration: 227.086839ms)","trace[201042790] 'applied index is now lower than readState.Index' (duration: 180.602µs)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:23:56.150911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-03T10:23:55.660789Z","time spent":"490.055724ms","remote":"127.0.0.1:45274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-03T10:23:56.150983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.767925ms","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-02-03T10:23:56.151019Z","caller":"traceutil/trace.go:171","msg":"trace[1603813387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:566; }","duration":"227.832836ms","start":"2026-02-03T10:23:55.923166Z","end":"2026-02-03T10:23:56.150999Z","steps":["trace[1603813387] 'agreement among raft nodes before linearized reading' (duration: 227.721345ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:25:14.747313Z","caller":"traceutil/trace.go:171","msg":"trace[1346056089] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"128.676763ms","start":"2026-02-03T10:25:14.61862Z","end":"2026-02-03T10:25:14.747297Z","steps":["trace[1346056089] 'read index received' (duration: 109.036195ms)","trace[1346056089] 'applied index is now lower than readState.Index' (duration: 19.640018ms)"],"step_count":2} {"level":"warn","ts":"2026-02-03T10:25:14.747457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.830646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-03T10:25:14.747473Z","caller":"traceutil/trace.go:171","msg":"trace[1979812804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:969; }","duration":"128.877937ms","start":"2026-02-03T10:25:14.61859Z","end":"2026-02-03T10:25:14.747468Z","steps":["trace[1979812804] 'agreement among raft nodes before linearized reading' (duration: 128.777525ms)"],"step_count":1} {"level":"info","ts":"2026-02-03T10:25:14.747601Z","caller":"traceutil/trace.go:171","msg":"trace[1205923207] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"146.270611ms","start":"2026-02-03T10:25:14.601325Z","end":"2026-02-03T10:25:14.747595Z","steps":["trace[1205923207] 'process raft request' (duration: 126.375687ms)","trace[1205923207] 'compare' (duration: 19.385172ms)"],"step_count":2} {"level":"info","ts":"2026-02-03T10:25:41.059347Z","caller":"traceutil/trace.go:171","msg":"trace[815152113] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"117.503798ms","start":"2026-02-03T10:25:40.94182Z","end":"2026-02-03T10:25:41.059323Z","steps":["trace[815152113] 'process raft request' (duration: 117.366095ms)"],"step_count":1}