{"level":"warn","ts":"2026-09-29T15:36:18.207156Z","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:18.207274Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.32: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.32:2380","--initial-cluster=instance=https://162.253.55.32:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.32:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.32: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:18.207366Z","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:18.207379Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.32:2380"]} {"level":"info","ts":"2026-09-29T15:36:18.207412Z","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:18.208267Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"]} {"level":"info","ts":"2026-09-29T15:36:18.208362Z","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.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.32: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:18.212772Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.144841ms"} {"level":"info","ts":"2026-09-29T15:36:18.225129Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c665390cd9eacc14","cluster-id":"d19b610fbe64baae"} {"level":"info","ts":"2026-09-29T15:36:18.225211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T15:36:18.225238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 0"} {"level":"info","ts":"2026-09-29T15:36:18.225265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c665390cd9eacc14 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T15:36:18.225277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 1"} {"level":"info","ts":"2026-09-29T15:36:18.225321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"} {"level":"warn","ts":"2026-09-29T15:36:18.236008Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T15:36:18.23903Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T15:36:18.2423Z","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:18.244871Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c665390cd9eacc14","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T15:36:18.244949Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c665390cd9eacc14","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T15:36:18.245073Z","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:18.245164Z","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:18.245175Z","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:18.246964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"} {"level":"info","ts":"2026-09-29T15:36:18.247123Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","added-peer-id":"c665390cd9eacc14","added-peer-peer-urls":["https://162.253.55.32:2380"]} {"level":"info","ts":"2026-09-29T15:36:18.2499Z","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:18.250058Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.32:2380"} {"level":"info","ts":"2026-09-29T15:36:18.250095Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.32:2380"} {"level":"info","ts":"2026-09-29T15:36:18.250388Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c665390cd9eacc14","initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T15:36:18.250437Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T15:36:18.325573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T15:36:18.325639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T15:36:18.325658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgPreVoteResp from c665390cd9eacc14 at term 1"} {"level":"info","ts":"2026-09-29T15:36:18.32567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became candidate at term 2"} {"level":"info","ts":"2026-09-29T15:36:18.325761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgVoteResp from c665390cd9eacc14 at term 2"} {"level":"info","ts":"2026-09-29T15:36:18.325798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became leader at term 2"} {"level":"info","ts":"2026-09-29T15:36:18.32581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c665390cd9eacc14 elected leader c665390cd9eacc14 at term 2"} {"level":"info","ts":"2026-09-29T15:36:18.327215Z","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:18.32807Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:36:18.328077Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c665390cd9eacc14","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.32:2379]}","request-path":"/0/members/c665390cd9eacc14/attributes","cluster-id":"d19b610fbe64baae","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T15:36:18.328102Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T15:36:18.32843Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T15:36:18.328545Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T15:36:18.328631Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:18.328733Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:18.328765Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T15:36:18.331987Z","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:18.333565Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.32:2379"} {"level":"warn","ts":"2026-09-29T15:36:22.011039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.420771ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:36:22.01119Z","caller":"traceutil/trace.go:171","msg":"trace[1195911992] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"373.990236ms","start":"2026-09-29T15:36:21.637178Z","end":"2026-09-29T15:36:22.011168Z","steps":["trace[1195911992] 'process raft request' (duration: 153.873081ms)","trace[1195911992] 'compare' (duration: 219.207107ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:36:22.011313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:36:21.637152Z","time spent":"374.104067ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":678,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T15:36:22.41141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.257019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:36:22.411525Z","caller":"traceutil/trace.go:171","msg":"trace[380784174] linearizableReadLoop","detail":"{readStateIndex:137; appliedIndex:136; }","duration":"212.534422ms","start":"2026-09-29T15:36:22.198971Z","end":"2026-09-29T15:36:22.411505Z","steps":["trace[380784174] 'read index received' (duration: 1.997388ms)","trace[380784174] 'applied index is now lower than readState.Index' (duration: 210.535824ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:36:22.411614Z","caller":"traceutil/trace.go:171","msg":"trace[525878581] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"393.604568ms","start":"2026-09-29T15:36:22.01795Z","end":"2026-09-29T15:36:22.411554Z","steps":["trace[525878581] 'process raft request' (duration: 183.118605ms)","trace[525878581] 'compare' (duration: 210.091515ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:36:22.411737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.736505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:36:22.411828Z","caller":"traceutil/trace.go:171","msg":"trace[797569003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:134; }","duration":"212.906289ms","start":"2026-09-29T15:36:22.198912Z","end":"2026-09-29T15:36:22.411818Z","steps":["trace[797569003] 'agreement among raft nodes before linearized reading' (duration: 212.640734ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:36:22.411842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:36:22.017918Z","time spent":"393.804512ms","remote":"127.0.0.1:35136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T15:36:25.06825Z","caller":"traceutil/trace.go:171","msg":"trace[1052994206] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"100.405412ms","start":"2026-09-29T15:36:24.967795Z","end":"2026-09-29T15:36:25.068201Z","steps":["trace[1052994206] 'process raft request' (duration: 24.073287ms)","trace[1052994206] 'compare' (duration: 75.934507ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:08.50835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.313618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:37:08.508797Z","caller":"traceutil/trace.go:171","msg":"trace[417024554] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"290.835825ms","start":"2026-09-29T15:37:08.217785Z","end":"2026-09-29T15:37:08.508621Z","steps":["trace[417024554] 'process raft request' (duration: 137.01844ms)","trace[417024554] 'compare' (duration: 153.189606ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:08.508926Z","caller":"traceutil/trace.go:171","msg":"trace[1278996478] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"281.863009ms","start":"2026-09-29T15:37:08.227018Z","end":"2026-09-29T15:37:08.508881Z","steps":["trace[1278996478] 'process raft request' (duration: 281.513743ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:08.509009Z","caller":"traceutil/trace.go:171","msg":"trace[232301120] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"270.018717ms","start":"2026-09-29T15:37:08.238969Z","end":"2026-09-29T15:37:08.508988Z","steps":["trace[232301120] 'process raft request' (duration: 269.841615ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:08.519861Z","caller":"traceutil/trace.go:171","msg":"trace[842290694] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:614; }","duration":"148.302021ms","start":"2026-09-29T15:37:08.37151Z","end":"2026-09-29T15:37:08.519812Z","steps":["trace[842290694] 'read index received' (duration: 134.130615ms)","trace[842290694] 'applied index is now lower than readState.Index' (duration: 14.169876ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:08.520022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.488314ms","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:08.520091Z","caller":"traceutil/trace.go:171","msg":"trace[1691350566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"148.611047ms","start":"2026-09-29T15:37:08.371461Z","end":"2026-09-29T15:37:08.520072Z","steps":["trace[1691350566] 'agreement among raft nodes before linearized reading' (duration: 148.450234ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:14.889438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.718864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:37:14.889527Z","caller":"traceutil/trace.go:171","msg":"trace[372096592] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"340.7017ms","start":"2026-09-29T15:37:14.54881Z","end":"2026-09-29T15:37:14.889512Z","steps":["trace[372096592] 'read index received' (duration: 104.63376ms)","trace[372096592] 'applied index is now lower than readState.Index' (duration: 236.06677ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T15:37:14.889598Z","caller":"traceutil/trace.go:171","msg":"trace[636947320] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"353.992738ms","start":"2026-09-29T15:37:14.535595Z","end":"2026-09-29T15:37:14.889588Z","steps":["trace[636947320] 'process raft request' (duration: 118.060401ms)","trace[636947320] 'compare' (duration: 235.484241ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:14.889641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:14.53557Z","time spent":"354.048339ms","remote":"127.0.0.1:35304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T15:37:14.889814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.727835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:37:14.88988Z","caller":"traceutil/trace.go:171","msg":"trace[2014012080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"284.813406ms","start":"2026-09-29T15:37:14.605045Z","end":"2026-09-29T15:37:14.889859Z","steps":["trace[2014012080] 'agreement among raft nodes before linearized reading' (duration: 284.652753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:14.8899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.090066ms","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:14.889954Z","caller":"traceutil/trace.go:171","msg":"trace[257722347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:665; }","duration":"341.184097ms","start":"2026-09-29T15:37:14.548753Z","end":"2026-09-29T15:37:14.889938Z","steps":["trace[257722347] 'agreement among raft nodes before linearized reading' (duration: 341.002365ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:14.89Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:14.548741Z","time spent":"341.248759ms","remote":"127.0.0.1:35058","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":"warn","ts":"2026-09-29T15:37:14.890024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.93176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hvpdx\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-29T15:37:14.890116Z","caller":"traceutil/trace.go:171","msg":"trace[640031977] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hvpdx; range_end:; response_count:1; response_revision:665; }","duration":"155.090762ms","start":"2026-09-29T15:37:14.735002Z","end":"2026-09-29T15:37:14.890092Z","steps":["trace[640031977] 'agreement among raft nodes before linearized reading' (duration: 154.792258ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:15.347303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.165987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T15:37:15.347401Z","caller":"traceutil/trace.go:171","msg":"trace[2088407976] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:692; }","duration":"445.110198ms","start":"2026-09-29T15:37:14.902275Z","end":"2026-09-29T15:37:15.347385Z","steps":["trace[2088407976] 'read index received' (duration: 5.695095ms)","trace[2088407976] 'applied index is now lower than readState.Index' (duration: 439.414073ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:15.347485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.21249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:37:15.347548Z","caller":"traceutil/trace.go:171","msg":"trace[1220730626] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:667; }","duration":"445.28483ms","start":"2026-09-29T15:37:14.90223Z","end":"2026-09-29T15:37:15.347514Z","steps":["trace[1220730626] 'agreement among raft nodes before linearized reading' (duration: 445.197979ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T15:37:15.347605Z","caller":"traceutil/trace.go:171","msg":"trace[519655776] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"449.164258ms","start":"2026-09-29T15:37:14.898341Z","end":"2026-09-29T15:37:15.347506Z","steps":["trace[519655776] 'process raft request' (duration: 93.719877ms)","trace[519655776] 'compare' (duration: 355.049745ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:15.347597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:14.902215Z","time spent":"445.370862ms","remote":"127.0.0.1:35044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-29T15:37:15.347877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:14.898322Z","time spent":"449.408571ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:37:15.812078Z","caller":"traceutil/trace.go:171","msg":"trace[2038559407] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:694; }","duration":"462.895346ms","start":"2026-09-29T15:37:15.34916Z","end":"2026-09-29T15:37:15.812056Z","steps":["trace[2038559407] 'read index received' (duration: 398.856836ms)","trace[2038559407] 'applied index is now lower than readState.Index' (duration: 64.03741ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:15.812252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.07588ms","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:37:15.812256Z","caller":"traceutil/trace.go:171","msg":"trace[11354820] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"900.277831ms","start":"2026-09-29T15:37:14.911943Z","end":"2026-09-29T15:37:15.812221Z","steps":["trace[11354820] 'process raft request' (duration: 835.994286ms)","trace[11354820] 'compare' (duration: 64.02459ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T15:37:15.812655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:14.911909Z","time spent":"900.629416ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T15:37:15.81231Z","caller":"traceutil/trace.go:171","msg":"trace[34022123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"463.190752ms","start":"2026-09-29T15:37:15.349106Z","end":"2026-09-29T15:37:15.812297Z","steps":["trace[34022123] 'agreement among raft nodes before linearized reading' (duration: 462.978128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:15.812871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T15:37:15.349081Z","time spent":"463.754159ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-29T15:37:15.826126Z","caller":"traceutil/trace.go:171","msg":"trace[5620196] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"252.198468ms","start":"2026-09-29T15:37:15.573903Z","end":"2026-09-29T15:37:15.826102Z","steps":["trace[5620196] 'process raft request' (duration: 251.872973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:15.827641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.769059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T15:37:15.82774Z","caller":"traceutil/trace.go:171","msg":"trace[566553454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:670; }","duration":"220.926252ms","start":"2026-09-29T15:37:15.606789Z","end":"2026-09-29T15:37:15.827715Z","steps":["trace[566553454] 'agreement among raft nodes before linearized reading' (duration: 220.76315ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:33.339199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.204353ms","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:37:33.339321Z","caller":"traceutil/trace.go:171","msg":"trace[2106531425] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:838; }","duration":"159.347865ms","start":"2026-09-29T15:37:33.179957Z","end":"2026-09-29T15:37:33.339305Z","steps":["trace[2106531425] 'range keys from in-memory index tree' (duration: 159.187523ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T15:37:33.339625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.202018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-29T15:37:33.339851Z","caller":"traceutil/trace.go:171","msg":"trace[1333924152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:838; }","duration":"262.470901ms","start":"2026-09-29T15:37:33.077348Z","end":"2026-09-29T15:37:33.339819Z","steps":["trace[1333924152] 'range keys from in-memory index tree' (duration: 261.985315ms)"],"step_count":1}