{"level":"warn","ts":"2026-08-10T22:29:48.786322Z","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-10T22:29:48.786424Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.231: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.231:2380","--initial-cluster=instance=https://199.19.213.231:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.231:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.231: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-10T22:29:48.786498Z","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-10T22:29:48.786515Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-08-10T22:29:48.786541Z","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-10T22:29:48.787223Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"]} {"level":"info","ts":"2026-08-10T22:29:48.787297Z","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.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.231: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-10T22:29:48.794337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.812787ms"} {"level":"info","ts":"2026-08-10T22:29:48.803217Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8bb149ac537fafcb","cluster-id":"6a60f8f1d4e49112"} {"level":"info","ts":"2026-08-10T22:29:48.803306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T22:29:48.803329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 0"} {"level":"info","ts":"2026-08-10T22:29:48.803339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8bb149ac537fafcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T22:29:48.803357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 1"} {"level":"info","ts":"2026-08-10T22:29:48.803418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"warn","ts":"2026-08-10T22:29:48.812607Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T22:29:48.821921Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T22:29:48.823242Z","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-10T22:29:48.826954Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8bb149ac537fafcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T22:29:48.830318Z","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-10T22:29:48.83054Z","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-10T22:29:48.830562Z","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-10T22:29:48.830865Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8bb149ac537fafcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T22:29:48.831778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"info","ts":"2026-08-10T22:29:48.837372Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","added-peer-id":"8bb149ac537fafcb","added-peer-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-08-10T22:29:48.838188Z","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-10T22:29:48.838609Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8bb149ac537fafcb","initial-advertise-peer-urls":["https://199.19.213.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T22:29:48.838654Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T22:29:48.83872Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-08-10T22:29:48.838732Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-08-10T22:29:49.204023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T22:29:49.204149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T22:29:49.204212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgPreVoteResp from 8bb149ac537fafcb at term 1"} {"level":"info","ts":"2026-08-10T22:29:49.204272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became candidate at term 2"} {"level":"info","ts":"2026-08-10T22:29:49.204307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgVoteResp from 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-08-10T22:29:49.204345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became leader at term 2"} {"level":"info","ts":"2026-08-10T22:29:49.204391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8bb149ac537fafcb elected leader 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-08-10T22:29:49.208144Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:29:49.224114Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8bb149ac537fafcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.231:2379]}","request-path":"/0/members/8bb149ac537fafcb/attributes","cluster-id":"6a60f8f1d4e49112","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T22:29:49.224193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:29:49.224127Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:29:49.224471Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T22:29:49.224529Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T22:29:49.226872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.231:2379"} {"level":"info","ts":"2026-08-10T22:29:49.227652Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-10T22:29:49.233793Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:29:49.233887Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:29:49.233915Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:30:01.087593Z","caller":"traceutil/trace.go:171","msg":"trace[121616858] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"111.089263ms","start":"2026-08-10T22:30:00.976461Z","end":"2026-08-10T22:30:01.08755Z","steps":["trace[121616858] 'process raft request' (duration: 110.761764ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:05.179713Z","caller":"traceutil/trace.go:171","msg":"trace[1302314249] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"262.393412ms","start":"2026-08-10T22:30:04.917285Z","end":"2026-08-10T22:30:05.179678Z","steps":["trace[1302314249] 'process raft request' (duration: 262.206197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:05.638013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.693239ms","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-08-10T22:30:05.638131Z","caller":"traceutil/trace.go:171","msg":"trace[784609538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:366; }","duration":"215.861433ms","start":"2026-08-10T22:30:05.42225Z","end":"2026-08-10T22:30:05.638111Z","steps":["trace[784609538] 'range keys from in-memory index tree' (duration: 215.436352ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:35.370948Z","caller":"traceutil/trace.go:171","msg":"trace[76703984] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"148.348463ms","start":"2026-08-10T22:30:35.222565Z","end":"2026-08-10T22:30:35.370913Z","steps":["trace[76703984] 'read index received' (duration: 147.486288ms)","trace[76703984] 'applied index is now lower than readState.Index' (duration: 861.195µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:30:35.370997Z","caller":"traceutil/trace.go:171","msg":"trace[201493769] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"209.715234ms","start":"2026-08-10T22:30:35.161254Z","end":"2026-08-10T22:30:35.37097Z","steps":["trace[201493769] 'process raft request' (duration: 209.032274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:35.37125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.613291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lk88d\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-10T22:30:35.371325Z","caller":"traceutil/trace.go:171","msg":"trace[666905466] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lk88d; range_end:; response_count:1; response_revision:594; }","duration":"148.780976ms","start":"2026-08-10T22:30:35.222536Z","end":"2026-08-10T22:30:35.371317Z","steps":["trace[666905466] 'agreement among raft nodes before linearized reading' (duration: 148.542419ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:36.081184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.048287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:30:36.081276Z","caller":"traceutil/trace.go:171","msg":"trace[174744806] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"290.575199ms","start":"2026-08-10T22:30:35.790686Z","end":"2026-08-10T22:30:36.081261Z","steps":["trace[174744806] 'read index received' (duration: 43.461µs)","trace[174744806] 'applied index is now lower than readState.Index' (duration: 290.530268ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:30:36.081351Z","caller":"traceutil/trace.go:171","msg":"trace[1456935987] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"645.743632ms","start":"2026-08-10T22:30:35.435597Z","end":"2026-08-10T22:30:36.081341Z","steps":["trace[1456935987] 'process raft request' (duration: 308.109208ms)","trace[1456935987] 'compare' (duration: 336.827331ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:30:36.081396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:30:35.435576Z","time spent":"645.797233ms","remote":"127.0.0.1:32880","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-08-10T22:30:36.081464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.728588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:30:36.08153Z","caller":"traceutil/trace.go:171","msg":"trace[933126772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"245.845871ms","start":"2026-08-10T22:30:35.83567Z","end":"2026-08-10T22:30:36.081516Z","steps":["trace[933126772] 'agreement among raft nodes before linearized reading' (duration: 245.701857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:36.08166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.95875ms","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-08-10T22:30:36.081738Z","caller":"traceutil/trace.go:171","msg":"trace[613710091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"291.083234ms","start":"2026-08-10T22:30:35.790632Z","end":"2026-08-10T22:30:36.081715Z","steps":["trace[613710091] 'agreement among raft nodes before linearized reading' (duration: 290.729844ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:37.499456Z","caller":"traceutil/trace.go:171","msg":"trace[223765654] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"130.122755ms","start":"2026-08-10T22:30:37.369309Z","end":"2026-08-10T22:30:37.499431Z","steps":["trace[223765654] 'process raft request' (duration: 129.97301ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:37.502442Z","caller":"traceutil/trace.go:171","msg":"trace[1583956528] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"113.07154ms","start":"2026-08-10T22:30:37.389349Z","end":"2026-08-10T22:30:37.50242Z","steps":["trace[1583956528] 'read index received' (duration: 109.924028ms)","trace[1583956528] 'applied index is now lower than readState.Index' (duration: 3.146272ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:30:37.502638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.274046ms","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-10T22:30:37.50272Z","caller":"traceutil/trace.go:171","msg":"trace[1346932651] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"113.392919ms","start":"2026-08-10T22:30:37.3893Z","end":"2026-08-10T22:30:37.502692Z","steps":["trace[1346932651] 'agreement among raft nodes before linearized reading' (duration: 113.190264ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:30:50.651853Z","caller":"traceutil/trace.go:171","msg":"trace[121831923] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:781; }","duration":"122.73439ms","start":"2026-08-10T22:30:50.529094Z","end":"2026-08-10T22:30:50.651828Z","steps":["trace[121831923] 'read index received' (duration: 122.589916ms)","trace[121831923] 'applied index is now lower than readState.Index' (duration: 143.554µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:30:50.651909Z","caller":"traceutil/trace.go:171","msg":"trace[586468949] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"320.839397ms","start":"2026-08-10T22:30:50.331037Z","end":"2026-08-10T22:30:50.651876Z","steps":["trace[586468949] 'process raft request' (duration: 320.644571ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:50.652172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.073411ms","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-08-10T22:30:50.652216Z","caller":"traceutil/trace.go:171","msg":"trace[1467778783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"123.152792ms","start":"2026-08-10T22:30:50.529052Z","end":"2026-08-10T22:30:50.652205Z","steps":["trace[1467778783] 'agreement among raft nodes before linearized reading' (duration: 122.877094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:30:50.652403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:30:50.331021Z","time spent":"320.93963ms","remote":"127.0.0.1:60774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:31:11.606268Z","caller":"traceutil/trace.go:171","msg":"trace[197881536] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"124.77818ms","start":"2026-08-10T22:31:11.481465Z","end":"2026-08-10T22:31:11.606243Z","steps":["trace[197881536] 'process raft request' (duration: 124.625265ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:38.71771Z","caller":"traceutil/trace.go:171","msg":"trace[1556918043] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"158.252714ms","start":"2026-08-10T22:31:38.559425Z","end":"2026-08-10T22:31:38.717678Z","steps":["trace[1556918043] 'process raft request' (duration: 158.004997ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:31:56.866638Z","caller":"traceutil/trace.go:171","msg":"trace[1206026880] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"365.379955ms","start":"2026-08-10T22:31:56.501228Z","end":"2026-08-10T22:31:56.866608Z","steps":["trace[1206026880] 'process raft request' (duration: 365.193999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:31:56.866826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:31:56.501199Z","time spent":"365.531939ms","remote":"127.0.0.1:60856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:32:12.174102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.985747ms","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-08-10T22:32:12.1742Z","caller":"traceutil/trace.go:171","msg":"trace[1954325135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"106.129112ms","start":"2026-08-10T22:32:12.06805Z","end":"2026-08-10T22:32:12.174179Z","steps":["trace[1954325135] 'range keys from in-memory index tree' (duration: 105.820922ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:32:12.378491Z","caller":"traceutil/trace.go:171","msg":"trace[107249205] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"163.47975ms","start":"2026-08-10T22:32:12.214979Z","end":"2026-08-10T22:32:12.378459Z","steps":["trace[107249205] 'read index received' (duration: 163.287194ms)","trace[107249205] 'applied index is now lower than readState.Index' (duration: 191.166µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:32:12.378599Z","caller":"traceutil/trace.go:171","msg":"trace[1768652002] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"199.605386ms","start":"2026-08-10T22:32:12.178948Z","end":"2026-08-10T22:32:12.378553Z","steps":["trace[1768652002] 'process raft request' (duration: 199.294497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:32:12.378782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.779708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.231\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-10T22:32:12.378868Z","caller":"traceutil/trace.go:171","msg":"trace[1753629079] range","detail":"{range_begin:/registry/masterleases/199.19.213.231; range_end:; response_count:1; response_revision:1176; }","duration":"163.933044ms","start":"2026-08-10T22:32:12.214913Z","end":"2026-08-10T22:32:12.378846Z","steps":["trace[1753629079] 'agreement among raft nodes before linearized reading' (duration: 163.677636ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:32:12.532401Z","caller":"traceutil/trace.go:171","msg":"trace[113106827] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"209.493561ms","start":"2026-08-10T22:32:12.322861Z","end":"2026-08-10T22:32:12.532355Z","steps":["trace[113106827] 'process raft request' (duration: 178.936851ms)","trace[113106827] 'compare' (duration: 30.368234ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:32:13.304717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.773172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:32:13.304809Z","caller":"traceutil/trace.go:171","msg":"trace[1626029083] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1233; }","duration":"293.041529ms","start":"2026-08-10T22:32:13.011749Z","end":"2026-08-10T22:32:13.304791Z","steps":["trace[1626029083] 'read index received' (duration: 145.997939ms)","trace[1626029083] 'applied index is now lower than readState.Index' (duration: 147.04244ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:32:13.304867Z","caller":"traceutil/trace.go:171","msg":"trace[508620432] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"302.938864ms","start":"2026-08-10T22:32:13.001917Z","end":"2026-08-10T22:32:13.304856Z","steps":["trace[508620432] 'process raft request' (duration: 155.940725ms)","trace[508620432] 'compare' (duration: 146.602607ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:32:13.304927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:32:13.001896Z","time spent":"302.999155ms","remote":"127.0.0.1:60856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:32:13.305266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.510343ms","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-08-10T22:32:13.305306Z","caller":"traceutil/trace.go:171","msg":"trace[2026465632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1182; }","duration":"293.552014ms","start":"2026-08-10T22:32:13.011745Z","end":"2026-08-10T22:32:13.305297Z","steps":["trace[2026465632] 'agreement among raft nodes before linearized reading' (duration: 293.368209ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:32:13.525171Z","caller":"traceutil/trace.go:171","msg":"trace[218001290] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"216.653014ms","start":"2026-08-10T22:32:13.308432Z","end":"2026-08-10T22:32:13.525085Z","steps":["trace[218001290] 'process raft request' (duration: 216.597292ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:32:13.525524Z","caller":"traceutil/trace.go:171","msg":"trace[1257773068] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1234; }","duration":"220.634183ms","start":"2026-08-10T22:32:13.30483Z","end":"2026-08-10T22:32:13.525464Z","steps":["trace[1257773068] 'read index received' (duration: 184.354082ms)","trace[1257773068] 'applied index is now lower than readState.Index' (duration: 36.275611ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:32:13.525563Z","caller":"traceutil/trace.go:171","msg":"trace[1256819817] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"231.669121ms","start":"2026-08-10T22:32:13.293854Z","end":"2026-08-10T22:32:13.525523Z","steps":["trace[1256819817] 'process raft request' (duration: 195.308578ms)","trace[1256819817] 'compare' (duration: 35.631811ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:32:13.525646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.163301ms","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-08-10T22:32:13.525694Z","caller":"traceutil/trace.go:171","msg":"trace[1013545659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1184; }","duration":"402.249724ms","start":"2026-08-10T22:32:13.12343Z","end":"2026-08-10T22:32:13.52568Z","steps":["trace[1013545659] 'agreement among raft nodes before linearized reading' (duration: 402.094399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:32:13.525726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:32:13.123422Z","time spent":"402.295845ms","remote":"127.0.0.1:60856","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":"warn","ts":"2026-08-10T22:32:13.525911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.299374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-10T22:32:13.525986Z","caller":"traceutil/trace.go:171","msg":"trace[1727109455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1184; }","duration":"403.431118ms","start":"2026-08-10T22:32:13.122535Z","end":"2026-08-10T22:32:13.525966Z","steps":["trace[1727109455] 'agreement among raft nodes before linearized reading' (duration: 403.091748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:32:13.526045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:32:13.122516Z","time spent":"403.515471ms","remote":"127.0.0.1:60856","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\" "}