{"level":"warn","ts":"2026-09-29T15:36:32.684067Z","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-29T15:36:32.684205Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.104: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.104:2380","--initial-cluster=instance=https://162.253.55.104:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.104:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.104: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-29T15:36:32.684282Z","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-29T15:36:32.684297Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-09-29T15:36:32.684316Z","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-29T15:36:32.685102Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"]} {"level":"info","ts":"2026-09-29T15:36:32.685191Z","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.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.104: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-29T15:36:32.689969Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.474416ms"} {"level":"info","ts":"2026-09-29T15:36:32.701487Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8572cc3a5351216d","cluster-id":"c1a156b8f69e6a79"} {"level":"info","ts":"2026-09-29T15:36:32.701556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T15:36:32.701573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 0"} {"level":"info","ts":"2026-09-29T15:36:32.701588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8572cc3a5351216d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T15:36:32.701595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 1"} {"level":"info","ts":"2026-09-29T15:36:32.701643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"warn","ts":"2026-09-29T15:36:32.708911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T15:36:32.710344Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T15:36:32.71163Z","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-29T15:36:32.717627Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8572cc3a5351216d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T15:36:32.718283Z","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-29T15:36:32.71844Z","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-29T15:36:32.718451Z","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-29T15:36:32.71874Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8572cc3a5351216d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T15:36:32.725105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"info","ts":"2026-09-29T15:36:32.72529Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","added-peer-id":"8572cc3a5351216d","added-peer-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-09-29T15:36:32.725617Z","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-29T15:36:32.726177Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8572cc3a5351216d","initial-advertise-peer-urls":["https://162.253.55.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T15:36:32.726239Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T15:36:32.726201Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-09-29T15:36:32.72627Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-09-29T15:36:33.002654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T15:36:33.002764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T15:36:33.002796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgPreVoteResp from 8572cc3a5351216d at term 1"} {"level":"info","ts":"2026-09-29T15:36:33.002828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became candidate at term 2"} {"level":"info","ts":"2026-09-29T15:36:33.002847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgVoteResp from 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-09-29T15:36:33.002867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became leader at term 2"} {"level":"info","ts":"2026-09-29T15:36:33.002889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8572cc3a5351216d elected leader 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-09-29T15:36:33.004008Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:33.004985Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:36:33.004989Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8572cc3a5351216d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.104:2379]}","request-path":"/0/members/8572cc3a5351216d/attributes","cluster-id":"c1a156b8f69e6a79","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T15:36:33.005428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:36:33.006087Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:33.00635Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:33.006459Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:33.008087Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-29T15:36:33.018033Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T15:36:33.018069Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T15:36:33.023301Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.104:2379"} {"level":"info","ts":"2026-09-29T15:36:35.772072Z","caller":"traceutil/trace.go:171","msg":"trace[590031946] linearizableReadLoop","detail":"{readStateIndex:121; appliedIndex:120; }","duration":"103.276669ms","start":"2026-09-29T15:36:35.668765Z","end":"2026-09-29T15:36:35.772042Z","steps":["trace[590031946] 'read index received' (duration: 102.985452ms)","trace[590031946] 'applied index is now lower than readState.Index' (duration: 289.757µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:36:35.772118Z","caller":"traceutil/trace.go:171","msg":"trace[121578550] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"104.453646ms","start":"2026-09-29T15:36:35.667636Z","end":"2026-09-29T15:36:35.772089Z","steps":["trace[121578550] 'process raft request' (duration: 104.230411ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:35.772329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.538885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T15:36:35.772433Z","caller":"traceutil/trace.go:171","msg":"trace[391946792] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:116; }","duration":"103.698669ms","start":"2026-09-29T15:36:35.668715Z","end":"2026-09-29T15:36:35.772414Z","steps":["trace[391946792] 'agreement among raft nodes before linearized reading' (duration: 103.456053ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:36.089081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.318738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-29T15:36:36.089192Z","caller":"traceutil/trace.go:171","msg":"trace[16132952] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"308.500553ms","start":"2026-09-29T15:36:35.780669Z","end":"2026-09-29T15:36:36.08917Z","steps":["trace[16132952] 'read index received' (duration: 172.582951ms)","trace[16132952] 'applied index is now lower than readState.Index' (duration: 135.916002ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:36:36.089322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.644936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T15:36:36.089364Z","caller":"traceutil/trace.go:171","msg":"trace[2135648221] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:117; }","duration":"308.711378ms","start":"2026-09-29T15:36:35.780643Z","end":"2026-09-29T15:36:36.089355Z","steps":["trace[2135648221] 'agreement among raft nodes before linearized reading' (duration: 308.583895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:36.089399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:36:35.780632Z","time spent":"308.759069ms","remote":"127.0.0.1:50998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"info","ts":"2026-09-29T15:36:36.089545Z","caller":"traceutil/trace.go:171","msg":"trace[548169902] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"311.114775ms","start":"2026-09-29T15:36:35.778165Z","end":"2026-09-29T15:36:36.08928Z","steps":["trace[548169902] 'process raft request' (duration: 175.011438ms)","trace[548169902] 'compare' (duration: 135.195295ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:36:36.089748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:36:35.778121Z","time spent":"311.536985ms","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T15:36:36.179482Z","caller":"traceutil/trace.go:171","msg":"trace[1337943875] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"386.42466ms","start":"2026-09-29T15:36:35.793032Z","end":"2026-09-29T15:36:36.179457Z","steps":["trace[1337943875] 'process raft request' (duration: 386.160654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:36.179617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:36:35.793013Z","time spent":"386.548813ms","remote":"127.0.0.1:50858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T15:37:11.689805Z","caller":"traceutil/trace.go:171","msg":"trace[1509142118] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"132.435774ms","start":"2026-09-29T15:37:11.55734Z","end":"2026-09-29T15:37:11.689776Z","steps":["trace[1509142118] 'process raft request' (duration: 49.102398ms)","trace[1509142118] 'compare' (duration: 82.911686ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:11.691642Z","caller":"traceutil/trace.go:171","msg":"trace[43000190] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"102.789144ms","start":"2026-09-29T15:37:11.588821Z","end":"2026-09-29T15:37:11.69161Z","steps":["trace[43000190] 'process raft request' (duration: 101.945254ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:11.847274Z","caller":"traceutil/trace.go:171","msg":"trace[1295489227] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"140.560675ms","start":"2026-09-29T15:37:11.70669Z","end":"2026-09-29T15:37:11.847251Z","steps":["trace[1295489227] 'process raft request' (duration: 140.497823ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:11.847274Z","caller":"traceutil/trace.go:171","msg":"trace[1050888391] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"142.88315ms","start":"2026-09-29T15:37:11.704354Z","end":"2026-09-29T15:37:11.847237Z","steps":["trace[1050888391] 'process raft request' (duration: 123.365759ms)","trace[1050888391] 'compare' (duration: 19.325076ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:11.847857Z","caller":"traceutil/trace.go:171","msg":"trace[1711565107] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"128.207024ms","start":"2026-09-29T15:37:11.719632Z","end":"2026-09-29T15:37:11.847839Z","steps":["trace[1711565107] 'process raft request' (duration: 128.04708ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:11.848158Z","caller":"traceutil/trace.go:171","msg":"trace[1731583182] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"125.233853ms","start":"2026-09-29T15:37:11.722916Z","end":"2026-09-29T15:37:11.84815Z","steps":["trace[1731583182] 'process raft request' (duration: 124.886985ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:11.848263Z","caller":"traceutil/trace.go:171","msg":"trace[1461185497] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"119.383305ms","start":"2026-09-29T15:37:11.728851Z","end":"2026-09-29T15:37:11.848234Z","steps":["trace[1461185497] 'process raft request' (duration: 119.140409ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:11.848588Z","caller":"traceutil/trace.go:171","msg":"trace[1211668867] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"108.583161ms","start":"2026-09-29T15:37:11.739987Z","end":"2026-09-29T15:37:11.848571Z","steps":["trace[1211668867] 'process raft request' (duration: 108.179332ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:18.196227Z","caller":"traceutil/trace.go:171","msg":"trace[1341953002] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"101.459153ms","start":"2026-09-29T15:37:18.094737Z","end":"2026-09-29T15:37:18.196196Z","steps":["trace[1341953002] 'read index received' (duration: 79.775582ms)","trace[1341953002] 'applied index is now lower than readState.Index' (duration: 21.681981ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:18.19645Z","caller":"traceutil/trace.go:171","msg":"trace[1106081648] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"210.701459ms","start":"2026-09-29T15:37:17.985707Z","end":"2026-09-29T15:37:18.196408Z","steps":["trace[1106081648] 'process raft request' (duration: 189.379686ms)","trace[1106081648] 'compare' (duration: 20.012162ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:18.196513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.76185ms","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-29T15:37:18.196584Z","caller":"traceutil/trace.go:171","msg":"trace[2117408693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"101.855612ms","start":"2026-09-29T15:37:18.094715Z","end":"2026-09-29T15:37:18.196571Z","steps":["trace[2117408693] 'agreement among raft nodes before linearized reading' (duration: 101.689258ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:18.8384Z","caller":"traceutil/trace.go:171","msg":"trace[1563288366] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"575.016732ms","start":"2026-09-29T15:37:18.263356Z","end":"2026-09-29T15:37:18.838372Z","steps":["trace[1563288366] 'process raft request' (duration: 563.699775ms)","trace[1563288366] 'compare' (duration: 10.055858ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:18.838714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:18.263324Z","time spent":"575.145505ms","remote":"127.0.0.1:50858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:37:18.838795Z","caller":"traceutil/trace.go:171","msg":"trace[407295681] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"540.008597ms","start":"2026-09-29T15:37:18.298732Z","end":"2026-09-29T15:37:18.838741Z","steps":["trace[407295681] 'process raft request' (duration: 539.508395ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:18.838954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:18.298726Z","time spent":"540.164101ms","remote":"127.0.0.1:50868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T15:37:20.542834Z","caller":"traceutil/trace.go:171","msg":"trace[2071138077] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"101.597387ms","start":"2026-09-29T15:37:20.441212Z","end":"2026-09-29T15:37:20.542809Z","steps":["trace[2071138077] 'process raft request' (duration: 99.839405ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:36.515466Z","caller":"traceutil/trace.go:171","msg":"trace[1079017371] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"166.727322ms","start":"2026-09-29T15:37:36.348713Z","end":"2026-09-29T15:37:36.51544Z","steps":["trace[1079017371] 'read index received' (duration: 150.858448ms)","trace[1079017371] 'applied index is now lower than readState.Index' (duration: 15.867724ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:36.515639Z","caller":"traceutil/trace.go:171","msg":"trace[1525361275] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"219.160769ms","start":"2026-09-29T15:37:36.296368Z","end":"2026-09-29T15:37:36.515529Z","steps":["trace[1525361275] 'process raft request' (duration: 203.238494ms)","trace[1525361275] 'compare' (duration: 15.712ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:36.515684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.944247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vqmd7\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-29T15:37:36.516425Z","caller":"traceutil/trace.go:171","msg":"trace[1807673072] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vqmd7; range_end:; response_count:1; response_revision:809; }","duration":"167.721166ms","start":"2026-09-29T15:37:36.348684Z","end":"2026-09-29T15:37:36.516406Z","steps":["trace[1807673072] 'agreement among raft nodes before linearized reading' (duration: 166.870706ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:36.708185Z","caller":"traceutil/trace.go:171","msg":"trace[470763193] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"183.863406ms","start":"2026-09-29T15:37:36.52429Z","end":"2026-09-29T15:37:36.708153Z","steps":["trace[470763193] 'process raft request' (duration: 183.60714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:32.09754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.041538ms","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-29T15:38:32.097665Z","caller":"traceutil/trace.go:171","msg":"trace[921393719] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1139; }","duration":"375.174721ms","start":"2026-09-29T15:38:31.722469Z","end":"2026-09-29T15:38:32.097643Z","steps":["trace[921393719] 'range keys from in-memory index tree' (duration: 375.024577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:32.097909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.06945ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:38:32.098052Z","caller":"traceutil/trace.go:171","msg":"trace[1595478042] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"469.065859ms","start":"2026-09-29T15:38:31.628971Z","end":"2026-09-29T15:38:32.098037Z","steps":["trace[1595478042] 'process raft request' (duration: 469.019118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:32.098108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:38:31.628946Z","time spent":"469.13544ms","remote":"127.0.0.1:50930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:38:32.098221Z","caller":"traceutil/trace.go:171","msg":"trace[1938848894] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"521.263877ms","start":"2026-09-29T15:38:31.576936Z","end":"2026-09-29T15:38:32.0982Z","steps":["trace[1938848894] 'process raft request' (duration: 330.833759ms)","trace[1938848894] 'compare' (duration: 189.952947ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:38:32.098316Z","caller":"traceutil/trace.go:171","msg":"trace[1174581362] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"471.038695ms","start":"2026-09-29T15:38:31.627268Z","end":"2026-09-29T15:38:32.098306Z","steps":["trace[1174581362] 'read index received' (duration: 280.513625ms)","trace[1174581362] 'applied index is now lower than readState.Index' (duration: 190.52412ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:38:32.098377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:38:31.57691Z","time spent":"521.37496ms","remote":"127.0.0.1:50930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T15:38:32.098462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.193839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-29T15:38:32.0985Z","caller":"traceutil/trace.go:171","msg":"trace[715419467] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1141; }","duration":"471.272911ms","start":"2026-09-29T15:38:31.627219Z","end":"2026-09-29T15:38:32.098492Z","steps":["trace[715419467] 'agreement among raft nodes before linearized reading' (duration: 471.183709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:32.098527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:38:31.6272Z","time spent":"471.319173ms","remote":"127.0.0.1:51104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-09-29T15:38:32.098677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.030063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:38:32.098738Z","caller":"traceutil/trace.go:171","msg":"trace[282513383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1141; }","duration":"347.141626ms","start":"2026-09-29T15:38:31.751577Z","end":"2026-09-29T15:38:32.098718Z","steps":["trace[282513383] 'agreement among raft nodes before linearized reading' (duration: 347.034544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:38:32.098764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:38:31.751553Z","time spent":"347.206327ms","remote":"127.0.0.1:50672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-29T15:38:48.601105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.990625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:38:48.60125Z","caller":"traceutil/trace.go:171","msg":"trace[1264715049] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"224.877526ms","start":"2026-09-29T15:38:48.376357Z","end":"2026-09-29T15:38:48.601234Z","steps":["trace[1264715049] 'read index received' (duration: 83.618804ms)","trace[1264715049] 'applied index is now lower than readState.Index' (duration: 141.257202ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:38:48.601344Z","caller":"traceutil/trace.go:171","msg":"trace[1974910851] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"241.858829ms","start":"2026-09-29T15:38:48.359463Z","end":"2026-09-29T15:38:48.601322Z","steps":["trace[1974910851] 'process raft request' (duration: 100.543946ms)","trace[1974910851] 'compare' (duration: 140.835572ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:38:48.601492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.101041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-29T15:38:48.601524Z","caller":"traceutil/trace.go:171","msg":"trace[1310925889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1214; }","duration":"225.172953ms","start":"2026-09-29T15:38:48.37634Z","end":"2026-09-29T15:38:48.601513Z","steps":["trace[1310925889] 'agreement among raft nodes before linearized reading' (duration: 224.999439ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:48.794799Z","caller":"traceutil/trace.go:171","msg":"trace[2053833497] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"188.997564ms","start":"2026-09-29T15:38:48.605778Z","end":"2026-09-29T15:38:48.794775Z","steps":["trace[2053833497] 'process raft request' (duration: 188.946413ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:38:48.794845Z","caller":"traceutil/trace.go:171","msg":"trace[1037788064] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"190.128142ms","start":"2026-09-29T15:38:48.604657Z","end":"2026-09-29T15:38:48.794785Z","steps":["trace[1037788064] 'process raft request' (duration: 150.89081ms)","trace[1037788064] 'compare' (duration: 39.030457ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:38:49.788565Z","caller":"traceutil/trace.go:171","msg":"trace[1287847161] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"215.971815ms","start":"2026-09-29T15:38:49.572571Z","end":"2026-09-29T15:38:49.788543Z","steps":["trace[1287847161] 'process raft request' (duration: 165.158799ms)","trace[1287847161] 'compare' (duration: 50.445787ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:38:50.142888Z","caller":"traceutil/trace.go:171","msg":"trace[1567023067] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"137.260217ms","start":"2026-09-29T15:38:50.005605Z","end":"2026-09-29T15:38:50.142865Z","steps":["trace[1567023067] 'process raft request' (duration: 137.114984ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:39:02.734404Z","caller":"traceutil/trace.go:171","msg":"trace[1992567204] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"219.911438ms","start":"2026-09-29T15:39:02.514466Z","end":"2026-09-29T15:39:02.734378Z","steps":["trace[1992567204] 'process raft request' (duration: 219.653542ms)"],"step_count":1}