{"level":"warn","ts":"2026-09-19T01:04:22.321177Z","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-19T01:04:22.321356Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.69: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.69:2380","--initial-cluster=instance=https://162.253.55.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.69: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-19T01:04:22.321488Z","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-19T01:04:22.321539Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-09-19T01:04:22.321567Z","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-19T01:04:22.32239Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"]} {"level":"info","ts":"2026-09-19T01:04:22.322513Z","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.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.69: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-19T01:04:22.326116Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.375509ms"} {"level":"info","ts":"2026-09-19T01:04:22.330643Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"905ccde8a677f143","cluster-id":"6fd07fe3af558460"} {"level":"info","ts":"2026-09-19T01:04:22.330717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T01:04:22.330742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 0"} {"level":"info","ts":"2026-09-19T01:04:22.330763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 905ccde8a677f143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T01:04:22.330776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 1"} {"level":"info","ts":"2026-09-19T01:04:22.330821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"warn","ts":"2026-09-19T01:04:22.33565Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T01:04:22.337Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T01:04:22.33863Z","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-19T01:04:22.34057Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"905ccde8a677f143","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T01:04:22.340806Z","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-19T01:04:22.340863Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"905ccde8a677f143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T01:04:22.340981Z","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-19T01:04:22.341001Z","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-19T01:04:22.342371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"info","ts":"2026-09-19T01:04:22.342483Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","added-peer-id":"905ccde8a677f143","added-peer-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-09-19T01:04:22.346972Z","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-19T01:04:22.347191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-09-19T01:04:22.347205Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-09-19T01:04:22.347376Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"905ccde8a677f143","initial-advertise-peer-urls":["https://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T01:04:22.347401Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T01:04:22.633661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T01:04:22.633745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T01:04:22.63379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgPreVoteResp from 905ccde8a677f143 at term 1"} {"level":"info","ts":"2026-09-19T01:04:22.633814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became candidate at term 2"} {"level":"info","ts":"2026-09-19T01:04:22.633832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgVoteResp from 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-09-19T01:04:22.633849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became leader at term 2"} {"level":"info","ts":"2026-09-19T01:04:22.633865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 905ccde8a677f143 elected leader 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-09-19T01:04:22.634947Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"905ccde8a677f143","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.69:2379]}","request-path":"/0/members/905ccde8a677f143/attributes","cluster-id":"6fd07fe3af558460","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T01:04:22.635048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:04:22.635071Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T01:04:22.635452Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:22.63577Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T01:04:22.6358Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T01:04:22.636788Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:22.637429Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:22.637478Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T01:04:22.63899Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T01:04:22.639633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.69:2379"} {"level":"info","ts":"2026-09-19T01:04:39.279229Z","caller":"traceutil/trace.go:171","msg":"trace[881939932] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"117.141322ms","start":"2026-09-19T01:04:39.162059Z","end":"2026-09-19T01:04:39.2792Z","steps":["trace[881939932] 'read index received' (duration: 116.933336ms)","trace[881939932] 'applied index is now lower than readState.Index' (duration: 206.676µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:04:39.279692Z","caller":"traceutil/trace.go:171","msg":"trace[56146723] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"193.137481ms","start":"2026-09-19T01:04:39.086535Z","end":"2026-09-19T01:04:39.279672Z","steps":["trace[56146723] 'process raft request' (duration: 192.486973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:04:39.280044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.970987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-19T01:04:39.280127Z","caller":"traceutil/trace.go:171","msg":"trace[1593034289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"118.115721ms","start":"2026-09-19T01:04:39.161993Z","end":"2026-09-19T01:04:39.280109Z","steps":["trace[1593034289] 'agreement among raft nodes before linearized reading' (duration: 117.965165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:04:39.86691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.226735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:04:39.867159Z","caller":"traceutil/trace.go:171","msg":"trace[1428648800] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:427; }","duration":"415.608803ms","start":"2026-09-19T01:04:39.451528Z","end":"2026-09-19T01:04:39.867137Z","steps":["trace[1428648800] 'read index received' (duration: 127.319686ms)","trace[1428648800] 'applied index is now lower than readState.Index' (duration: 288.287926ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:04:39.867319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.796728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-19T01:04:39.867354Z","caller":"traceutil/trace.go:171","msg":"trace[1562849852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:415; }","duration":"415.88844ms","start":"2026-09-19T01:04:39.451456Z","end":"2026-09-19T01:04:39.867344Z","steps":["trace[1562849852] 'agreement among raft nodes before linearized reading' (duration: 415.753787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:04:39.867387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:04:39.451428Z","time spent":"415.951242ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-19T01:04:39.867479Z","caller":"traceutil/trace.go:171","msg":"trace[66366416] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"581.460984ms","start":"2026-09-19T01:04:39.285983Z","end":"2026-09-19T01:04:39.867444Z","steps":["trace[66366416] 'process raft request' (duration: 581.059693ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:04:39.867574Z","caller":"traceutil/trace.go:171","msg":"trace[2017781604] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"582.35364ms","start":"2026-09-19T01:04:39.285132Z","end":"2026-09-19T01:04:39.867485Z","steps":["trace[2017781604] 'process raft request' (duration: 293.5751ms)","trace[2017781604] 'compare' (duration: 286.632299ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:04:39.867712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:04:39.28595Z","time spent":"581.615749ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:04:39.86843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:04:39.285104Z","time spent":"582.542446ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:05:03.901492Z","caller":"traceutil/trace.go:171","msg":"trace[1557991740] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"176.451438ms","start":"2026-09-19T01:05:03.725012Z","end":"2026-09-19T01:05:03.901464Z","steps":["trace[1557991740] 'process raft request' (duration: 176.202781ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908555Z","caller":"traceutil/trace.go:171","msg":"trace[127069082] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"178.685902ms","start":"2026-09-19T01:05:03.729836Z","end":"2026-09-19T01:05:03.908522Z","steps":["trace[127069082] 'process raft request' (duration: 178.491827ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908791Z","caller":"traceutil/trace.go:171","msg":"trace[596997084] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"167.083868ms","start":"2026-09-19T01:05:03.741673Z","end":"2026-09-19T01:05:03.908757Z","steps":["trace[596997084] 'process raft request' (duration: 166.84566ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908913Z","caller":"traceutil/trace.go:171","msg":"trace[2042777585] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"155.066869ms","start":"2026-09-19T01:05:03.753728Z","end":"2026-09-19T01:05:03.908795Z","steps":["trace[2042777585] 'process raft request' (duration: 154.823861ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908971Z","caller":"traceutil/trace.go:171","msg":"trace[773456592] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"152.117444ms","start":"2026-09-19T01:05:03.756775Z","end":"2026-09-19T01:05:03.908892Z","steps":["trace[773456592] 'process raft request' (duration: 151.847526ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.909Z","caller":"traceutil/trace.go:171","msg":"trace[1148371950] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"155.206963ms","start":"2026-09-19T01:05:03.753776Z","end":"2026-09-19T01:05:03.908983Z","steps":["trace[1148371950] 'process raft request' (duration: 154.811591ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.909004Z","caller":"traceutil/trace.go:171","msg":"trace[583523604] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"143.091842ms","start":"2026-09-19T01:05:03.765905Z","end":"2026-09-19T01:05:03.908997Z","steps":["trace[583523604] 'process raft request' (duration: 142.891946ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908979Z","caller":"traceutil/trace.go:171","msg":"trace[1278989660] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"151.338451ms","start":"2026-09-19T01:05:03.757633Z","end":"2026-09-19T01:05:03.908971Z","steps":["trace[1278989660] 'process raft request' (duration: 151.109075ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908927Z","caller":"traceutil/trace.go:171","msg":"trace[456288449] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"119.560982ms","start":"2026-09-19T01:05:03.789346Z","end":"2026-09-19T01:05:03.908907Z","steps":["trace[456288449] 'process raft request' (duration: 119.517841ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.908801Z","caller":"traceutil/trace.go:171","msg":"trace[1931845397] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"171.365282ms","start":"2026-09-19T01:05:03.7374Z","end":"2026-09-19T01:05:03.908766Z","steps":["trace[1931845397] 'process raft request' (duration: 171.015181ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:03.90886Z","caller":"traceutil/trace.go:171","msg":"trace[1679647456] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"169.866499ms","start":"2026-09-19T01:05:03.738983Z","end":"2026-09-19T01:05:03.90885Z","steps":["trace[1679647456] 'process raft request' (duration: 169.499567ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:04.584022Z","caller":"traceutil/trace.go:171","msg":"trace[1361061792] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"156.288435ms","start":"2026-09-19T01:05:04.427716Z","end":"2026-09-19T01:05:04.584004Z","steps":["trace[1361061792] 'process raft request' (duration: 74.015553ms)","trace[1361061792] 'compare' (duration: 82.072476ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:04.584213Z","caller":"traceutil/trace.go:171","msg":"trace[1489164077] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"123.612078ms","start":"2026-09-19T01:05:04.460578Z","end":"2026-09-19T01:05:04.58419Z","steps":["trace[1489164077] 'process raft request' (duration: 123.387552ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:10.351312Z","caller":"traceutil/trace.go:171","msg":"trace[1230163329] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"193.114897ms","start":"2026-09-19T01:05:10.158166Z","end":"2026-09-19T01:05:10.351281Z","steps":["trace[1230163329] 'process raft request' (duration: 139.126592ms)","trace[1230163329] 'compare' (duration: 53.857602ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:05:10.375687Z","caller":"traceutil/trace.go:171","msg":"trace[526770787] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"216.093803ms","start":"2026-09-19T01:05:10.159568Z","end":"2026-09-19T01:05:10.375662Z","steps":["trace[526770787] 'process raft request' (duration: 215.940698ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:10.376189Z","caller":"traceutil/trace.go:171","msg":"trace[2082190892] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"215.530327ms","start":"2026-09-19T01:05:10.160642Z","end":"2026-09-19T01:05:10.376172Z","steps":["trace[2082190892] 'process raft request' (duration: 214.97338ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:05:10.376315Z","caller":"traceutil/trace.go:171","msg":"trace[624587318] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"213.444137ms","start":"2026-09-19T01:05:10.162838Z","end":"2026-09-19T01:05:10.376282Z","steps":["trace[624587318] 'process raft request' (duration: 213.235151ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:05:10.996446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.042879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T01:05:10.996552Z","caller":"traceutil/trace.go:171","msg":"trace[734240872] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"670.069182ms","start":"2026-09-19T01:05:10.326465Z","end":"2026-09-19T01:05:10.996534Z","steps":["trace[734240872] 'process raft request' (duration: 194.867718ms)","trace[734240872] 'compare' (duration: 474.104892ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:05:10.996618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:05:10.326446Z","time spent":"670.144224ms","remote":"127.0.0.1:55388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T01:05:28.435126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.987472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:05:28.435219Z","caller":"traceutil/trace.go:171","msg":"trace[601820590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"175.152407ms","start":"2026-09-19T01:05:28.260045Z","end":"2026-09-19T01:05:28.435198Z","steps":["trace[601820590] 'range keys from in-memory index tree' (duration: 174.893319ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:10.852561Z","caller":"traceutil/trace.go:171","msg":"trace[1824376600] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"109.716101ms","start":"2026-09-19T01:06:10.742816Z","end":"2026-09-19T01:06:10.852532Z","steps":["trace[1824376600] 'read index received' (duration: 70.992998ms)","trace[1824376600] 'applied index is now lower than readState.Index' (duration: 38.721863ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:10.852712Z","caller":"traceutil/trace.go:171","msg":"trace[393758954] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"109.944017ms","start":"2026-09-19T01:06:10.742751Z","end":"2026-09-19T01:06:10.852695Z","steps":["trace[393758954] 'process raft request' (duration: 71.124542ms)","trace[393758954] 'compare' (duration: 38.533346ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:06:10.853039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.187174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-19T01:06:10.853149Z","caller":"traceutil/trace.go:171","msg":"trace[513855192] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1104; }","duration":"110.325808ms","start":"2026-09-19T01:06:10.74278Z","end":"2026-09-19T01:06:10.853105Z","steps":["trace[513855192] 'agreement among raft nodes before linearized reading' (duration: 110.067071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:10.853129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.548848ms","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-19T01:06:10.853276Z","caller":"traceutil/trace.go:171","msg":"trace[11730838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1104; }","duration":"106.767234ms","start":"2026-09-19T01:06:10.74649Z","end":"2026-09-19T01:06:10.853257Z","steps":["trace[11730838] 'agreement among raft nodes before linearized reading' (duration: 106.299621ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:30.995361Z","caller":"traceutil/trace.go:171","msg":"trace[153665249] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"163.296105ms","start":"2026-09-19T01:06:30.832042Z","end":"2026-09-19T01:06:30.995338Z","steps":["trace[153665249] 'read index received' (duration: 163.093619ms)","trace[153665249] 'applied index is now lower than readState.Index' (duration: 201.566µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T01:06:30.995399Z","caller":"traceutil/trace.go:171","msg":"trace[1223639777] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"176.720428ms","start":"2026-09-19T01:06:30.818661Z","end":"2026-09-19T01:06:30.995381Z","steps":["trace[1223639777] 'process raft request' (duration: 176.534353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:30.995518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.439099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:30.995564Z","caller":"traceutil/trace.go:171","msg":"trace[1922424797] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1196; }","duration":"163.533902ms","start":"2026-09-19T01:06:30.832009Z","end":"2026-09-19T01:06:30.995543Z","steps":["trace[1922424797] 'agreement among raft nodes before linearized reading' (duration: 163.445109ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:31.347013Z","caller":"traceutil/trace.go:171","msg":"trace[1784749472] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"347.562234ms","start":"2026-09-19T01:06:30.999418Z","end":"2026-09-19T01:06:31.34698Z","steps":["trace[1784749472] 'process raft request' (duration: 283.876407ms)","trace[1784749472] 'compare' (duration: 63.337877ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:06:31.347167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:30.999397Z","time spent":"347.683668ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:06:31.386515Z","caller":"traceutil/trace.go:171","msg":"trace[1481127428] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1239; }","duration":"127.789984ms","start":"2026-09-19T01:06:31.258695Z","end":"2026-09-19T01:06:31.386484Z","steps":["trace[1481127428] 'read index received' (duration: 24.753526ms)","trace[1481127428] 'applied index is now lower than readState.Index' (duration: 103.035658ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:06:31.386652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.943069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:31.386683Z","caller":"traceutil/trace.go:171","msg":"trace[1423152529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1201; }","duration":"128.023301ms","start":"2026-09-19T01:06:31.25865Z","end":"2026-09-19T01:06:31.386674Z","steps":["trace[1423152529] 'agreement among raft nodes before linearized reading' (duration: 127.934408ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:06:31.387089Z","caller":"traceutil/trace.go:171","msg":"trace[401153590] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"387.312549ms","start":"2026-09-19T01:06:30.999764Z","end":"2026-09-19T01:06:31.387077Z","steps":["trace[401153590] 'process raft request' (duration: 386.484415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:31.387215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:30.999752Z","time spent":"387.385172ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:06:31.387359Z","caller":"traceutil/trace.go:171","msg":"trace[772243061] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"387.024811ms","start":"2026-09-19T01:06:31.000325Z","end":"2026-09-19T01:06:31.38735Z","steps":["trace[772243061] 'process raft request' (duration: 386.034472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:31.387415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:31.00031Z","time spent":"387.077233ms","remote":"127.0.0.1:55554","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-09-19T01:06:31.387533Z","caller":"traceutil/trace.go:171","msg":"trace[2074981034] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"387.164955ms","start":"2026-09-19T01:06:31.000358Z","end":"2026-09-19T01:06:31.387523Z","steps":["trace[2074981034] 'process raft request' (duration: 386.036282ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:31.387592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:31.000345Z","time spent":"387.215417ms","remote":"127.0.0.1:55554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:06:31.387841Z","caller":"traceutil/trace.go:171","msg":"trace[1253459501] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"306.879503ms","start":"2026-09-19T01:06:31.080948Z","end":"2026-09-19T01:06:31.387827Z","steps":["trace[1253459501] 'process raft request' (duration: 305.485512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:31.387923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T01:06:31.080918Z","time spent":"306.963904ms","remote":"127.0.0.1:55468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T01:06:31.89268Z","caller":"traceutil/trace.go:171","msg":"trace[55037169] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"146.332069ms","start":"2026-09-19T01:06:31.746325Z","end":"2026-09-19T01:06:31.892657Z","steps":["trace[55037169] 'process raft request' (duration: 146.195135ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:32.358017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.851308ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-19T01:06:32.813645Z","caller":"traceutil/trace.go:171","msg":"trace[1480204645] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"126.103925ms","start":"2026-09-19T01:06:32.687517Z","end":"2026-09-19T01:06:32.813621Z","steps":["trace[1480204645] 'process raft request' (duration: 125.897649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T01:06:42.482271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.902205ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-19T01:06:42.482374Z","caller":"traceutil/trace.go:171","msg":"trace[319444614] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"153.955671ms","start":"2026-09-19T01:06:42.328401Z","end":"2026-09-19T01:06:42.482357Z","steps":["trace[319444614] 'read index received' (duration: 74.582µs)","trace[319444614] 'applied index is now lower than readState.Index' (duration: 153.879349ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:06:42.482441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.039424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T01:06:42.48247Z","caller":"traceutil/trace.go:171","msg":"trace[573640429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"154.114236ms","start":"2026-09-19T01:06:42.328348Z","end":"2026-09-19T01:06:42.482462Z","steps":["trace[573640429] 'agreement among raft nodes before linearized reading' (duration: 154.053144ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:11:19.134244Z","caller":"traceutil/trace.go:171","msg":"trace[1569103550] linearizableReadLoop","detail":"{readStateIndex:2672; appliedIndex:2671; }","duration":"142.019729ms","start":"2026-09-19T01:11:18.992195Z","end":"2026-09-19T01:11:19.134214Z","steps":["trace[1569103550] 'read index received' (duration: 51.969959ms)","trace[1569103550] 'applied index is now lower than readState.Index' (duration: 90.04844ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T01:11:19.13452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.306037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-19T01:11:19.134595Z","caller":"traceutil/trace.go:171","msg":"trace[717567811] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2570; }","duration":"142.42231ms","start":"2026-09-19T01:11:18.992141Z","end":"2026-09-19T01:11:19.134563Z","steps":["trace[717567811] 'agreement among raft nodes before linearized reading' (duration: 142.219245ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:11:19.134559Z","caller":"traceutil/trace.go:171","msg":"trace[2058392746] transaction","detail":"{read_only:false; response_revision:2571; number_of_response:1; }","duration":"130.879942ms","start":"2026-09-19T01:11:19.003637Z","end":"2026-09-19T01:11:19.134517Z","steps":["trace[2058392746] 'process raft request' (duration: 130.629285ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T01:11:19.135311Z","caller":"traceutil/trace.go:171","msg":"trace[573516987] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"185.167288ms","start":"2026-09-19T01:11:18.950046Z","end":"2026-09-19T01:11:19.135213Z","steps":["trace[573516987] 'process raft request' (duration: 93.957605ms)","trace[573516987] 'compare' (duration: 90.060219ms)"],"step_count":2}