{"level":"warn","ts":"2026-08-12T17:28:55.256264Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T17:28:55.256603Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.125: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.125:2380","--initial-cluster=instance=https://199.19.213.125:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.125:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.125: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-08-12T17:28:55.256682Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T17:28:55.256693Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-08-12T17:28:55.256711Z","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-08-12T17:28:55.257593Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"]} {"level":"info","ts":"2026-08-12T17:28:55.25776Z","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.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.125: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-08-12T17:28:55.264549Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.390355ms"} {"level":"info","ts":"2026-08-12T17:28:55.277434Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b448fdce642f2755","cluster-id":"66f7e5dc9a72c5e3"} {"level":"info","ts":"2026-08-12T17:28:55.277519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=()"} {"level":"info","ts":"2026-08-12T17:28:55.277536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 0"} {"level":"info","ts":"2026-08-12T17:28:55.27755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b448fdce642f2755 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-12T17:28:55.277556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 1"} {"level":"info","ts":"2026-08-12T17:28:55.277587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"warn","ts":"2026-08-12T17:28:55.282411Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-12T17:28:55.283993Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-12T17:28:55.285075Z","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-08-12T17:28:55.287654Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b448fdce642f2755","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-12T17:28:55.287842Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b448fdce642f2755","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-12T17:28:55.287976Z","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-08-12T17:28:55.28802Z","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-08-12T17:28:55.288028Z","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-08-12T17:28:55.290441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"info","ts":"2026-08-12T17:28:55.290608Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","added-peer-id":"b448fdce642f2755","added-peer-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-08-12T17:28:55.292574Z","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-08-12T17:28:55.292747Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-08-12T17:28:55.292777Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-08-12T17:28:55.293106Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b448fdce642f2755","initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-12T17:28:55.293153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-12T17:28:55.877818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 is starting a new election at term 1"} {"level":"info","ts":"2026-08-12T17:28:55.877888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-12T17:28:55.87793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgPreVoteResp from b448fdce642f2755 at term 1"} {"level":"info","ts":"2026-08-12T17:28:55.87795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became candidate at term 2"} {"level":"info","ts":"2026-08-12T17:28:55.877962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgVoteResp from b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-08-12T17:28:55.878016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became leader at term 2"} {"level":"info","ts":"2026-08-12T17:28:55.87804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b448fdce642f2755 elected leader b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-08-12T17:28:55.880491Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:28:55.880753Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T17:28:55.880735Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T17:28:55.88138Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-12T17:28:55.881459Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-12T17:28:55.883705Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.125:2379"} {"level":"info","ts":"2026-08-12T17:28:55.884074Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b448fdce642f2755","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.125:2379]}","request-path":"/0/members/b448fdce642f2755/attributes","cluster-id":"66f7e5dc9a72c5e3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-12T17:28:55.885096Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-12T17:28:55.88566Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:28:55.885763Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:28:55.885793Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T17:28:59.954346Z","caller":"traceutil/trace.go:171","msg":"trace[2125642804] linearizableReadLoop","detail":"{readStateIndex:209; appliedIndex:208; }","duration":"191.938173ms","start":"2026-08-12T17:28:59.762363Z","end":"2026-08-12T17:28:59.954301Z","steps":["trace[2125642804] 'read index received' (duration: 191.688667ms)","trace[2125642804] 'applied index is now lower than readState.Index' (duration: 248.526µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:28:59.954441Z","caller":"traceutil/trace.go:171","msg":"trace[359361096] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"373.490065ms","start":"2026-08-12T17:28:59.580914Z","end":"2026-08-12T17:28:59.954404Z","steps":["trace[359361096] 'process raft request' (duration: 373.200368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:28:59.954559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.165978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:28:59.955932Z","caller":"traceutil/trace.go:171","msg":"trace[1792047728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:204; }","duration":"192.351803ms","start":"2026-08-12T17:28:59.762297Z","end":"2026-08-12T17:28:59.954648Z","steps":["trace[1792047728] 'agreement among raft nodes before linearized reading' (duration: 192.165378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:28:59.956645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:28:59.580877Z","time spent":"373.68398ms","remote":"127.0.0.1:49114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:29:00.414708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.447977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:29:00.414783Z","caller":"traceutil/trace.go:171","msg":"trace[1073440014] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"452.568787ms","start":"2026-08-12T17:28:59.962202Z","end":"2026-08-12T17:29:00.414771Z","steps":["trace[1073440014] 'read index received' (duration: 215.770311ms)","trace[1073440014] 'applied index is now lower than readState.Index' (duration: 236.797806ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:29:00.414872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.67599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-nzxr7u\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:29:00.414895Z","caller":"traceutil/trace.go:171","msg":"trace[1130860172] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-nzxr7u; range_end:; response_count:0; response_revision:205; }","duration":"452.744802ms","start":"2026-08-12T17:28:59.962144Z","end":"2026-08-12T17:29:00.414889Z","steps":["trace[1130860172] 'agreement among raft nodes before linearized reading' (duration: 452.68653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:00.414918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:28:59.962122Z","time spent":"452.791942ms","remote":"127.0.0.1:49054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-nzxr7u\" "} {"level":"warn","ts":"2026-08-12T17:29:00.415076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.255839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:29:00.4151Z","caller":"traceutil/trace.go:171","msg":"trace[1579738974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:205; }","duration":"156.316491ms","start":"2026-08-12T17:29:00.258778Z","end":"2026-08-12T17:29:00.415094Z","steps":["trace[1579738974] 'agreement among raft nodes before linearized reading' (duration: 156.28347ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:29:00.414938Z","caller":"traceutil/trace.go:171","msg":"trace[765567744] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"452.938216ms","start":"2026-08-12T17:28:59.961911Z","end":"2026-08-12T17:29:00.414849Z","steps":["trace[765567744] 'process raft request' (duration: 216.170701ms)","trace[765567744] 'compare' (duration: 236.344195ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:29:00.415736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:28:59.961895Z","time spent":"453.474629ms","remote":"127.0.0.1:49210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T17:29:05.268339Z","caller":"traceutil/trace.go:171","msg":"trace[291032686] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"193.373144ms","start":"2026-08-12T17:29:05.074937Z","end":"2026-08-12T17:29:05.26831Z","steps":["trace[291032686] 'read index received' (duration: 17.413339ms)","trace[291032686] 'applied index is now lower than readState.Index' (duration: 175.958715ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:29:05.268464Z","caller":"traceutil/trace.go:171","msg":"trace[628628499] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"195.722869ms","start":"2026-08-12T17:29:05.072712Z","end":"2026-08-12T17:29:05.268435Z","steps":["trace[628628499] 'process raft request' (duration: 98.654592ms)","trace[628628499] 'compare' (duration: 96.810961ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:29:05.268696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.214888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-12T17:29:05.268737Z","caller":"traceutil/trace.go:171","msg":"trace[281927572] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:306; }","duration":"144.27979ms","start":"2026-08-12T17:29:05.124441Z","end":"2026-08-12T17:29:05.268721Z","steps":["trace[281927572] 'agreement among raft nodes before linearized reading' (duration: 144.227138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:05.268531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.57897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-08-12T17:29:05.268973Z","caller":"traceutil/trace.go:171","msg":"trace[1582624064] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:306; }","duration":"194.0425ms","start":"2026-08-12T17:29:05.074908Z","end":"2026-08-12T17:29:05.26895Z","steps":["trace[1582624064] 'agreement among raft nodes before linearized reading' (duration: 193.556849ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:29:34.185297Z","caller":"traceutil/trace.go:171","msg":"trace[56037440] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"118.142354ms","start":"2026-08-12T17:29:34.06714Z","end":"2026-08-12T17:29:34.185282Z","steps":["trace[56037440] 'process raft request' (duration: 118.083133ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:29:34.185297Z","caller":"traceutil/trace.go:171","msg":"trace[701459802] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"120.636771ms","start":"2026-08-12T17:29:34.064636Z","end":"2026-08-12T17:29:34.185272Z","steps":["trace[701459802] 'process raft request' (duration: 112.287866ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:29:37.527565Z","caller":"traceutil/trace.go:171","msg":"trace[1114686507] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"111.96075ms","start":"2026-08-12T17:29:37.415588Z","end":"2026-08-12T17:29:37.527549Z","steps":["trace[1114686507] 'read index received' (duration: 111.803018ms)","trace[1114686507] 'applied index is now lower than readState.Index' (duration: 157.352µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:29:37.527592Z","caller":"traceutil/trace.go:171","msg":"trace[1177745871] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"112.698643ms","start":"2026-08-12T17:29:37.414871Z","end":"2026-08-12T17:29:37.52757Z","steps":["trace[1177745871] 'process raft request' (duration: 112.56335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:37.527772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.165514ms","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-08-12T17:29:37.527827Z","caller":"traceutil/trace.go:171","msg":"trace[1067670363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:617; }","duration":"112.253845ms","start":"2026-08-12T17:29:37.415559Z","end":"2026-08-12T17:29:37.527813Z","steps":["trace[1067670363] 'agreement among raft nodes before linearized reading' (duration: 112.058532ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T17:29:41.876636Z","caller":"traceutil/trace.go:171","msg":"trace[1779446659] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"279.737138ms","start":"2026-08-12T17:29:41.596869Z","end":"2026-08-12T17:29:41.876606Z","steps":["trace[1779446659] 'read index received' (duration: 279.484653ms)","trace[1779446659] 'applied index is now lower than readState.Index' (duration: 251.155µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T17:29:41.876786Z","caller":"traceutil/trace.go:171","msg":"trace[355568937] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"303.839005ms","start":"2026-08-12T17:29:41.572933Z","end":"2026-08-12T17:29:41.876772Z","steps":["trace[355568937] 'process raft request' (duration: 303.491728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:41.8769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:29:41.5729Z","time spent":"303.915235ms","remote":"127.0.0.1:49210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T17:29:41.877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.01144ms","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-08-12T17:29:41.877068Z","caller":"traceutil/trace.go:171","msg":"trace[1204153795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"225.128842ms","start":"2026-08-12T17:29:41.651908Z","end":"2026-08-12T17:29:41.877036Z","steps":["trace[1204153795] 'agreement among raft nodes before linearized reading' (duration: 224.954789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:41.877186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.289927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T17:29:41.877285Z","caller":"traceutil/trace.go:171","msg":"trace[448642370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"280.44993ms","start":"2026-08-12T17:29:41.596814Z","end":"2026-08-12T17:29:41.877264Z","steps":["trace[448642370] 'agreement among raft nodes before linearized reading' (duration: 280.281157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:41.877914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.372104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-12T17:29:41.877971Z","caller":"traceutil/trace.go:171","msg":"trace[384121244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:652; }","duration":"187.471816ms","start":"2026-08-12T17:29:41.690486Z","end":"2026-08-12T17:29:41.877958Z","steps":["trace[384121244] 'agreement among raft nodes before linearized reading' (duration: 186.656472ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:42.234348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.014794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T17:29:42.234542Z","caller":"traceutil/trace.go:171","msg":"trace[913652120] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"352.171762ms","start":"2026-08-12T17:29:41.882345Z","end":"2026-08-12T17:29:42.234517Z","steps":["trace[913652120] 'process raft request' (duration: 352.101581ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:42.234705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:29:41.882332Z","time spent":"352.296414ms","remote":"127.0.0.1:49210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:29:42.234855Z","caller":"traceutil/trace.go:171","msg":"trace[1261760625] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"353.159891ms","start":"2026-08-12T17:29:41.881668Z","end":"2026-08-12T17:29:42.234828Z","steps":["trace[1261760625] 'process raft request' (duration: 242.571608ms)","trace[1261760625] 'compare' (duration: 109.87037ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T17:29:42.235556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:29:41.88165Z","time spent":"353.262863ms","remote":"127.0.0.1:49210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T17:29:58.01951Z","caller":"traceutil/trace.go:171","msg":"trace[686468432] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"334.999019ms","start":"2026-08-12T17:29:57.684478Z","end":"2026-08-12T17:29:58.019477Z","steps":["trace[686468432] 'process raft request' (duration: 334.728725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T17:29:58.019742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T17:29:57.684454Z","time spent":"335.154452ms","remote":"127.0.0.1:49196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}