{"level":"warn","ts":"2026-08-26T08:57:09.502915Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T08:57:09.503011Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.59: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.59:2380","--initial-cluster=instance=https://162.253.55.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.59: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-08-26T08:57:09.503074Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T08:57:09.503087Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-08-26T08:57:09.503148Z","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-08-26T08:57:09.503857Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"]} {"level":"info","ts":"2026-08-26T08:57:09.503931Z","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.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.59: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-08-26T08:57:09.50755Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.439046ms"} {"level":"info","ts":"2026-08-26T08:57:09.513967Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f5132dc9ac390b66","cluster-id":"458d1cb56ab56fc4"} {"level":"info","ts":"2026-08-26T08:57:09.514044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=()"} {"level":"info","ts":"2026-08-26T08:57:09.514141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 0"} {"level":"info","ts":"2026-08-26T08:57:09.514255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f5132dc9ac390b66 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-26T08:57:09.514274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 1"} {"level":"info","ts":"2026-08-26T08:57:09.514368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"warn","ts":"2026-08-26T08:57:09.520083Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-26T08:57:09.521349Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-26T08:57:09.525576Z","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-08-26T08:57:09.527541Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f5132dc9ac390b66","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-26T08:57:09.527783Z","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-08-26T08:57:09.527789Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f5132dc9ac390b66","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-26T08:57:09.527856Z","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-08-26T08:57:09.527886Z","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-08-26T08:57:09.531647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"info","ts":"2026-08-26T08:57:09.531953Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","added-peer-id":"f5132dc9ac390b66","added-peer-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-08-26T08:57:09.534954Z","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-08-26T08:57:09.535139Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-08-26T08:57:09.5352Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-08-26T08:57:09.535182Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f5132dc9ac390b66","initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-26T08:57:09.535227Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-26T08:57:10.315493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 is starting a new election at term 1"} {"level":"info","ts":"2026-08-26T08:57:10.315595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-26T08:57:10.315684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgPreVoteResp from f5132dc9ac390b66 at term 1"} {"level":"info","ts":"2026-08-26T08:57:10.315709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became candidate at term 2"} {"level":"info","ts":"2026-08-26T08:57:10.315721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgVoteResp from f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-08-26T08:57:10.31574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became leader at term 2"} {"level":"info","ts":"2026-08-26T08:57:10.315757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f5132dc9ac390b66 elected leader f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-08-26T08:57:10.316922Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T08:57:10.31769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T08:57:10.317696Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f5132dc9ac390b66","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.59:2379]}","request-path":"/0/members/f5132dc9ac390b66/attributes","cluster-id":"458d1cb56ab56fc4","publish-timeout":"7s"} {"level":"info","ts":"2026-08-26T08:57:10.317794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T08:57:10.318081Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-26T08:57:10.318147Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-26T08:57:10.318466Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T08:57:10.318642Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T08:57:10.318705Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T08:57:10.321883Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.59:2379"} {"level":"info","ts":"2026-08-26T08:57:10.322539Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-26T08:57:12.261275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.019368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-26T08:57:12.261706Z","caller":"traceutil/trace.go:171","msg":"trace[178951091] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"482.228965ms","start":"2026-08-26T08:57:11.779383Z","end":"2026-08-26T08:57:12.261612Z","steps":["trace[178951091] 'process raft request' (duration: 260.151793ms)","trace[178951091] 'compare' (duration: 220.802714ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T08:57:12.261771Z","caller":"traceutil/trace.go:171","msg":"trace[604139377] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"480.746042ms","start":"2026-08-26T08:57:11.780993Z","end":"2026-08-26T08:57:12.261739Z","steps":["trace[604139377] 'process raft request' (duration: 480.6409ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:12.261967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.624199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-26T08:57:12.262019Z","caller":"traceutil/trace.go:171","msg":"trace[889983206] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:39; }","duration":"475.697711ms","start":"2026-08-26T08:57:11.786305Z","end":"2026-08-26T08:57:12.262003Z","steps":["trace[889983206] 'agreement among raft nodes before linearized reading' (duration: 475.559608ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:12.262055Z","caller":"traceutil/trace.go:171","msg":"trace[900641814] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"480.193ms","start":"2026-08-26T08:57:11.781845Z","end":"2026-08-26T08:57:12.262038Z","steps":["trace[900641814] 'process raft request' (duration: 479.873603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:12.262029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.780979Z","time spent":"480.966386ms","remote":"127.0.0.1:49536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-26T08:57:12.262096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.786297Z","time spent":"475.766473ms","remote":"127.0.0.1:49420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"warn","ts":"2026-08-26T08:57:12.26216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.781836Z","time spent":"480.257421ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T08:57:12.262244Z","caller":"traceutil/trace.go:171","msg":"trace[1883774860] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"480.162769ms","start":"2026-08-26T08:57:11.782065Z","end":"2026-08-26T08:57:12.262227Z","steps":["trace[1883774860] 'process raft request' (duration: 479.687869ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:12.262253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.779366Z","time spent":"482.536791ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-26T08:57:12.262366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.782055Z","time spent":"480.239801ms","remote":"127.0.0.1:49432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T08:57:12.261749Z","caller":"traceutil/trace.go:171","msg":"trace[1791319272] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"482.328047ms","start":"2026-08-26T08:57:11.779393Z","end":"2026-08-26T08:57:12.261721Z","steps":["trace[1791319272] 'process raft request' (duration: 482.175184ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:12.261823Z","caller":"traceutil/trace.go:171","msg":"trace[1576764598] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"480.140538ms","start":"2026-08-26T08:57:11.781672Z","end":"2026-08-26T08:57:12.261813Z","steps":["trace[1576764598] 'process raft request' (duration: 480.000595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:12.262564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.781661Z","time spent":"480.871155ms","remote":"127.0.0.1:49814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T08:57:12.261781Z","caller":"traceutil/trace.go:171","msg":"trace[1691992987] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"482.073711ms","start":"2026-08-26T08:57:11.77965Z","end":"2026-08-26T08:57:12.261724Z","steps":["trace[1691992987] 'process raft request' (duration: 481.951198ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:12.262686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.779574Z","time spent":"483.065572ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T08:57:12.262748Z","caller":"traceutil/trace.go:171","msg":"trace[1551411540] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"483.308168ms","start":"2026-08-26T08:57:11.779405Z","end":"2026-08-26T08:57:12.262713Z","steps":["trace[1551411540] 'process raft request' (duration: 482.044101ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:12.261828Z","caller":"traceutil/trace.go:171","msg":"trace[1441648552] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:35; }","duration":"475.481646ms","start":"2026-08-26T08:57:11.786323Z","end":"2026-08-26T08:57:12.261805Z","steps":["trace[1441648552] 'read index received' (duration: 253.063267ms)","trace[1441648552] 'applied index is now lower than readState.Index' (duration: 222.417039ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T08:57:12.262821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.779396Z","time spent":"483.39309ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-26T08:57:12.262899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:11.779371Z","time spent":"483.138244ms","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T08:57:12.380696Z","caller":"traceutil/trace.go:171","msg":"trace[284402581] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"112.960552ms","start":"2026-08-26T08:57:12.267709Z","end":"2026-08-26T08:57:12.380669Z","steps":["trace[284402581] 'process raft request' (duration: 112.90073ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:12.380956Z","caller":"traceutil/trace.go:171","msg":"trace[1888704204] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"115.113099ms","start":"2026-08-26T08:57:12.265812Z","end":"2026-08-26T08:57:12.380925Z","steps":["trace[1888704204] 'process raft request' (duration: 103.410873ms)","trace[1888704204] 'compare' (duration: 11.229076ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T08:57:13.181883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.428848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-26T08:57:13.182039Z","caller":"traceutil/trace.go:171","msg":"trace[1086644465] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"225.01492ms","start":"2026-08-26T08:57:12.956995Z","end":"2026-08-26T08:57:13.18201Z","steps":["trace[1086644465] 'process raft request' (duration: 106.267575ms)","trace[1086644465] 'compare' (duration: 118.247384ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T08:57:49.469076Z","caller":"traceutil/trace.go:171","msg":"trace[652840422] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"116.444496ms","start":"2026-08-26T08:57:49.352607Z","end":"2026-08-26T08:57:49.469051Z","steps":["trace[652840422] 'read index received' (duration: 115.922015ms)","trace[652840422] 'applied index is now lower than readState.Index' (duration: 521.531µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T08:57:49.469132Z","caller":"traceutil/trace.go:171","msg":"trace[1453938126] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"141.166295ms","start":"2026-08-26T08:57:49.327912Z","end":"2026-08-26T08:57:49.469079Z","steps":["trace[1453938126] 'process raft request' (duration: 140.773776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:49.469376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.749873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T08:57:49.46946Z","caller":"traceutil/trace.go:171","msg":"trace[298832586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:567; }","duration":"116.840704ms","start":"2026-08-26T08:57:49.3526Z","end":"2026-08-26T08:57:49.469441Z","steps":["trace[298832586] 'agreement among raft nodes before linearized reading' (duration: 116.683591ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:49.469483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.692872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T08:57:49.469558Z","caller":"traceutil/trace.go:171","msg":"trace[1064394164] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:567; }","duration":"116.794454ms","start":"2026-08-26T08:57:49.352752Z","end":"2026-08-26T08:57:49.469546Z","steps":["trace[1064394164] 'agreement among raft nodes before linearized reading' (duration: 116.653601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:49.470006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.084419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T08:57:49.470087Z","caller":"traceutil/trace.go:171","msg":"trace[813811996] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:567; }","duration":"117.176211ms","start":"2026-08-26T08:57:49.352892Z","end":"2026-08-26T08:57:49.470068Z","steps":["trace[813811996] 'agreement among raft nodes before linearized reading' (duration: 117.047109ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:52.534507Z","caller":"traceutil/trace.go:171","msg":"trace[556329756] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"112.775653ms","start":"2026-08-26T08:57:52.421696Z","end":"2026-08-26T08:57:52.534472Z","steps":["trace[556329756] 'process raft request' (duration: 112.286743ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:53.026399Z","caller":"traceutil/trace.go:171","msg":"trace[1842400614] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"235.935162ms","start":"2026-08-26T08:57:52.790444Z","end":"2026-08-26T08:57:53.026379Z","steps":["trace[1842400614] 'process raft request' (duration: 235.883931ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:57:53.026397Z","caller":"traceutil/trace.go:171","msg":"trace[797626291] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"419.493232ms","start":"2026-08-26T08:57:52.606879Z","end":"2026-08-26T08:57:53.026372Z","steps":["trace[797626291] 'process raft request' (duration: 413.218091ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:53.026631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:52.606853Z","time spent":"419.727607ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-26T08:57:53.026798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.921096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-26T08:57:53.026839Z","caller":"traceutil/trace.go:171","msg":"trace[1485414264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"412.993588ms","start":"2026-08-26T08:57:52.613828Z","end":"2026-08-26T08:57:53.026821Z","steps":["trace[1485414264] 'agreement among raft nodes before linearized reading' (duration: 412.939896ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:57:53.026859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:57:52.613806Z","time spent":"413.049509ms","remote":"127.0.0.1:49636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-26T08:57:53.026712Z","caller":"traceutil/trace.go:171","msg":"trace[1811083336] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"412.588649ms","start":"2026-08-26T08:57:52.613874Z","end":"2026-08-26T08:57:53.026463Z","steps":["trace[1811083336] 'read index received' (duration: 406.231486ms)","trace[1811083336] 'applied index is now lower than readState.Index' (duration: 6.352213ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T08:58:06.861208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.299441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T08:58:06.86141Z","caller":"traceutil/trace.go:171","msg":"trace[1300427284] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"231.992007ms","start":"2026-08-26T08:58:06.629398Z","end":"2026-08-26T08:58:06.86139Z","steps":["trace[1300427284] 'process raft request' (duration: 113.305088ms)","trace[1300427284] 'compare' (duration: 117.945934ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T08:59:25.946519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.669174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-da88b40b-c987-418c-884f-68df77f42237\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-26T08:59:25.946613Z","caller":"traceutil/trace.go:171","msg":"trace[470069715] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-da88b40b-c987-418c-884f-68df77f42237; range_end:; response_count:1; response_revision:1826; }","duration":"315.801726ms","start":"2026-08-26T08:59:25.630791Z","end":"2026-08-26T08:59:25.946593Z","steps":["trace[470069715] 'range keys from in-memory index tree' (duration: 315.484211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:59:25.946653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T08:59:25.630774Z","time spent":"315.870248ms","remote":"127.0.0.1:49536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-da88b40b-c987-418c-884f-68df77f42237\" "} {"level":"warn","ts":"2026-08-26T08:59:26.161375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.694531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T08:59:26.161478Z","caller":"traceutil/trace.go:171","msg":"trace[1167215841] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"114.897954ms","start":"2026-08-26T08:59:26.046564Z","end":"2026-08-26T08:59:26.161462Z","steps":["trace[1167215841] 'compare' (duration: 108.588869ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:59:26.176858Z","caller":"traceutil/trace.go:171","msg":"trace[8726412] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"125.648058ms","start":"2026-08-26T08:59:26.05119Z","end":"2026-08-26T08:59:26.176838Z","steps":["trace[8726412] 'process raft request' (duration: 125.383073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:59:37.675461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.467622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T08:59:37.675533Z","caller":"traceutil/trace.go:171","msg":"trace[1441486945] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1931; }","duration":"105.572214ms","start":"2026-08-26T08:59:37.569939Z","end":"2026-08-26T08:59:37.675512Z","steps":["trace[1441486945] 'count revisions from in-memory index tree' (duration: 105.334609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T08:59:37.676033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.704746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-26T08:59:37.676155Z","caller":"traceutil/trace.go:171","msg":"trace[1500635746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1931; }","duration":"103.030433ms","start":"2026-08-26T08:59:37.573095Z","end":"2026-08-26T08:59:37.676125Z","steps":["trace[1500635746] 'range keys from in-memory index tree' (duration: 102.484613ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T08:59:59.558739Z","caller":"traceutil/trace.go:171","msg":"trace[513906068] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"103.704029ms","start":"2026-08-26T08:59:59.455006Z","end":"2026-08-26T08:59:59.55871Z","steps":["trace[513906068] 'process raft request' (duration: 65.742569ms)","trace[513906068] 'compare' (duration: 37.815716ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T09:00:00.986758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.843891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-26T09:00:00.986883Z","caller":"traceutil/trace.go:171","msg":"trace[2014553167] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2072; }","duration":"158.024824ms","start":"2026-08-26T09:00:00.828832Z","end":"2026-08-26T09:00:00.986856Z","steps":["trace[2014553167] 'range keys from in-memory index tree' (duration: 157.542644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T09:05:22.431989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.84991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d0ee3944-5759-4e63-b694-c062f835245a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-26T09:05:22.432075Z","caller":"traceutil/trace.go:171","msg":"trace[1375460018] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d0ee3944-5759-4e63-b694-c062f835245a; range_end:; response_count:1; response_revision:4648; }","duration":"118.001623ms","start":"2026-08-26T09:05:22.314049Z","end":"2026-08-26T09:05:22.43205Z","steps":["trace[1375460018] 'range keys from in-memory index tree' (duration: 117.147586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T09:05:22.432164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.715446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-26T09:05:22.432599Z","caller":"traceutil/trace.go:171","msg":"trace[1443817308] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"114.403481ms","start":"2026-08-26T09:05:22.318171Z","end":"2026-08-26T09:05:22.432574Z","steps":["trace[1443817308] 'compare' (duration: 102.695886ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T09:05:22.908827Z","caller":"traceutil/trace.go:171","msg":"trace[1408429074] linearizableReadLoop","detail":"{readStateIndex:4833; appliedIndex:4832; }","duration":"246.230763ms","start":"2026-08-26T09:05:22.662559Z","end":"2026-08-26T09:05:22.90879Z","steps":["trace[1408429074] 'read index received' (duration: 163.912148ms)","trace[1408429074] 'applied index is now lower than readState.Index' (duration: 82.317095ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T09:05:22.909196Z","caller":"traceutil/trace.go:171","msg":"trace[856878434] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"278.101554ms","start":"2026-08-26T09:05:22.63104Z","end":"2026-08-26T09:05:22.909142Z","steps":["trace[856878434] 'process raft request' (duration: 195.431642ms)","trace[856878434] 'compare' (duration: 81.945608ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T09:05:22.909573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.989349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-26T09:05:22.909916Z","caller":"traceutil/trace.go:171","msg":"trace[1960641490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4656; }","duration":"247.358346ms","start":"2026-08-26T09:05:22.662541Z","end":"2026-08-26T09:05:22.909899Z","steps":["trace[1960641490] 'agreement among raft nodes before linearized reading' (duration: 246.839265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T09:05:35.594257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.079842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-26T09:05:35.594352Z","caller":"traceutil/trace.go:171","msg":"trace[539360654] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4826; }","duration":"102.208615ms","start":"2026-08-26T09:05:35.492119Z","end":"2026-08-26T09:05:35.594327Z","steps":["trace[539360654] 'range keys from in-memory index tree' (duration: 101.937179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T09:05:35.594751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.425221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16401"} {"level":"info","ts":"2026-08-26T09:05:35.594826Z","caller":"traceutil/trace.go:171","msg":"trace[595925122] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4826; }","duration":"124.545504ms","start":"2026-08-26T09:05:35.470261Z","end":"2026-08-26T09:05:35.594807Z","steps":["trace[595925122] 'range keys from in-memory index tree' (duration: 124.285839ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T09:07:10.352705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-08-26T09:07:10.45437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"100.33763ms","hash":91612,"current-db-size-bytes":55017472,"current-db-size":"55 MB","current-db-size-in-use-bytes":29618176,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-26T09:07:10.45445Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":91612,"revision":2875,"compact-revision":-1} {"level":"info","ts":"2026-08-26T09:09:52.596989Z","caller":"traceutil/trace.go:171","msg":"trace[1434333246] transaction","detail":"{read_only:false; response_revision:6677; number_of_response:1; }","duration":"100.919105ms","start":"2026-08-26T09:09:52.496053Z","end":"2026-08-26T09:09:52.596972Z","steps":["trace[1434333246] 'process raft request' (duration: 85.365247ms)","trace[1434333246] 'compare' (duration: 14.607836ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T09:09:52.596566Z","caller":"traceutil/trace.go:171","msg":"trace[1811003667] linearizableReadLoop","detail":"{readStateIndex:6924; appliedIndex:6922; }","duration":"100.204428ms","start":"2026-08-26T09:09:52.496338Z","end":"2026-08-26T09:09:52.596543Z","steps":["trace[1811003667] 'read index received' (duration: 5.86204ms)","trace[1811003667] 'applied index is now lower than readState.Index' (duration: 94.341238ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T09:09:52.597639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.259994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T09:09:52.59782Z","caller":"traceutil/trace.go:171","msg":"trace[225409264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6677; }","duration":"101.440799ms","start":"2026-08-26T09:09:52.496324Z","end":"2026-08-26T09:09:52.597765Z","steps":["trace[225409264] 'agreement among raft nodes before linearized reading' (duration: 101.207144ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T09:10:06.27767Z","caller":"traceutil/trace.go:171","msg":"trace[605910506] transaction","detail":"{read_only:false; response_revision:6747; number_of_response:1; }","duration":"187.478528ms","start":"2026-08-26T09:10:06.090163Z","end":"2026-08-26T09:10:06.277641Z","steps":["trace[605910506] 'process raft request' (duration: 187.294754ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T09:12:10.359463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5596} {"level":"info","ts":"2026-08-26T09:12:10.440906Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5596,"took":"79.790807ms","hash":792883538,"current-db-size-bytes":55017472,"current-db-size":"55 MB","current-db-size-in-use-bytes":18501632,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-26T09:12:10.441006Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":792883538,"revision":5596,"compact-revision":2875}