{"level":"warn","ts":"2026-07-06T21:28:51.894847Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T21:28:51.894925Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-07-06T21:28:51.894997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T21:28:51.895007Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-07-06T21:28:51.895033Z","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-07-06T21:28:51.895649Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-07-06T21:28:51.895715Z","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.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-07-06T21:28:51.899003Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.095985ms"} {"level":"info","ts":"2026-07-06T21:28:51.906925Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-07-06T21:28:51.907011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-07-06T21:28:51.907036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-07-06T21:28:51.907046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-06T21:28:51.907058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-07-06T21:28:51.907099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-07-06T21:28:51.919867Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-06T21:28:51.921078Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-06T21:28:51.922169Z","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-07-06T21:28:51.923738Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-06T21:28:51.929491Z","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-07-06T21:28:51.929646Z","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-07-06T21:28:51.929698Z","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-07-06T21:28:51.929809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-06T21:28:51.931333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-07-06T21:28:51.931528Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-07-06T21:28:51.932513Z","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-07-06T21:28:51.932693Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-06T21:28:51.932722Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-06T21:28:51.932926Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-07-06T21:28:51.932967Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-07-06T21:28:52.111539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-07-06T21:28:52.111603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-07-06T21:28:52.111702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-07-06T21:28:52.111728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-07-06T21:28:52.111774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-07-06T21:28:52.111818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-07-06T21:28:52.111837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-07-06T21:28:52.112704Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-06T21:28:52.112763Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:28:52.112714Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T21:28:52.112949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T21:28:52.11308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-06T21:28:52.113293Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-06T21:28:52.113377Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:28:52.113486Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:28:52.11352Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:28:52.114798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-06T21:28:52.117209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"warn","ts":"2026-07-06T21:28:57.903433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.64965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:28:57.903509Z","caller":"traceutil/trace.go:171","msg":"trace[654608271] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:268; }","duration":"243.806554ms","start":"2026-07-06T21:28:57.659684Z","end":"2026-07-06T21:28:57.90349Z","steps":["trace[654608271] 'range keys from in-memory index tree' (duration: 243.561898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:28:57.903704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.346585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:28:57.903772Z","caller":"traceutil/trace.go:171","msg":"trace[1031036026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:268; }","duration":"147.457468ms","start":"2026-07-06T21:28:57.756297Z","end":"2026-07-06T21:28:57.903755Z","steps":["trace[1031036026] 'range keys from in-memory index tree' (duration: 147.236242ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.07021Z","caller":"traceutil/trace.go:171","msg":"trace[357541290] transaction","detail":"{read_only:false; number_of_response:0; response_revision:268; }","duration":"229.612366ms","start":"2026-07-06T21:28:57.840572Z","end":"2026-07-06T21:28:58.070185Z","steps":["trace[357541290] 'process raft request' (duration: 229.529854ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146109Z","caller":"traceutil/trace.go:171","msg":"trace[880732329] transaction","detail":"{read_only:false; number_of_response:0; response_revision:268; }","duration":"302.792074ms","start":"2026-07-06T21:28:57.843288Z","end":"2026-07-06T21:28:58.14608Z","steps":["trace[880732329] 'process raft request' (duration: 302.594239ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146181Z","caller":"traceutil/trace.go:171","msg":"trace[1493191387] transaction","detail":"{read_only:false; number_of_response:0; response_revision:268; }","duration":"301.00751ms","start":"2026-07-06T21:28:57.845149Z","end":"2026-07-06T21:28:58.146157Z","steps":["trace[1493191387] 'process raft request' (duration: 300.832315ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146265Z","caller":"traceutil/trace.go:171","msg":"trace[170396690] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"238.736044ms","start":"2026-07-06T21:28:57.90752Z","end":"2026-07-06T21:28:58.146256Z","steps":["trace[170396690] 'process raft request' (duration: 238.56999ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146275Z","caller":"traceutil/trace.go:171","msg":"trace[1356058443] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:278; }","duration":"242.205999ms","start":"2026-07-06T21:28:57.904053Z","end":"2026-07-06T21:28:58.146259Z","steps":["trace[1356058443] 'read index received' (duration: 166.164861ms)","trace[1356058443] 'applied index is now lower than readState.Index' (duration: 76.040068ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:28:58.146354Z","caller":"traceutil/trace.go:171","msg":"trace[1618791550] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"238.817575ms","start":"2026-07-06T21:28:57.907528Z","end":"2026-07-06T21:28:58.146346Z","steps":["trace[1618791550] 'process raft request' (duration: 238.632601ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146484Z","caller":"traceutil/trace.go:171","msg":"trace[769810320] transaction","detail":"{read_only:false; number_of_response:0; response_revision:268; }","duration":"299.730738ms","start":"2026-07-06T21:28:57.846744Z","end":"2026-07-06T21:28:58.146475Z","steps":["trace[769810320] 'process raft request' (duration: 299.308658ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.146554Z","caller":"traceutil/trace.go:171","msg":"trace[109379617] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"226.794799ms","start":"2026-07-06T21:28:57.91975Z","end":"2026-07-06T21:28:58.146545Z","steps":["trace[109379617] 'process raft request' (duration: 226.465731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:28:58.146628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:28:57.843267Z","time spent":"302.920447ms","remote":"127.0.0.1:44988","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-06T21:28:58.146824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:28:57.845134Z","time spent":"301.097141ms","remote":"127.0.0.1:44988","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-06T21:28:58.147003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.694252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:28:58.14708Z","caller":"traceutil/trace.go:171","msg":"trace[1431037244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:271; }","duration":"243.036541ms","start":"2026-07-06T21:28:57.904025Z","end":"2026-07-06T21:28:58.147061Z","steps":["trace[1431037244] 'agreement among raft nodes before linearized reading' (duration: 242.686191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:28:58.147424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.19391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-06T21:28:58.147494Z","caller":"traceutil/trace.go:171","msg":"trace[1565940553] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:271; }","duration":"240.289143ms","start":"2026-07-06T21:28:57.907188Z","end":"2026-07-06T21:28:58.147477Z","steps":["trace[1565940553] 'agreement among raft nodes before linearized reading' (duration: 240.19061ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.252255Z","caller":"traceutil/trace.go:171","msg":"trace[989836319] linearizableReadLoop","detail":"{readStateIndex:285; appliedIndex:284; }","duration":"100.833961ms","start":"2026-07-06T21:28:58.151399Z","end":"2026-07-06T21:28:58.252233Z","steps":["trace[989836319] 'read index received' (duration: 84.871326ms)","trace[989836319] 'applied index is now lower than readState.Index' (duration: 15.961515ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:28:58.252419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.992505ms","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-07-06T21:28:58.252457Z","caller":"traceutil/trace.go:171","msg":"trace[2039038183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:272; }","duration":"101.057396ms","start":"2026-07-06T21:28:58.151391Z","end":"2026-07-06T21:28:58.252448Z","steps":["trace[2039038183] 'agreement among raft nodes before linearized reading' (duration: 100.939903ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:28:58.252537Z","caller":"traceutil/trace.go:171","msg":"trace[2011926111] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"101.285262ms","start":"2026-07-06T21:28:58.151219Z","end":"2026-07-06T21:28:58.252504Z","steps":["trace[2011926111] 'process raft request' (duration: 85.134642ms)","trace[2011926111] 'compare' (duration: 15.787781ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:28:58.253125Z","caller":"traceutil/trace.go:171","msg":"trace[733614515] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"101.693522ms","start":"2026-07-06T21:28:58.151405Z","end":"2026-07-06T21:28:58.253098Z","steps":["trace[733614515] 'process raft request' (duration: 101.584229ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.896493Z","caller":"traceutil/trace.go:171","msg":"trace[341561716] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"113.420007ms","start":"2026-07-06T21:29:27.783047Z","end":"2026-07-06T21:29:27.896467Z","steps":["trace[341561716] 'process raft request' (duration: 113.235332ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902188Z","caller":"traceutil/trace.go:171","msg":"trace[1211753551] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"111.363329ms","start":"2026-07-06T21:29:27.790807Z","end":"2026-07-06T21:29:27.90217Z","steps":["trace[1211753551] 'process raft request' (duration: 111.231905ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.90212Z","caller":"traceutil/trace.go:171","msg":"trace[580633228] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"116.96428ms","start":"2026-07-06T21:29:27.785129Z","end":"2026-07-06T21:29:27.902093Z","steps":["trace[580633228] 'process raft request' (duration: 116.771034ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902272Z","caller":"traceutil/trace.go:171","msg":"trace[624832064] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"107.731144ms","start":"2026-07-06T21:29:27.794523Z","end":"2026-07-06T21:29:27.902254Z","steps":["trace[624832064] 'process raft request' (duration: 107.542049ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902387Z","caller":"traceutil/trace.go:171","msg":"trace[768981733] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"117.144375ms","start":"2026-07-06T21:29:27.785237Z","end":"2026-07-06T21:29:27.902381Z","steps":["trace[768981733] 'process raft request' (duration: 116.746744ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902442Z","caller":"traceutil/trace.go:171","msg":"trace[1050759763] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"100.249528ms","start":"2026-07-06T21:29:27.802187Z","end":"2026-07-06T21:29:27.902437Z","steps":["trace[1050759763] 'process raft request' (duration: 99.933949ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902707Z","caller":"traceutil/trace.go:171","msg":"trace[942319960] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"106.314284ms","start":"2026-07-06T21:29:27.796379Z","end":"2026-07-06T21:29:27.902693Z","steps":["trace[942319960] 'process raft request' (duration: 105.708496ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:27.902871Z","caller":"traceutil/trace.go:171","msg":"trace[1776480385] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"113.825859ms","start":"2026-07-06T21:29:27.788997Z","end":"2026-07-06T21:29:27.902823Z","steps":["trace[1776480385] 'process raft request' (duration: 113.012826ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:34.083048Z","caller":"traceutil/trace.go:171","msg":"trace[985075609] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"142.333282ms","start":"2026-07-06T21:29:33.940672Z","end":"2026-07-06T21:29:34.083005Z","steps":["trace[985075609] 'process raft request' (duration: 142.126285ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:34.147683Z","caller":"traceutil/trace.go:171","msg":"trace[1662421495] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"124.958325ms","start":"2026-07-06T21:29:34.022697Z","end":"2026-07-06T21:29:34.147655Z","steps":["trace[1662421495] 'process raft request' (duration: 124.486591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:34.653806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.81185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-06T21:29:34.65393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.671439ms","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-07-06T21:29:34.65394Z","caller":"traceutil/trace.go:171","msg":"trace[888859931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"318.979704ms","start":"2026-07-06T21:29:34.334934Z","end":"2026-07-06T21:29:34.653914Z","steps":["trace[888859931] 'range keys from in-memory index tree' (duration: 318.740477ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:34.653983Z","caller":"traceutil/trace.go:171","msg":"trace[881635040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"219.757551ms","start":"2026-07-06T21:29:34.434212Z","end":"2026-07-06T21:29:34.65397Z","steps":["trace[881635040] 'range keys from in-memory index tree' (duration: 219.619208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:34.654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.334919Z","time spent":"319.070537ms","remote":"127.0.0.1:45104","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-07-06T21:29:35.209901Z","caller":"traceutil/trace.go:171","msg":"trace[152576274] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"559.17116ms","start":"2026-07-06T21:29:34.650683Z","end":"2026-07-06T21:29:35.209855Z","steps":["trace[152576274] 'process raft request' (duration: 557.964685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:35.21483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.650656Z","time spent":"559.363345ms","remote":"127.0.0.1:44904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T21:29:35.238976Z","caller":"traceutil/trace.go:171","msg":"trace[771542230] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:618; }","duration":"415.558123ms","start":"2026-07-06T21:29:34.823377Z","end":"2026-07-06T21:29:35.238935Z","steps":["trace[771542230] 'read index received' (duration: 385.066366ms)","trace[771542230] 'applied index is now lower than readState.Index' (duration: 30.490897ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:29:35.239205Z","caller":"traceutil/trace.go:171","msg":"trace[1513826738] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"581.599405ms","start":"2026-07-06T21:29:34.657598Z","end":"2026-07-06T21:29:35.239197Z","steps":["trace[1513826738] 'process raft request' (duration: 581.086551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:35.239285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.657582Z","time spent":"581.648087ms","remote":"127.0.0.1:45104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T21:29:35.239406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.039714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-06T21:29:35.239411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.004475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:29:35.239478Z","caller":"traceutil/trace.go:171","msg":"trace[402103873] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:600; }","duration":"111.144797ms","start":"2026-07-06T21:29:35.128304Z","end":"2026-07-06T21:29:35.239449Z","steps":["trace[402103873] 'agreement among raft nodes before linearized reading' (duration: 111.014274ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:35.239518Z","caller":"traceutil/trace.go:171","msg":"trace[489174235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"416.16206ms","start":"2026-07-06T21:29:34.823329Z","end":"2026-07-06T21:29:35.239491Z","steps":["trace[489174235] 'agreement among raft nodes before linearized reading' (duration: 415.940813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:35.239571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.82331Z","time spent":"416.250751ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-06T21:29:35.239649Z","caller":"traceutil/trace.go:171","msg":"trace[960704168] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"581.534354ms","start":"2026-07-06T21:29:34.658087Z","end":"2026-07-06T21:29:35.239621Z","steps":["trace[960704168] 'process raft request' (duration: 580.790863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:35.239694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.658073Z","time spent":"581.595485ms","remote":"127.0.0.1:45104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T21:29:35.239727Z","caller":"traceutil/trace.go:171","msg":"trace[599261535] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"538.434588ms","start":"2026-07-06T21:29:34.701283Z","end":"2026-07-06T21:29:35.239718Z","steps":["trace[599261535] 'process raft request' (duration: 537.619365ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:29:35.239774Z","caller":"traceutil/trace.go:171","msg":"trace[164235530] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"581.713649ms","start":"2026-07-06T21:29:34.658054Z","end":"2026-07-06T21:29:35.239768Z","steps":["trace[164235530] 'process raft request' (duration: 580.792093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:29:35.239795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.70126Z","time spent":"538.48746ms","remote":"127.0.0.1:45104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T21:29:35.239815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:29:34.658032Z","time spent":"581.76374ms","remote":"127.0.0.1:45104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T21:29:56.387149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.96979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:29:56.387249Z","caller":"traceutil/trace.go:171","msg":"trace[567467572] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:777; }","duration":"226.123574ms","start":"2026-07-06T21:29:56.161106Z","end":"2026-07-06T21:29:56.387229Z","steps":["trace[567467572] 'count revisions from in-memory index tree' (duration: 225.885398ms)"],"step_count":1}