{"level":"warn","ts":"2026-09-18T01:22:21.211238Z","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-18T01:22:21.211352Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.135: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.135:2380","--initial-cluster=instance=https://162.253.55.135:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.135:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.135: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-18T01:22:21.211434Z","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-18T01:22:21.21162Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.135:2380"]} {"level":"info","ts":"2026-09-18T01:22:21.211733Z","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-18T01:22:21.215196Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"]} {"level":"info","ts":"2026-09-18T01:22:21.215389Z","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.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.135: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-18T01:22:21.222052Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.199562ms"} {"level":"info","ts":"2026-09-18T01:22:21.506004Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36725369a67988c9","cluster-id":"458f7f83a0fed211"} {"level":"info","ts":"2026-09-18T01:22:21.506205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T01:22:21.506291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 0"} {"level":"info","ts":"2026-09-18T01:22:21.506339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36725369a67988c9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T01:22:21.506366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 1"} {"level":"info","ts":"2026-09-18T01:22:21.506525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"} {"level":"warn","ts":"2026-09-18T01:22:21.538236Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T01:22:21.545145Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T01:22:21.554009Z","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-18T01:22:21.561149Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36725369a67988c9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T01:22:21.565235Z","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-18T01:22:21.565347Z","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-18T01:22:21.565364Z","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-18T01:22:21.56551Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36725369a67988c9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T01:22:21.568725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"} {"level":"info","ts":"2026-09-18T01:22:21.568904Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","added-peer-id":"36725369a67988c9","added-peer-peer-urls":["https://162.253.55.135:2380"]} {"level":"info","ts":"2026-09-18T01:22:21.570076Z","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-18T01:22:21.570206Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.135:2380"} {"level":"info","ts":"2026-09-18T01:22:21.570239Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.135:2380"} {"level":"info","ts":"2026-09-18T01:22:21.570366Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36725369a67988c9","initial-advertise-peer-urls":["https://162.253.55.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T01:22:21.57043Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T01:22:21.608096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T01:22:21.608174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T01:22:21.608202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgPreVoteResp from 36725369a67988c9 at term 1"} {"level":"info","ts":"2026-09-18T01:22:21.608222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became candidate at term 2"} {"level":"info","ts":"2026-09-18T01:22:21.608237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgVoteResp from 36725369a67988c9 at term 2"} {"level":"info","ts":"2026-09-18T01:22:21.608256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became leader at term 2"} {"level":"info","ts":"2026-09-18T01:22:21.608273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36725369a67988c9 elected leader 36725369a67988c9 at term 2"} {"level":"info","ts":"2026-09-18T01:22:21.609498Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:22:21.611515Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36725369a67988c9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.135:2379]}","request-path":"/0/members/36725369a67988c9/attributes","cluster-id":"458f7f83a0fed211","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T01:22:21.611644Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:22:21.611775Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T01:22:21.611668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T01:22:21.611804Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T01:22:21.612914Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:22:21.613024Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:22:21.613054Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T01:22:21.613926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T01:22:21.615788Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.135:2379"} {"level":"info","ts":"2026-09-18T01:22:29.927366Z","caller":"traceutil/trace.go:171","msg":"trace[2122583853] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"133.522349ms","start":"2026-09-18T01:22:29.793806Z","end":"2026-09-18T01:22:29.927328Z","steps":["trace[2122583853] 'process raft request' (duration: 133.269058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.299295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.233688ms","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-18T01:22:30.299458Z","caller":"traceutil/trace.go:171","msg":"trace[2035110328] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:334; }","duration":"283.471728ms","start":"2026-09-18T01:22:30.015972Z","end":"2026-09-18T01:22:30.299443Z","steps":["trace[2035110328] 'range keys from in-memory index tree' (duration: 283.132178ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.299295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.391476ms","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-18T01:22:30.299678Z","caller":"traceutil/trace.go:171","msg":"trace[679235265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:334; }","duration":"250.835856ms","start":"2026-09-18T01:22:30.04882Z","end":"2026-09-18T01:22:30.299656Z","steps":["trace[679235265] 'range keys from in-memory index tree' (duration: 250.235586ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.299308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.11729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:22:30.299879Z","caller":"traceutil/trace.go:171","msg":"trace[1911363690] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:334; }","duration":"365.774501ms","start":"2026-09-18T01:22:29.934054Z","end":"2026-09-18T01:22:30.299829Z","steps":["trace[1911363690] 'range keys from in-memory index tree' (duration: 365.01569ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.30002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:22:29.934027Z","time spent":"365.888451ms","remote":"127.0.0.1:38716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"info","ts":"2026-09-18T01:22:30.67634Z","caller":"traceutil/trace.go:171","msg":"trace[1486658897] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"372.546774ms","start":"2026-09-18T01:22:30.303771Z","end":"2026-09-18T01:22:30.676318Z","steps":["trace[1486658897] 'process raft request' (duration: 372.420374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.677098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:22:30.303731Z","time spent":"372.673584ms","remote":"127.0.0.1:38772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:22:30.686885Z","caller":"traceutil/trace.go:171","msg":"trace[1515007555] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"380.778819ms","start":"2026-09-18T01:22:30.306074Z","end":"2026-09-18T01:22:30.686853Z","steps":["trace[1515007555] 'process raft request' (duration: 380.717949ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.687001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:22:30.306061Z","time spent":"380.886849ms","remote":"127.0.0.1:38772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T01:22:30.686901Z","caller":"traceutil/trace.go:171","msg":"trace[1844921912] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"381.06894ms","start":"2026-09-18T01:22:30.305811Z","end":"2026-09-18T01:22:30.68688Z","steps":["trace[1844921912] 'process raft request' (duration: 380.854619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:30.687342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:22:30.305791Z","time spent":"381.481081ms","remote":"127.0.0.1:38716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T01:22:31.080623Z","caller":"traceutil/trace.go:171","msg":"trace[213275636] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"117.884899ms","start":"2026-09-18T01:22:30.962715Z","end":"2026-09-18T01:22:31.0806Z","steps":["trace[213275636] 'process raft request' (duration: 111.859748ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:22:50.979845Z","caller":"traceutil/trace.go:171","msg":"trace[1127524854] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"104.467032ms","start":"2026-09-18T01:22:50.875341Z","end":"2026-09-18T01:22:50.979808Z","steps":["trace[1127524854] 'process raft request' (duration: 43.806521ms)","trace[1127524854] 'compare' (duration: 60.382541ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:22:50.979921Z","caller":"traceutil/trace.go:171","msg":"trace[1310067126] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:484; }","duration":"100.018064ms","start":"2026-09-18T01:22:50.879877Z","end":"2026-09-18T01:22:50.979895Z","steps":["trace[1310067126] 'read index received' (duration: 3.461306ms)","trace[1310067126] 'applied index is now lower than readState.Index' (duration: 96.555558ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:22:50.98024Z","caller":"traceutil/trace.go:171","msg":"trace[652148177] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"103.98242ms","start":"2026-09-18T01:22:50.876247Z","end":"2026-09-18T01:22:50.980229Z","steps":["trace[652148177] 'process raft request' (duration: 103.469269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:22:50.980385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.512234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-09-18T01:22:50.980434Z","caller":"traceutil/trace.go:171","msg":"trace[457421329] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:470; }","duration":"100.607904ms","start":"2026-09-18T01:22:50.879812Z","end":"2026-09-18T01:22:50.98042Z","steps":["trace[457421329] 'agreement among raft nodes before linearized reading' (duration: 100.490764ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:22:50.980691Z","caller":"traceutil/trace.go:171","msg":"trace[325420215] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"102.551379ms","start":"2026-09-18T01:22:50.878129Z","end":"2026-09-18T01:22:50.98068Z","steps":["trace[325420215] 'process raft request' (duration: 101.653177ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:22:50.980798Z","caller":"traceutil/trace.go:171","msg":"trace[1133216401] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"101.783376ms","start":"2026-09-18T01:22:50.879004Z","end":"2026-09-18T01:22:50.980787Z","steps":["trace[1133216401] 'process raft request' (duration: 100.840184ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:22:51.190239Z","caller":"traceutil/trace.go:171","msg":"trace[648686312] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"198.867844ms","start":"2026-09-18T01:22:50.991344Z","end":"2026-09-18T01:22:51.190212Z","steps":["trace[648686312] 'process raft request' (duration: 158.58277ms)","trace[648686312] 'compare' (duration: 40.157024ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:23:05.739029Z","caller":"traceutil/trace.go:171","msg":"trace[1122535204] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"163.234696ms","start":"2026-09-18T01:23:05.575746Z","end":"2026-09-18T01:23:05.738981Z","steps":["trace[1122535204] 'process raft request' (duration: 162.728816ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:05.754624Z","caller":"traceutil/trace.go:171","msg":"trace[1278179963] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"113.500887ms","start":"2026-09-18T01:23:05.641103Z","end":"2026-09-18T01:23:05.754604Z","steps":["trace[1278179963] 'process raft request' (duration: 113.104467ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:05.75509Z","caller":"traceutil/trace.go:171","msg":"trace[2061395681] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"113.487706ms","start":"2026-09-18T01:23:05.641584Z","end":"2026-09-18T01:23:05.755072Z","steps":["trace[2061395681] 'process raft request' (duration: 112.794645ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.155281Z","caller":"traceutil/trace.go:171","msg":"trace[1361645599] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"140.112234ms","start":"2026-09-18T01:23:06.015141Z","end":"2026-09-18T01:23:06.155253Z","steps":["trace[1361645599] 'process raft request' (duration: 108.176126ms)","trace[1361645599] 'compare' (duration: 31.820728ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:23:06.155717Z","caller":"traceutil/trace.go:171","msg":"trace[61054903] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"129.420095ms","start":"2026-09-18T01:23:06.026275Z","end":"2026-09-18T01:23:06.155695Z","steps":["trace[61054903] 'process raft request' (duration: 129.280065ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.156002Z","caller":"traceutil/trace.go:171","msg":"trace[1691482208] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"104.392099ms","start":"2026-09-18T01:23:06.051553Z","end":"2026-09-18T01:23:06.155945Z","steps":["trace[1691482208] 'process raft request' (duration: 104.111319ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.425207Z","caller":"traceutil/trace.go:171","msg":"trace[481211879] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"142.069377ms","start":"2026-09-18T01:23:06.283111Z","end":"2026-09-18T01:23:06.425181Z","steps":["trace[481211879] 'process raft request' (duration: 141.905156ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.469738Z","caller":"traceutil/trace.go:171","msg":"trace[974670949] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"183.308193ms","start":"2026-09-18T01:23:06.286387Z","end":"2026-09-18T01:23:06.469695Z","steps":["trace[974670949] 'process raft request' (duration: 183.045242ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.469961Z","caller":"traceutil/trace.go:171","msg":"trace[1805021735] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"172.060612ms","start":"2026-09-18T01:23:06.297861Z","end":"2026-09-18T01:23:06.469922Z","steps":["trace[1805021735] 'process raft request' (duration: 171.743142ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:06.595966Z","caller":"traceutil/trace.go:171","msg":"trace[446204307] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"108.714688ms","start":"2026-09-18T01:23:06.487223Z","end":"2026-09-18T01:23:06.595938Z","steps":["trace[446204307] 'process raft request' (duration: 61.772203ms)","trace[446204307] 'compare' (duration: 46.772805ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:23:06.742591Z","caller":"traceutil/trace.go:171","msg":"trace[1249996] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"117.072223ms","start":"2026-09-18T01:23:06.625475Z","end":"2026-09-18T01:23:06.742547Z","steps":["trace[1249996] 'process raft request' (duration: 72.647012ms)","trace[1249996] 'compare' (duration: 39.432862ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:23:14.189979Z","caller":"traceutil/trace.go:171","msg":"trace[1491949487] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"200.838945ms","start":"2026-09-18T01:23:13.98911Z","end":"2026-09-18T01:23:14.189949Z","steps":["trace[1491949487] 'process raft request' (duration: 200.590294ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:14.54932Z","caller":"traceutil/trace.go:171","msg":"trace[1658815949] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"341.997979ms","start":"2026-09-18T01:23:14.207285Z","end":"2026-09-18T01:23:14.549283Z","steps":["trace[1658815949] 'process raft request' (duration: 341.705469ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:14.549475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:23:14.207264Z","time spent":"342.140829ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T01:23:15.045378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.577541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wp747\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-18T01:23:15.045399Z","caller":"traceutil/trace.go:171","msg":"trace[2015765955] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"247.513408ms","start":"2026-09-18T01:23:14.797854Z","end":"2026-09-18T01:23:15.045368Z","steps":["trace[2015765955] 'process raft request' (duration: 237.57685ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:15.045472Z","caller":"traceutil/trace.go:171","msg":"trace[104000552] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wp747; range_end:; response_count:1; response_revision:660; }","duration":"309.718971ms","start":"2026-09-18T01:23:14.735729Z","end":"2026-09-18T01:23:15.045448Z","steps":["trace[104000552] 'range keys from in-memory index tree' (duration: 309.411221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:15.045518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T01:23:14.735696Z","time spent":"309.813321ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-wp747\" "} {"level":"info","ts":"2026-09-18T01:23:15.256002Z","caller":"traceutil/trace.go:171","msg":"trace[2072375213] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"166.718952ms","start":"2026-09-18T01:23:15.089249Z","end":"2026-09-18T01:23:15.255968Z","steps":["trace[2072375213] 'read index received' (duration: 166.37668ms)","trace[2072375213] 'applied index is now lower than readState.Index' (duration: 340.962µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T01:23:15.256206Z","caller":"traceutil/trace.go:171","msg":"trace[956089655] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"189.727794ms","start":"2026-09-18T01:23:15.066397Z","end":"2026-09-18T01:23:15.256125Z","steps":["trace[956089655] 'process raft request' (duration: 189.358434ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:15.256365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.069562ms","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-18T01:23:15.256418Z","caller":"traceutil/trace.go:171","msg":"trace[506493155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:662; }","duration":"167.191533ms","start":"2026-09-18T01:23:15.089211Z","end":"2026-09-18T01:23:15.256403Z","steps":["trace[506493155] 'agreement among raft nodes before linearized reading' (duration: 166.928022ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:15.256409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.986668ms","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-18T01:23:15.256495Z","caller":"traceutil/trace.go:171","msg":"trace[104588668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:662; }","duration":"137.149899ms","start":"2026-09-18T01:23:15.119321Z","end":"2026-09-18T01:23:15.25647Z","steps":["trace[104588668] 'agreement among raft nodes before linearized reading' (duration: 136.873358ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:59.748348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.897775ms","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-18T01:23:59.748478Z","caller":"traceutil/trace.go:171","msg":"trace[866722523] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:903; }","duration":"231.111106ms","start":"2026-09-18T01:23:59.517342Z","end":"2026-09-18T01:23:59.748453Z","steps":["trace[866722523] 'range keys from in-memory index tree' (duration: 230.621505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T01:23:59.748463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.15867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-18T01:23:59.748452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.094102ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T01:23:59.748549Z","caller":"traceutil/trace.go:171","msg":"trace[25838854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:903; }","duration":"211.2972ms","start":"2026-09-18T01:23:59.53723Z","end":"2026-09-18T01:23:59.748527Z","steps":["trace[25838854] 'range keys from in-memory index tree' (duration: 211.001749ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:23:59.748581Z","caller":"traceutil/trace.go:171","msg":"trace[1959662009] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:903; }","duration":"318.241552ms","start":"2026-09-18T01:23:59.43032Z","end":"2026-09-18T01:23:59.748561Z","steps":["trace[1959662009] 'range keys from in-memory index tree' (duration: 318.077531ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T01:25:40.493712Z","caller":"traceutil/trace.go:171","msg":"trace[740253419] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"104.819169ms","start":"2026-09-18T01:25:40.388847Z","end":"2026-09-18T01:25:40.493666Z","steps":["trace[740253419] 'process raft request' (duration: 104.557149ms)"],"step_count":1}