{"level":"warn","ts":"2026-09-03T02:25:24.815255Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T02:25:24.815369Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.57: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.57:2380","--initial-cluster=instance=https://162.253.55.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.57: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-09-03T02:25:24.815447Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T02:25:24.815461Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-03T02:25:24.815495Z","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-09-03T02:25:24.816216Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"]} {"level":"info","ts":"2026-09-03T02:25:24.816308Z","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.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.57: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-09-03T02:25:24.824097Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.589022ms"} {"level":"info","ts":"2026-09-03T02:25:24.83453Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db28a37eabf8270","cluster-id":"33328f64ab44b15e"} {"level":"info","ts":"2026-09-03T02:25:24.834815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=()"} {"level":"info","ts":"2026-09-03T02:25:24.834883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 0"} {"level":"info","ts":"2026-09-03T02:25:24.834896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db28a37eabf8270 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-03T02:25:24.834909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 1"} {"level":"info","ts":"2026-09-03T02:25:24.834949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"warn","ts":"2026-09-03T02:25:24.845912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-03T02:25:24.849258Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-03T02:25:24.851344Z","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-09-03T02:25:24.853303Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db28a37eabf8270","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-03T02:25:24.853454Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db28a37eabf8270","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-03T02:25:24.853562Z","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-09-03T02:25:24.853692Z","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-09-03T02:25:24.853703Z","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-09-03T02:25:24.858011Z","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-09-03T02:25:24.858271Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db28a37eabf8270","initial-advertise-peer-urls":["https://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-03T02:25:24.858311Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-03T02:25:24.858314Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-03T02:25:24.858385Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-03T02:25:24.85865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"info","ts":"2026-09-03T02:25:24.858856Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","added-peer-id":"db28a37eabf8270","added-peer-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-03T02:25:24.935742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 is starting a new election at term 1"} {"level":"info","ts":"2026-09-03T02:25:24.935858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-03T02:25:24.936054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgPreVoteResp from db28a37eabf8270 at term 1"} {"level":"info","ts":"2026-09-03T02:25:24.936206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became candidate at term 2"} {"level":"info","ts":"2026-09-03T02:25:24.93623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgVoteResp from db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-03T02:25:24.93633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became leader at term 2"} {"level":"info","ts":"2026-09-03T02:25:24.936354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db28a37eabf8270 elected leader db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-03T02:25:24.937639Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db28a37eabf8270","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.57:2379]}","request-path":"/0/members/db28a37eabf8270/attributes","cluster-id":"33328f64ab44b15e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-03T02:25:24.937735Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T02:25:24.938258Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:25:24.938451Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T02:25:24.938981Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-03T02:25:24.939078Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-03T02:25:24.94117Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.57:2379"} {"level":"info","ts":"2026-09-03T02:25:24.94163Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:25:24.9418Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:25:24.941853Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:25:24.942064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-03T02:25:28.643559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.390592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:25:28.643945Z","caller":"traceutil/trace.go:171","msg":"trace[2087469410] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"534.703585ms","start":"2026-09-03T02:25:28.109171Z","end":"2026-09-03T02:25:28.643875Z","steps":["trace[2087469410] 'process raft request' (duration: 161.322597ms)","trace[2087469410] 'compare' (duration: 372.204695ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:25:28.644203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:25:28.109158Z","time spent":"534.952867ms","remote":"127.0.0.1:44868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-03T02:25:28.83662Z","caller":"traceutil/trace.go:171","msg":"trace[1221138795] linearizableReadLoop","detail":"{readStateIndex:144; appliedIndex:143; }","duration":"172.722728ms","start":"2026-09-03T02:25:28.663862Z","end":"2026-09-03T02:25:28.836585Z","steps":["trace[1221138795] 'read index received' (duration: 162.888435ms)","trace[1221138795] 'applied index is now lower than readState.Index' (duration: 9.832643ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:25:28.83672Z","caller":"traceutil/trace.go:171","msg":"trace[1682523578] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"185.680688ms","start":"2026-09-03T02:25:28.65099Z","end":"2026-09-03T02:25:28.836671Z","steps":["trace[1682523578] 'process raft request' (duration: 175.785003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:25:28.836896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.002818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:25:28.837104Z","caller":"traceutil/trace.go:171","msg":"trace[46759814] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:140; }","duration":"173.274258ms","start":"2026-09-03T02:25:28.663811Z","end":"2026-09-03T02:25:28.837086Z","steps":["trace[46759814] 'agreement among raft nodes before linearized reading' (duration: 172.896134ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:06.180359Z","caller":"traceutil/trace.go:171","msg":"trace[1806543352] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"169.634643ms","start":"2026-09-03T02:26:06.010673Z","end":"2026-09-03T02:26:06.180307Z","steps":["trace[1806543352] 'process raft request' (duration: 169.459239ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:06.772315Z","caller":"traceutil/trace.go:171","msg":"trace[157862616] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"103.293028ms","start":"2026-09-03T02:26:06.668989Z","end":"2026-09-03T02:26:06.772282Z","steps":["trace[157862616] 'process raft request' (duration: 50.102869ms)","trace[157862616] 'compare' (duration: 53.022664ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:26:07.16936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.766647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:26:07.169636Z","caller":"traceutil/trace.go:171","msg":"trace[1709958648] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"357.998505ms","start":"2026-09-03T02:26:06.811601Z","end":"2026-09-03T02:26:07.1696Z","steps":["trace[1709958648] 'process raft request' (duration: 176.906221ms)","trace[1709958648] 'compare' (duration: 180.57201ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:07.169772Z","caller":"traceutil/trace.go:171","msg":"trace[220782576] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"357.400009ms","start":"2026-09-03T02:26:06.812352Z","end":"2026-09-03T02:26:07.169752Z","steps":["trace[220782576] 'process raft request' (duration: 357.196134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:07.169843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:26:06.811559Z","time spent":"358.168139ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-03T02:26:07.170017Z","caller":"traceutil/trace.go:171","msg":"trace[1207422824] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:575; }","duration":"239.993199ms","start":"2026-09-03T02:26:06.930005Z","end":"2026-09-03T02:26:07.169998Z","steps":["trace[1207422824] 'read index received' (duration: 58.546367ms)","trace[1207422824] 'applied index is now lower than readState.Index' (duration: 181.445862ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:26:07.170074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:26:06.812319Z","time spent":"357.505762ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T02:26:07.170117Z","caller":"traceutil/trace.go:171","msg":"trace[21146765] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"327.552912ms","start":"2026-09-03T02:26:06.842555Z","end":"2026-09-03T02:26:07.170108Z","steps":["trace[21146765] 'process raft request' (duration: 327.141892ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:07.170169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.162403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-03T02:26:07.170197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:26:06.842504Z","time spent":"327.637494ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T02:26:07.170208Z","caller":"traceutil/trace.go:171","msg":"trace[1295640318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"240.254585ms","start":"2026-09-03T02:26:06.929943Z","end":"2026-09-03T02:26:07.170198Z","steps":["trace[1295640318] 'agreement among raft nodes before linearized reading' (duration: 240.162953ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:07.17035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.294178ms","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-09-03T02:26:07.170393Z","caller":"traceutil/trace.go:171","msg":"trace[1526550788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"118.37001ms","start":"2026-09-03T02:26:07.052011Z","end":"2026-09-03T02:26:07.170381Z","steps":["trace[1526550788] 'agreement among raft nodes before linearized reading' (duration: 118.293008ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:12.786871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.180457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:26:12.787001Z","caller":"traceutil/trace.go:171","msg":"trace[1864443636] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"146.335574ms","start":"2026-09-03T02:26:12.640642Z","end":"2026-09-03T02:26:12.786978Z","steps":["trace[1864443636] 'read index received' (duration: 33.856049ms)","trace[1864443636] 'applied index is now lower than readState.Index' (duration: 112.477975ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:12.78717Z","caller":"traceutil/trace.go:171","msg":"trace[88208421] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"154.634618ms","start":"2026-09-03T02:26:12.632464Z","end":"2026-09-03T02:26:12.787098Z","steps":["trace[88208421] 'process raft request' (duration: 42.114143ms)","trace[88208421] 'compare' (duration: 111.971662ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:26:12.78723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.589041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6fcv4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-03T02:26:12.787574Z","caller":"traceutil/trace.go:171","msg":"trace[1516468097] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6fcv4; range_end:; response_count:1; response_revision:600; }","duration":"146.962349ms","start":"2026-09-03T02:26:12.640594Z","end":"2026-09-03T02:26:12.787556Z","steps":["trace[1516468097] 'agreement among raft nodes before linearized reading' (duration: 146.442127ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:13.184198Z","caller":"traceutil/trace.go:171","msg":"trace[952261334] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"252.093991ms","start":"2026-09-03T02:26:12.932077Z","end":"2026-09-03T02:26:13.184171Z","steps":["trace[952261334] 'read index received' (duration: 220.524863ms)","trace[952261334] 'applied index is now lower than readState.Index' (duration: 31.567838ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:26:13.184345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.254894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:26:13.184369Z","caller":"traceutil/trace.go:171","msg":"trace[50371291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"252.355236ms","start":"2026-09-03T02:26:12.932007Z","end":"2026-09-03T02:26:13.184362Z","steps":["trace[50371291] 'agreement among raft nodes before linearized reading' (duration: 252.263694ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:13.18462Z","caller":"traceutil/trace.go:171","msg":"trace[1604363348] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"376.765862ms","start":"2026-09-03T02:26:12.807807Z","end":"2026-09-03T02:26:13.184573Z","steps":["trace[1604363348] 'process raft request' (duration: 344.892677ms)","trace[1604363348] 'compare' (duration: 31.062105ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:26:13.184819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:26:12.807751Z","time spent":"376.963578ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T02:26:13.484375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.19515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:26:13.484744Z","caller":"traceutil/trace.go:171","msg":"trace[1267251423] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"272.366378ms","start":"2026-09-03T02:26:13.212306Z","end":"2026-09-03T02:26:13.484672Z","steps":["trace[1267251423] 'process raft request' (duration: 151.698316ms)","trace[1267251423] 'compare' (duration: 119.969525ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:13.484834Z","caller":"traceutil/trace.go:171","msg":"trace[761371619] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"271.706362ms","start":"2026-09-03T02:26:13.213107Z","end":"2026-09-03T02:26:13.484813Z","steps":["trace[761371619] 'process raft request' (duration: 271.481867ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:13.485914Z","caller":"traceutil/trace.go:171","msg":"trace[1256779737] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"256.993495ms","start":"2026-09-03T02:26:13.228877Z","end":"2026-09-03T02:26:13.48587Z","steps":["trace[1256779737] 'process raft request' (duration: 256.111343ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:13.751466Z","caller":"traceutil/trace.go:171","msg":"trace[818750884] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"223.666405ms","start":"2026-09-03T02:26:13.527759Z","end":"2026-09-03T02:26:13.751425Z","steps":["trace[818750884] 'process raft request' (duration: 169.824586ms)","trace[818750884] 'compare' (duration: 53.611652ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:13.751764Z","caller":"traceutil/trace.go:171","msg":"trace[1111990638] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"184.047592ms","start":"2026-09-03T02:26:13.567687Z","end":"2026-09-03T02:26:13.751734Z","steps":["trace[1111990638] 'process raft request' (duration: 183.667453ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:13.751802Z","caller":"traceutil/trace.go:171","msg":"trace[1308481736] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"103.970986ms","start":"2026-09-03T02:26:13.647802Z","end":"2026-09-03T02:26:13.751773Z","steps":["trace[1308481736] 'read index received' (duration: 49.799409ms)","trace[1308481736] 'applied index is now lower than readState.Index' (duration: 54.170247ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:13.75182Z","caller":"traceutil/trace.go:171","msg":"trace[1583094553] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"103.350241ms","start":"2026-09-03T02:26:13.648429Z","end":"2026-09-03T02:26:13.751779Z","steps":["trace[1583094553] 'process raft request' (duration: 103.221358ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:13.752145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.324724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6fcv4\" ","response":"range_response_count:1 size:17145"} {"level":"info","ts":"2026-09-03T02:26:13.752226Z","caller":"traceutil/trace.go:171","msg":"trace[2021776524] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6fcv4; range_end:; response_count:1; response_revision:607; }","duration":"104.460958ms","start":"2026-09-03T02:26:13.647738Z","end":"2026-09-03T02:26:13.752199Z","steps":["trace[2021776524] 'agreement among raft nodes before linearized reading' (duration: 104.146901ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:26:29.068196Z","caller":"traceutil/trace.go:171","msg":"trace[1044791202] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"138.833706ms","start":"2026-09-03T02:26:28.929334Z","end":"2026-09-03T02:26:29.068168Z","steps":["trace[1044791202] 'read index received' (duration: 138.614171ms)","trace[1044791202] 'applied index is now lower than readState.Index' (duration: 218.415µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:26:29.068531Z","caller":"traceutil/trace.go:171","msg":"trace[1335313011] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"314.47398ms","start":"2026-09-03T02:26:28.754037Z","end":"2026-09-03T02:26:29.068511Z","steps":["trace[1335313011] 'process raft request' (duration: 313.967659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:29.068347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.990809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:26:29.068601Z","caller":"traceutil/trace.go:171","msg":"trace[718387779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"139.283846ms","start":"2026-09-03T02:26:28.929301Z","end":"2026-09-03T02:26:29.068584Z","steps":["trace[718387779] 'agreement among raft nodes before linearized reading' (duration: 138.990879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:26:29.068873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:26:28.754017Z","time spent":"314.572332ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}