{"level":"warn","ts":"2026-10-13T21:11:34.642247Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T21:11:34.642339Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.205: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://162.253.55.205:2380","--initial-cluster=instance=https://162.253.55.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.205: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-10-13T21:11:34.642407Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T21:11:34.64242Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-13T21:11:34.642443Z","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-10-13T21:11:34.64308Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"]} {"level":"info","ts":"2026-10-13T21:11:34.643162Z","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://162.253.55.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.205: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-10-13T21:11:34.647599Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.224163ms"} {"level":"info","ts":"2026-10-13T21:11:34.654178Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f1f73ead33f822e","cluster-id":"eaba2551c55d0fa5"} {"level":"info","ts":"2026-10-13T21:11:34.654321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T21:11:34.654343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 0"} {"level":"info","ts":"2026-10-13T21:11:34.654396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f1f73ead33f822e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T21:11:34.654407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 1"} {"level":"info","ts":"2026-10-13T21:11:34.654441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"warn","ts":"2026-10-13T21:11:34.664642Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T21:11:34.666058Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T21:11:34.667265Z","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-10-13T21:11:34.669175Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f1f73ead33f822e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T21:11:34.669401Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f1f73ead33f822e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T21:11:34.669444Z","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-10-13T21:11:34.669558Z","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-10-13T21:11:34.669574Z","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-10-13T21:11:34.670009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"info","ts":"2026-10-13T21:11:34.67009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","added-peer-id":"5f1f73ead33f822e","added-peer-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-13T21:11:34.675406Z","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-10-13T21:11:34.67555Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-13T21:11:34.675612Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-13T21:11:34.676104Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f1f73ead33f822e","initial-advertise-peer-urls":["https://162.253.55.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T21:11:34.676141Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T21:11:35.35534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T21:11:35.355662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T21:11:35.35583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgPreVoteResp from 5f1f73ead33f822e at term 1"} {"level":"info","ts":"2026-10-13T21:11:35.355931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became candidate at term 2"} {"level":"info","ts":"2026-10-13T21:11:35.355976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgVoteResp from 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-13T21:11:35.356041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became leader at term 2"} {"level":"info","ts":"2026-10-13T21:11:35.356141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f1f73ead33f822e elected leader 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-13T21:11:35.358118Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:11:35.359291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T21:11:35.359289Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f1f73ead33f822e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.205:2379]}","request-path":"/0/members/5f1f73ead33f822e/attributes","cluster-id":"eaba2551c55d0fa5","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T21:11:35.359501Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T21:11:35.360337Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T21:11:35.360408Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T21:11:35.360823Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:11:35.360915Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:11:35.360946Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T21:11:35.362059Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.205:2379"} {"level":"info","ts":"2026-10-13T21:11:35.362704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-13T21:11:40.782419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.820937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-13T21:11:40.782547Z","caller":"traceutil/trace.go:171","msg":"trace[296036854] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:268; }","duration":"166.98599ms","start":"2026-10-13T21:11:40.615534Z","end":"2026-10-13T21:11:40.78252Z","steps":["trace[296036854] 'range keys from in-memory index tree' (duration: 166.701265ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:11:40.782659Z","caller":"traceutil/trace.go:171","msg":"trace[1873562639] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"159.247871ms","start":"2026-10-13T21:11:40.623392Z","end":"2026-10-13T21:11:40.78264Z","steps":["trace[1873562639] 'process raft request' (duration: 131.308044ms)","trace[1873562639] 'compare' (duration: 27.55896ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:11:41.27746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.646669ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:11:41.277737Z","caller":"traceutil/trace.go:171","msg":"trace[465752811] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:277; }","duration":"202.707248ms","start":"2026-10-13T21:11:41.074945Z","end":"2026-10-13T21:11:41.277652Z","steps":["trace[465752811] 'read index received' (duration: 33.69µs)","trace[465752811] 'applied index is now lower than readState.Index' (duration: 202.672458ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:11:41.277815Z","caller":"traceutil/trace.go:171","msg":"trace[1822685257] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"491.336824ms","start":"2026-10-13T21:11:40.786454Z","end":"2026-10-13T21:11:41.277791Z","steps":["trace[1822685257] 'process raft request' (duration: 207.324154ms)","trace[1822685257] 'compare' (duration: 282.300852ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:11:41.277813Z","caller":"traceutil/trace.go:171","msg":"trace[192836952] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"491.009159ms","start":"2026-10-13T21:11:40.786779Z","end":"2026-10-13T21:11:41.277789Z","steps":["trace[192836952] 'process raft request' (duration: 490.776605ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:11:41.27792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:11:40.786432Z","time spent":"491.437746ms","remote":"127.0.0.1:35386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T21:11:41.277984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:11:40.786769Z","time spent":"491.154541ms","remote":"127.0.0.1:35240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T21:11:41.278036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.050684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:11:41.278136Z","caller":"traceutil/trace.go:171","msg":"trace[319633721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:271; }","duration":"203.206926ms","start":"2026-10-13T21:11:41.074886Z","end":"2026-10-13T21:11:41.278093Z","steps":["trace[319633721] 'agreement among raft nodes before linearized reading' (duration: 202.977862ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:11:41.278288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.712654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-13T21:11:41.278344Z","caller":"traceutil/trace.go:171","msg":"trace[744919961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:271; }","duration":"153.811216ms","start":"2026-10-13T21:11:41.124516Z","end":"2026-10-13T21:11:41.278327Z","steps":["trace[744919961] 'agreement among raft nodes before linearized reading' (duration: 153.557312ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:11:41.482011Z","caller":"traceutil/trace.go:171","msg":"trace[1157595602] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:279; }","duration":"199.535685ms","start":"2026-10-13T21:11:41.282447Z","end":"2026-10-13T21:11:41.481983Z","steps":["trace[1157595602] 'read index received' (duration: 148.522849ms)","trace[1157595602] 'applied index is now lower than readState.Index' (duration: 51.011396ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:11:41.482058Z","caller":"traceutil/trace.go:171","msg":"trace[647337816] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"200.148585ms","start":"2026-10-13T21:11:41.281886Z","end":"2026-10-13T21:11:41.482035Z","steps":["trace[647337816] 'process raft request' (duration: 149.074727ms)","trace[647337816] 'compare' (duration: 50.544059ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:11:41.482328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.843261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:11:41.482487Z","caller":"traceutil/trace.go:171","msg":"trace[1445475246] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:272; }","duration":"199.994173ms","start":"2026-10-13T21:11:41.282422Z","end":"2026-10-13T21:11:41.482417Z","steps":["trace[1445475246] 'agreement among raft nodes before linearized reading' (duration: 199.651187ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:11:41.486221Z","caller":"traceutil/trace.go:171","msg":"trace[1009130602] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"203.427401ms","start":"2026-10-13T21:11:41.282782Z","end":"2026-10-13T21:11:41.48621Z","steps":["trace[1009130602] 'process raft request' (duration: 203.397901ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:11:41.48634Z","caller":"traceutil/trace.go:171","msg":"trace[1220622656] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"203.564993ms","start":"2026-10-13T21:11:41.282695Z","end":"2026-10-13T21:11:41.48626Z","steps":["trace[1220622656] 'process raft request' (duration: 203.40356ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:12:19.883056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.267191ms","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-10-13T21:12:19.883144Z","caller":"traceutil/trace.go:171","msg":"trace[380886550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:511; }","duration":"110.368113ms","start":"2026-10-13T21:12:19.772757Z","end":"2026-10-13T21:12:19.883125Z","steps":["trace[380886550] 'range keys from in-memory index tree' (duration: 110.135029ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:12:25.93561Z","caller":"traceutil/trace.go:171","msg":"trace[355474646] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"108.440895ms","start":"2026-10-13T21:12:25.827143Z","end":"2026-10-13T21:12:25.935584Z","steps":["trace[355474646] 'process raft request' (duration: 100.187261ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:12:26.371417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.79189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T21:12:26.371513Z","caller":"traceutil/trace.go:171","msg":"trace[2042075321] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"373.412464ms","start":"2026-10-13T21:12:25.998083Z","end":"2026-10-13T21:12:26.371495Z","steps":["trace[2042075321] 'process raft request' (duration: 263.314171ms)","trace[2042075321] 'compare' (duration: 109.687837ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:12:26.371584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:12:25.998072Z","time spent":"373.468745ms","remote":"127.0.0.1:35310","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-10-13T21:12:26.386014Z","caller":"traceutil/trace.go:171","msg":"trace[555394077] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:641; }","duration":"309.382703ms","start":"2026-10-13T21:12:26.076612Z","end":"2026-10-13T21:12:26.385995Z","steps":["trace[555394077] 'read index received' (duration: 184.876322ms)","trace[555394077] 'applied index is now lower than readState.Index' (duration: 124.505511ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:12:26.386119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.500565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:12:26.386109Z","caller":"traceutil/trace.go:171","msg":"trace[485102896] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"363.793241ms","start":"2026-10-13T21:12:26.022295Z","end":"2026-10-13T21:12:26.386088Z","steps":["trace[485102896] 'process raft request' (duration: 363.649529ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:12:26.386155Z","caller":"traceutil/trace.go:171","msg":"trace[426308666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"309.581255ms","start":"2026-10-13T21:12:26.076562Z","end":"2026-10-13T21:12:26.386143Z","steps":["trace[426308666] 'agreement among raft nodes before linearized reading' (duration: 309.499444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:12:26.386187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:12:26.076498Z","time spent":"309.682847ms","remote":"127.0.0.1:35030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T21:12:26.386194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:12:26.02228Z","time spent":"363.878332ms","remote":"127.0.0.1:35386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T21:12:26.386214Z","caller":"traceutil/trace.go:171","msg":"trace[889524320] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"384.06503ms","start":"2026-10-13T21:12:26.002122Z","end":"2026-10-13T21:12:26.386187Z","steps":["trace[889524320] 'process raft request' (duration: 383.729206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:12:26.386368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:12:26.002102Z","time spent":"384.188971ms","remote":"127.0.0.1:35310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T21:12:27.084549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.645979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j7wzf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-13T21:12:27.084658Z","caller":"traceutil/trace.go:171","msg":"trace[44422089] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j7wzf; range_end:; response_count:1; response_revision:619; }","duration":"511.848862ms","start":"2026-10-13T21:12:26.572786Z","end":"2026-10-13T21:12:27.084635Z","steps":["trace[44422089] 'range keys from in-memory index tree' (duration: 511.133292ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T21:12:27.084747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T21:12:26.572749Z","time spent":"511.987194ms","remote":"127.0.0.1:35224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-j7wzf\" "} {"level":"info","ts":"2026-10-13T21:12:27.099424Z","caller":"traceutil/trace.go:171","msg":"trace[1169780664] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"255.964895ms","start":"2026-10-13T21:12:26.843412Z","end":"2026-10-13T21:12:27.099376Z","steps":["trace[1169780664] 'process raft request' (duration: 243.055217ms)","trace[1169780664] 'compare' (duration: 12.38516ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T21:12:42.601158Z","caller":"traceutil/trace.go:171","msg":"trace[169425959] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"117.591053ms","start":"2026-10-13T21:12:42.483543Z","end":"2026-10-13T21:12:42.601134Z","steps":["trace[169425959] 'read index received' (duration: 117.407301ms)","trace[169425959] 'applied index is now lower than readState.Index' (duration: 182.832µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T21:12:42.601399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.831096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-13T21:12:42.601412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.129254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T21:12:42.601486Z","caller":"traceutil/trace.go:171","msg":"trace[410640051] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:787; }","duration":"100.238616ms","start":"2026-10-13T21:12:42.501228Z","end":"2026-10-13T21:12:42.601467Z","steps":["trace[410640051] 'agreement among raft nodes before linearized reading' (duration: 100.109664ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:12:42.601471Z","caller":"traceutil/trace.go:171","msg":"trace[987489389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"117.922717ms","start":"2026-10-13T21:12:42.483518Z","end":"2026-10-13T21:12:42.601441Z","steps":["trace[987489389] 'agreement among raft nodes before linearized reading' (duration: 117.746305ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:12:42.601277Z","caller":"traceutil/trace.go:171","msg":"trace[1460163127] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"141.391876ms","start":"2026-10-13T21:12:42.459861Z","end":"2026-10-13T21:12:42.601253Z","steps":["trace[1460163127] 'process raft request' (duration: 141.136372ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T21:13:14.288794Z","caller":"traceutil/trace.go:171","msg":"trace[1610419943] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"132.843429ms","start":"2026-10-13T21:13:14.155898Z","end":"2026-10-13T21:13:14.288741Z","steps":["trace[1610419943] 'process raft request' (duration: 118.065099ms)","trace[1610419943] 'compare' (duration: 14.519947ms)"],"step_count":2}