{"level":"warn","ts":"2026-09-11T17:24:50.847171Z","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-11T17:24:50.847325Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217: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-11T17:24:50.847419Z","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-11T17:24:50.84745Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-09-11T17:24:50.84748Z","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-11T17:24:50.848091Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]} {"level":"info","ts":"2026-09-11T17:24:50.848186Z","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.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217: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-11T17:24:50.855145Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.103076ms"} {"level":"info","ts":"2026-09-11T17:24:50.864594Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-09-11T17:24:50.864729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-09-11T17:24:50.864783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-09-11T17:24:50.864822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-11T17:24:50.864852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-09-11T17:24:50.864927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-09-11T17:24:50.870293Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-11T17:24:50.871705Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-11T17:24:50.872933Z","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-11T17:24:50.874817Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-11T17:24:50.874968Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-11T17:24:50.875072Z","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-11T17:24:50.875144Z","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-11T17:24:50.875154Z","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-11T17:24:50.877972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-09-11T17:24:50.878065Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-09-11T17:24:50.880259Z","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-11T17:24:50.88034Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-09-11T17:24:50.880369Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-09-11T17:24:50.880534Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-11T17:24:50.880645Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-11T17:24:51.865623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-09-11T17:24:51.865667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-11T17:24:51.865704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-09-11T17:24:51.865715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-09-11T17:24:51.86572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-09-11T17:24:51.865727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-09-11T17:24:51.865734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-09-11T17:24:51.866412Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:24:51.867201Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"} {"level":"info","ts":"2026-09-11T17:24:51.867212Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T17:24:51.867231Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T17:24:51.86753Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-11T17:24:51.867561Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-11T17:24:51.867939Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:24:51.868005Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:24:51.868028Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:24:51.870009Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-11T17:24:51.870521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"info","ts":"2026-09-11T17:24:55.200811Z","caller":"traceutil/trace.go:171","msg":"trace[1692361402] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"462.720675ms","start":"2026-09-11T17:24:54.737951Z","end":"2026-09-11T17:24:55.200672Z","steps":["trace[1692361402] 'process raft request' (duration: 380.385218ms)","trace[1692361402] 'compare' (duration: 82.194352ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:24:55.202017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:24:54.737924Z","time spent":"463.015904ms","remote":"127.0.0.1:44250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":657,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-11T17:24:55.59585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.835201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-11T17:24:55.596003Z","caller":"traceutil/trace.go:171","msg":"trace[1334234354] linearizableReadLoop","detail":"{readStateIndex:181; appliedIndex:180; }","duration":"267.511576ms","start":"2026-09-11T17:24:55.328468Z","end":"2026-09-11T17:24:55.59598Z","steps":["trace[1334234354] 'read index received' (duration: 53.076678ms)","trace[1334234354] 'applied index is now lower than readState.Index' (duration: 214.432598ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:24:55.596058Z","caller":"traceutil/trace.go:171","msg":"trace[1528235193] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"386.119159ms","start":"2026-09-11T17:24:55.209898Z","end":"2026-09-11T17:24:55.596018Z","steps":["trace[1528235193] 'process raft request' (duration: 171.6901ms)","trace[1528235193] 'compare' (duration: 213.639878ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:24:55.596245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:24:55.209859Z","time spent":"386.295581ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":664,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-11T17:24:55.596495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.975888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:24:55.596692Z","caller":"traceutil/trace.go:171","msg":"trace[435108560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:176; }","duration":"268.18344ms","start":"2026-09-11T17:24:55.328402Z","end":"2026-09-11T17:24:55.596585Z","steps":["trace[435108560] 'agreement among raft nodes before linearized reading' (duration: 267.822554ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:31.838137Z","caller":"traceutil/trace.go:171","msg":"trace[453283612] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"133.300601ms","start":"2026-09-11T17:25:31.704805Z","end":"2026-09-11T17:25:31.838105Z","steps":["trace[453283612] 'process raft request' (duration: 132.887278ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.739416Z","caller":"traceutil/trace.go:171","msg":"trace[1455566579] transaction","detail":"{read_only:false; number_of_response:1; response_revision:547; }","duration":"149.653569ms","start":"2026-09-11T17:25:33.589737Z","end":"2026-09-11T17:25:33.739391Z","steps":["trace[1455566579] 'process raft request' (duration: 149.062394ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.74Z","caller":"traceutil/trace.go:171","msg":"trace[1598079526] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"143.299754ms","start":"2026-09-11T17:25:33.596677Z","end":"2026-09-11T17:25:33.739976Z","steps":["trace[1598079526] 'process raft request' (duration: 143.203503ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.74024Z","caller":"traceutil/trace.go:171","msg":"trace[309110565] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"144.545745ms","start":"2026-09-11T17:25:33.595676Z","end":"2026-09-11T17:25:33.740222Z","steps":["trace[309110565] 'process raft request' (duration: 143.645006ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.7405Z","caller":"traceutil/trace.go:171","msg":"trace[534553507] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"144.744726ms","start":"2026-09-11T17:25:33.595744Z","end":"2026-09-11T17:25:33.740489Z","steps":["trace[534553507] 'process raft request' (duration: 143.763327ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.758795Z","caller":"traceutil/trace.go:171","msg":"trace[1997238880] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"157.951894ms","start":"2026-09-11T17:25:33.600818Z","end":"2026-09-11T17:25:33.75877Z","steps":["trace[1997238880] 'process raft request' (duration: 157.887964ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.758825Z","caller":"traceutil/trace.go:171","msg":"trace[1991228177] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"159.108374ms","start":"2026-09-11T17:25:33.599693Z","end":"2026-09-11T17:25:33.758801Z","steps":["trace[1991228177] 'process raft request' (duration: 158.900152ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.759311Z","caller":"traceutil/trace.go:171","msg":"trace[1365088509] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"153.754147ms","start":"2026-09-11T17:25:33.605518Z","end":"2026-09-11T17:25:33.759272Z","steps":["trace[1365088509] 'process raft request' (duration: 153.463833ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.759453Z","caller":"traceutil/trace.go:171","msg":"trace[762407441] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"153.846798ms","start":"2026-09-11T17:25:33.605589Z","end":"2026-09-11T17:25:33.759436Z","steps":["trace[762407441] 'process raft request' (duration: 153.624616ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.759702Z","caller":"traceutil/trace.go:171","msg":"trace[892459552] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"148.957084ms","start":"2026-09-11T17:25:33.610735Z","end":"2026-09-11T17:25:33.759692Z","steps":["trace[892459552] 'process raft request' (duration: 148.645441ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.759842Z","caller":"traceutil/trace.go:171","msg":"trace[742336813] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"148.923223ms","start":"2026-09-11T17:25:33.610892Z","end":"2026-09-11T17:25:33.759816Z","steps":["trace[742336813] 'process raft request' (duration: 148.719991ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.759979Z","caller":"traceutil/trace.go:171","msg":"trace[996318385] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"147.582891ms","start":"2026-09-11T17:25:33.612372Z","end":"2026-09-11T17:25:33.759955Z","steps":["trace[996318385] 'process raft request' (duration: 147.336739ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.760034Z","caller":"traceutil/trace.go:171","msg":"trace[1741836148] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"136.601384ms","start":"2026-09-11T17:25:33.623422Z","end":"2026-09-11T17:25:33.760024Z","steps":["trace[1741836148] 'process raft request' (duration: 136.399122ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.76003Z","caller":"traceutil/trace.go:171","msg":"trace[178565061] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:567; }","duration":"116.487716ms","start":"2026-09-11T17:25:33.643526Z","end":"2026-09-11T17:25:33.760014Z","steps":["trace[178565061] 'read index received' (duration: 95.229387ms)","trace[178565061] 'applied index is now lower than readState.Index' (duration: 21.257159ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:33.759234Z","caller":"traceutil/trace.go:171","msg":"trace[1846817584] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"156.225639ms","start":"2026-09-11T17:25:33.602984Z","end":"2026-09-11T17:25:33.75921Z","steps":["trace[1846817584] 'process raft request' (duration: 155.754294ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:33.76014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.601346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:25:33.760457Z","caller":"traceutil/trace.go:171","msg":"trace[414406453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"116.981289ms","start":"2026-09-11T17:25:33.643456Z","end":"2026-09-11T17:25:33.760437Z","steps":["trace[414406453] 'agreement among raft nodes before linearized reading' (duration: 116.612976ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.97713Z","caller":"traceutil/trace.go:171","msg":"trace[1011332191] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"179.209793ms","start":"2026-09-11T17:25:33.797897Z","end":"2026-09-11T17:25:33.977107Z","steps":["trace[1011332191] 'process raft request' (duration: 179.148732ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.977266Z","caller":"traceutil/trace.go:171","msg":"trace[678963649] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"191.212189ms","start":"2026-09-11T17:25:33.786012Z","end":"2026-09-11T17:25:33.977224Z","steps":["trace[678963649] 'process raft request' (duration: 128.610733ms)","trace[678963649] 'compare' (duration: 62.259103ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:33.990815Z","caller":"traceutil/trace.go:171","msg":"trace[1088547328] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"154.817936ms","start":"2026-09-11T17:25:33.835977Z","end":"2026-09-11T17:25:33.990795Z","steps":["trace[1088547328] 'process raft request' (duration: 154.738445ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.990891Z","caller":"traceutil/trace.go:171","msg":"trace[1425704365] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"162.756267ms","start":"2026-09-11T17:25:33.828114Z","end":"2026-09-11T17:25:33.99087Z","steps":["trace[1425704365] 'process raft request' (duration: 162.437564ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.990938Z","caller":"traceutil/trace.go:171","msg":"trace[335375620] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"149.755731ms","start":"2026-09-11T17:25:33.841171Z","end":"2026-09-11T17:25:33.990927Z","steps":["trace[335375620] 'process raft request' (duration: 149.59547ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.991024Z","caller":"traceutil/trace.go:171","msg":"trace[984264193] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:586; }","duration":"162.696556ms","start":"2026-09-11T17:25:33.828318Z","end":"2026-09-11T17:25:33.991014Z","steps":["trace[984264193] 'read index received' (duration: 86.388938ms)","trace[984264193] 'applied index is now lower than readState.Index' (duration: 76.306898ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:33.991058Z","caller":"traceutil/trace.go:171","msg":"trace[314910597] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"149.029694ms","start":"2026-09-11T17:25:33.842021Z","end":"2026-09-11T17:25:33.99105Z","steps":["trace[314910597] 'process raft request' (duration: 148.820582ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:33.991135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.803417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-09-11T17:25:33.991174Z","caller":"traceutil/trace.go:171","msg":"trace[1613068479] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:569; }","duration":"162.849977ms","start":"2026-09-11T17:25:33.828314Z","end":"2026-09-11T17:25:33.991164Z","steps":["trace[1613068479] 'agreement among raft nodes before linearized reading' (duration: 162.739896ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:33.991167Z","caller":"traceutil/trace.go:171","msg":"trace[1918976123] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"118.793786ms","start":"2026-09-11T17:25:33.8723Z","end":"2026-09-11T17:25:33.991094Z","steps":["trace[1918976123] 'process raft request' (duration: 118.631875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:34.037748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.371562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-09-11T17:25:34.037838Z","caller":"traceutil/trace.go:171","msg":"trace[765073691] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:570; }","duration":"209.476643ms","start":"2026-09-11T17:25:33.828336Z","end":"2026-09-11T17:25:34.037813Z","steps":["trace[765073691] 'agreement among raft nodes before linearized reading' (duration: 209.275801ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:34.176714Z","caller":"traceutil/trace.go:171","msg":"trace[67235103] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"163.985944ms","start":"2026-09-11T17:25:34.012705Z","end":"2026-09-11T17:25:34.176691Z","steps":["trace[67235103] 'process raft request' (duration: 163.914043ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:34.176811Z","caller":"traceutil/trace.go:171","msg":"trace[1498387136] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"171.105043ms","start":"2026-09-11T17:25:34.005653Z","end":"2026-09-11T17:25:34.176758Z","steps":["trace[1498387136] 'process raft request' (duration: 113.51003ms)","trace[1498387136] 'compare' (duration: 57.107168ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:34.177764Z","caller":"traceutil/trace.go:171","msg":"trace[1204408246] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"103.743394ms","start":"2026-09-11T17:25:34.073999Z","end":"2026-09-11T17:25:34.177743Z","steps":["trace[1204408246] 'read index received' (duration: 45.161712ms)","trace[1204408246] 'applied index is now lower than readState.Index' (duration: 58.580662ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:25:34.178015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.004887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:25:34.178053Z","caller":"traceutil/trace.go:171","msg":"trace[183916202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"104.119769ms","start":"2026-09-11T17:25:34.073922Z","end":"2026-09-11T17:25:34.178042Z","steps":["trace[183916202] 'agreement among raft nodes before linearized reading' (duration: 103.903847ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:34.178511Z","caller":"traceutil/trace.go:171","msg":"trace[1575646484] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"127.889611ms","start":"2026-09-11T17:25:34.050608Z","end":"2026-09-11T17:25:34.178497Z","steps":["trace[1575646484] 'process raft request' (duration: 126.972772ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:40.455154Z","caller":"traceutil/trace.go:171","msg":"trace[211000749] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"523.572227ms","start":"2026-09-11T17:25:39.931543Z","end":"2026-09-11T17:25:40.455116Z","steps":["trace[211000749] 'process raft request' (duration: 522.480581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:40.455316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.244842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:25:40.455401Z","caller":"traceutil/trace.go:171","msg":"trace[1839590009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"377.423805ms","start":"2026-09-11T17:25:40.07796Z","end":"2026-09-11T17:25:40.455384Z","steps":["trace[1839590009] 'agreement among raft nodes before linearized reading' (duration: 377.262333ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:40.455129Z","caller":"traceutil/trace.go:171","msg":"trace[6751307] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"376.929998ms","start":"2026-09-11T17:25:40.078034Z","end":"2026-09-11T17:25:40.454964Z","steps":["trace[6751307] 'read index received' (duration: 375.544978ms)","trace[6751307] 'applied index is now lower than readState.Index' (duration: 1.38368ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:25:40.455459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:40.077927Z","time spent":"377.522376ms","remote":"127.0.0.1:43934","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-09-11T17:25:40.456261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:39.93152Z","time spent":"523.72711ms","remote":"127.0.0.1:44028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T17:25:40.466002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.13068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2wpn4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-11T17:25:40.466132Z","caller":"traceutil/trace.go:171","msg":"trace[929425012] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2wpn4; range_end:; response_count:1; response_revision:644; }","duration":"278.316343ms","start":"2026-09-11T17:25:40.18778Z","end":"2026-09-11T17:25:40.466096Z","steps":["trace[929425012] 'agreement among raft nodes before linearized reading' (duration: 278.11392ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:40.466556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.080743ms","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-09-11T17:25:40.466694Z","caller":"traceutil/trace.go:171","msg":"trace[221572132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:644; }","duration":"122.242635ms","start":"2026-09-11T17:25:40.344399Z","end":"2026-09-11T17:25:40.466641Z","steps":["trace[221572132] 'agreement among raft nodes before linearized reading' (duration: 122.020182ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:40.583233Z","caller":"traceutil/trace.go:171","msg":"trace[1640770978] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"109.502466ms","start":"2026-09-11T17:25:40.473701Z","end":"2026-09-11T17:25:40.583203Z","steps":["trace[1640770978] 'process raft request' (duration: 89.478199ms)","trace[1640770978] 'compare' (duration: 19.912056ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:40.655244Z","caller":"traceutil/trace.go:171","msg":"trace[1506713460] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"180.608322ms","start":"2026-09-11T17:25:40.474586Z","end":"2026-09-11T17:25:40.655194Z","steps":["trace[1506713460] 'process raft request' (duration: 180.372698ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:40.655589Z","caller":"traceutil/trace.go:171","msg":"trace[424113551] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"153.770034ms","start":"2026-09-11T17:25:40.5018Z","end":"2026-09-11T17:25:40.65557Z","steps":["trace[424113551] 'process raft request' (duration: 153.313187ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:40.655698Z","caller":"traceutil/trace.go:171","msg":"trace[949550447] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"115.565705ms","start":"2026-09-11T17:25:40.540117Z","end":"2026-09-11T17:25:40.655682Z","steps":["trace[949550447] 'process raft request' (duration: 115.239691ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:41.580863Z","caller":"traceutil/trace.go:171","msg":"trace[409608504] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"250.194747ms","start":"2026-09-11T17:25:41.330642Z","end":"2026-09-11T17:25:41.580836Z","steps":["trace[409608504] 'read index received' (duration: 249.099079ms)","trace[409608504] 'applied index is now lower than readState.Index' (duration: 1.094428ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:41.581058Z","caller":"traceutil/trace.go:171","msg":"trace[1337114570] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"496.266546ms","start":"2026-09-11T17:25:41.084754Z","end":"2026-09-11T17:25:41.581021Z","steps":["trace[1337114570] 'process raft request' (duration: 495.391562ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:41.581173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.520931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-11T17:25:41.581191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:41.084733Z","time spent":"496.387749ms","remote":"127.0.0.1:44028","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-09-11T17:25:41.581228Z","caller":"traceutil/trace.go:171","msg":"trace[1666378160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"250.602352ms","start":"2026-09-11T17:25:41.330599Z","end":"2026-09-11T17:25:41.581201Z","steps":["trace[1666378160] 'agreement among raft nodes before linearized reading' (duration: 250.46774ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:41.607238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.108742ms","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-09-11T17:25:41.607296Z","caller":"traceutil/trace.go:171","msg":"trace[697386361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"260.310325ms","start":"2026-09-11T17:25:41.346972Z","end":"2026-09-11T17:25:41.607282Z","steps":["trace[697386361] 'agreement among raft nodes before linearized reading' (duration: 260.140912ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:58.9211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.996044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-11T17:25:58.921187Z","caller":"traceutil/trace.go:171","msg":"trace[1131083212] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"209.132297ms","start":"2026-09-11T17:25:58.712035Z","end":"2026-09-11T17:25:58.921168Z","steps":["trace[1131083212] 'range keys from in-memory index tree' (duration: 208.83647ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:58.921307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.594301ms","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-09-11T17:25:58.921385Z","caller":"traceutil/trace.go:171","msg":"trace[761876471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"189.707534ms","start":"2026-09-11T17:25:58.731659Z","end":"2026-09-11T17:25:58.921367Z","steps":["trace[761876471] 'range keys from in-memory index tree' (duration: 189.458287ms)"],"step_count":1}