{"level":"warn","ts":"2026-09-22T02:09:04.365736Z","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-22T02:09:04.365854Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.55: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.55:2380","--initial-cluster=instance=https://162.253.55.55:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.55:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.55: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-22T02:09:04.365948Z","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-22T02:09:04.365959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.55:2380"]} {"level":"info","ts":"2026-09-22T02:09:04.36599Z","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-22T02:09:04.366947Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"]} {"level":"info","ts":"2026-09-22T02:09:04.367135Z","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.55:2380"],"listen-peer-urls":["https://162.253.55.55:2380"],"advertise-client-urls":["https://162.253.55.55:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.55: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-22T02:09:04.372776Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.291775ms"} {"level":"info","ts":"2026-09-22T02:09:04.378917Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"357bf0025115def9","cluster-id":"5f69314e1ae3c800"} {"level":"info","ts":"2026-09-22T02:09:04.379032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T02:09:04.379054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became follower at term 0"} {"level":"info","ts":"2026-09-22T02:09:04.379067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 357bf0025115def9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T02:09:04.379085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became follower at term 1"} {"level":"info","ts":"2026-09-22T02:09:04.379127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=(3853937798886579961)"} {"level":"warn","ts":"2026-09-22T02:09:04.388471Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T02:09:04.392394Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T02:09:04.394429Z","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-22T02:09:04.397544Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"357bf0025115def9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T02:09:04.397969Z","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-22T02:09:04.398062Z","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-22T02:09:04.398078Z","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-22T02:09:04.398312Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"357bf0025115def9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T02:09:04.401646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 switched to configuration voters=(3853937798886579961)"} {"level":"info","ts":"2026-09-22T02:09:04.401732Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f69314e1ae3c800","local-member-id":"357bf0025115def9","added-peer-id":"357bf0025115def9","added-peer-peer-urls":["https://162.253.55.55:2380"]} {"level":"info","ts":"2026-09-22T02:09:04.402901Z","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-22T02:09:04.403194Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"357bf0025115def9","initial-advertise-peer-urls":["https://162.253.55.55:2380"],"listen-peer-urls":["https://162.253.55.55:2380"],"advertise-client-urls":["https://162.253.55.55:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.55:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T02:09:04.40322Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T02:09:04.403534Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.55:2380"} {"level":"info","ts":"2026-09-22T02:09:04.403557Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.55:2380"} {"level":"info","ts":"2026-09-22T02:09:05.379822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T02:09:05.379894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T02:09:05.379916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 received MsgPreVoteResp from 357bf0025115def9 at term 1"} {"level":"info","ts":"2026-09-22T02:09:05.379936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became candidate at term 2"} {"level":"info","ts":"2026-09-22T02:09:05.379946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 received MsgVoteResp from 357bf0025115def9 at term 2"} {"level":"info","ts":"2026-09-22T02:09:05.379961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"357bf0025115def9 became leader at term 2"} {"level":"info","ts":"2026-09-22T02:09:05.379974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 357bf0025115def9 elected leader 357bf0025115def9 at term 2"} {"level":"info","ts":"2026-09-22T02:09:05.390251Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"357bf0025115def9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.55:2379]}","request-path":"/0/members/357bf0025115def9/attributes","cluster-id":"5f69314e1ae3c800","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T02:09:05.390247Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:09:05.390308Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T02:09:05.390437Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T02:09:05.390679Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T02:09:05.390741Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T02:09:05.392712Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.55:2379"} {"level":"info","ts":"2026-09-22T02:09:05.393839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T02:09:05.395353Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f69314e1ae3c800","local-member-id":"357bf0025115def9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:09:05.395441Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:09:05.395476Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-22T02:09:07.407258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.319793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-22T02:09:07.407603Z","caller":"traceutil/trace.go:171","msg":"trace[446229968] linearizableReadLoop","detail":"{readStateIndex:53; appliedIndex:51; }","duration":"221.687504ms","start":"2026-09-22T02:09:07.18587Z","end":"2026-09-22T02:09:07.407557Z","steps":["trace[446229968] 'read index received' (duration: 217.568969ms)","trace[446229968] 'applied index is now lower than readState.Index' (duration: 4.116895ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:07.407828Z","caller":"traceutil/trace.go:171","msg":"trace[1415002764] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"325.564098ms","start":"2026-09-22T02:09:07.08224Z","end":"2026-09-22T02:09:07.407804Z","steps":["trace[1415002764] 'process raft request' (duration: 35.976613ms)","trace[1415002764] 'compare' (duration: 288.107277ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:07.407918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:07.082226Z","time spent":"325.656291ms","remote":"127.0.0.1:47878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T02:09:07.408097Z","caller":"traceutil/trace.go:171","msg":"trace[1013853076] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"319.992597ms","start":"2026-09-22T02:09:07.088051Z","end":"2026-09-22T02:09:07.408044Z","steps":["trace[1013853076] 'process raft request' (duration: 319.422383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:07.40829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.814478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T02:09:07.408331Z","caller":"traceutil/trace.go:171","msg":"trace[654833950] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:49; }","duration":"128.90749ms","start":"2026-09-22T02:09:07.279411Z","end":"2026-09-22T02:09:07.408318Z","steps":["trace[654833950] 'agreement among raft nodes before linearized reading' (duration: 128.820248ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:07.408307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.34506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T02:09:07.408413Z","caller":"traceutil/trace.go:171","msg":"trace[996380115] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:49; }","duration":"222.562336ms","start":"2026-09-22T02:09:07.185822Z","end":"2026-09-22T02:09:07.408385Z","steps":["trace[996380115] 'agreement among raft nodes before linearized reading' (duration: 222.310909ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:07.40904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:07.088034Z","time spent":"320.197813ms","remote":"127.0.0.1:47878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:09:17.613676Z","caller":"traceutil/trace.go:171","msg":"trace[203155317] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:403; }","duration":"136.279797ms","start":"2026-09-22T02:09:17.477327Z","end":"2026-09-22T02:09:17.613607Z","steps":["trace[203155317] 'read index received' (duration: 136.047731ms)","trace[203155317] 'applied index is now lower than readState.Index' (duration: 230.576µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:17.613873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.519873ms","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-22T02:09:17.613857Z","caller":"traceutil/trace.go:171","msg":"trace[1364384448] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"171.634994ms","start":"2026-09-22T02:09:17.442177Z","end":"2026-09-22T02:09:17.613812Z","steps":["trace[1364384448] 'process raft request' (duration: 171.234654ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:17.613917Z","caller":"traceutil/trace.go:171","msg":"trace[557540612] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:396; }","duration":"136.613485ms","start":"2026-09-22T02:09:17.477288Z","end":"2026-09-22T02:09:17.613902Z","steps":["trace[557540612] 'agreement among raft nodes before linearized reading' (duration: 136.504013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:18.040044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.012862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:09:18.040247Z","caller":"traceutil/trace.go:171","msg":"trace[797986876] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"420.746443ms","start":"2026-09-22T02:09:17.619482Z","end":"2026-09-22T02:09:18.040228Z","steps":["trace[797986876] 'process raft request' (duration: 420.682831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:18.040345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:17.619447Z","time spent":"420.860486ms","remote":"127.0.0.1:47734","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-22T02:09:18.04033Z","caller":"traceutil/trace.go:171","msg":"trace[1137041945] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:404; }","duration":"426.509589ms","start":"2026-09-22T02:09:17.613765Z","end":"2026-09-22T02:09:18.040275Z","steps":["trace[1137041945] 'read index received' (duration: 77.187148ms)","trace[1137041945] 'applied index is now lower than readState.Index' (duration: 349.317611ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:18.040504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.899118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-22T02:09:18.040545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.472691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-09-22T02:09:18.040553Z","caller":"traceutil/trace.go:171","msg":"trace[1158730410] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"434.011029ms","start":"2026-09-22T02:09:17.606528Z","end":"2026-09-22T02:09:18.040539Z","steps":["trace[1158730410] 'process raft request' (duration: 84.391551ms)","trace[1158730410] 'compare' (duration: 348.858769ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:18.040572Z","caller":"traceutil/trace.go:171","msg":"trace[395904728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:398; }","duration":"535.003971ms","start":"2026-09-22T02:09:17.505551Z","end":"2026-09-22T02:09:18.040555Z","steps":["trace[395904728] 'agreement among raft nodes before linearized reading' (duration: 534.893878ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:18.040581Z","caller":"traceutil/trace.go:171","msg":"trace[104432180] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:398; }","duration":"188.558363ms","start":"2026-09-22T02:09:17.852011Z","end":"2026-09-22T02:09:18.04057Z","steps":["trace[104432180] 'agreement among raft nodes before linearized reading' (duration: 188.44409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:18.040612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:17.505534Z","time spent":"535.070892ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-22T02:09:18.040704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:17.606499Z","time spent":"434.081561ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:09:18.274591Z","caller":"traceutil/trace.go:171","msg":"trace[507774177] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"229.656936ms","start":"2026-09-22T02:09:18.04491Z","end":"2026-09-22T02:09:18.274567Z","steps":["trace[507774177] 'process raft request' (duration: 223.685274ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:18.279531Z","caller":"traceutil/trace.go:171","msg":"trace[377409739] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"233.398181ms","start":"2026-09-22T02:09:18.046104Z","end":"2026-09-22T02:09:18.279502Z","steps":["trace[377409739] 'process raft request' (duration: 233.164435ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:18.279682Z","caller":"traceutil/trace.go:171","msg":"trace[84140134] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"230.306063ms","start":"2026-09-22T02:09:18.049313Z","end":"2026-09-22T02:09:18.279619Z","steps":["trace[84140134] 'process raft request' (duration: 230.108908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:52.776485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.51817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:09:52.776636Z","caller":"traceutil/trace.go:171","msg":"trace[1999069986] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"316.588351ms","start":"2026-09-22T02:09:52.460032Z","end":"2026-09-22T02:09:52.776621Z","steps":["trace[1999069986] 'read index received' (duration: 35.761µs)","trace[1999069986] 'applied index is now lower than readState.Index' (duration: 316.55161ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:52.776869Z","caller":"traceutil/trace.go:171","msg":"trace[2016580846] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"508.449607ms","start":"2026-09-22T02:09:52.268399Z","end":"2026-09-22T02:09:52.776849Z","steps":["trace[2016580846] 'process raft request' (duration: 508.17783ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:52.776886Z","caller":"traceutil/trace.go:171","msg":"trace[648848528] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"556.745572ms","start":"2026-09-22T02:09:52.220113Z","end":"2026-09-22T02:09:52.776859Z","steps":["trace[648848528] 'process raft request' (duration: 60.783391ms)","trace[648848528] 'compare' (duration: 495.401797ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:52.776928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.885748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-22T02:09:52.776968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.268381Z","time spent":"508.543918ms","remote":"127.0.0.1:47694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T02:09:52.776984Z","caller":"traceutil/trace.go:171","msg":"trace[1382332780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"316.97892ms","start":"2026-09-22T02:09:52.459987Z","end":"2026-09-22T02:09:52.776965Z","steps":["trace[1382332780] 'agreement among raft nodes before linearized reading' (duration: 316.827327ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:52.776913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.618922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-22T02:09:52.777019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.220086Z","time spent":"556.860225ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:09:52.777027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.459966Z","time spent":"317.051572ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-22T02:09:52.777054Z","caller":"traceutil/trace.go:171","msg":"trace[758702516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"290.790665ms","start":"2026-09-22T02:09:52.486252Z","end":"2026-09-22T02:09:52.777043Z","steps":["trace[758702516] 'agreement among raft nodes before linearized reading' (duration: 290.56956ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:53.11311Z","caller":"traceutil/trace.go:171","msg":"trace[481937891] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"329.840856ms","start":"2026-09-22T02:09:52.783242Z","end":"2026-09-22T02:09:53.113082Z","steps":["trace[481937891] 'read index received' (duration: 328.79737ms)","trace[481937891] 'applied index is now lower than readState.Index' (duration: 1.042676ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:53.113235Z","caller":"traceutil/trace.go:171","msg":"trace[1983147011] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"332.861263ms","start":"2026-09-22T02:09:52.780349Z","end":"2026-09-22T02:09:53.113211Z","steps":["trace[1983147011] 'process raft request' (duration: 331.684773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:53.113379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.780328Z","time spent":"332.975666ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:09:53.113665Z","caller":"traceutil/trace.go:171","msg":"trace[1663172520] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"332.844183ms","start":"2026-09-22T02:09:52.780804Z","end":"2026-09-22T02:09:53.113649Z","steps":["trace[1663172520] 'process raft request' (duration: 332.195686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:53.113756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.780755Z","time spent":"332.953686ms","remote":"127.0.0.1:47734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:09:53.11369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.397371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-22T02:09:53.114072Z","caller":"traceutil/trace.go:171","msg":"trace[703147843] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:645; }","duration":"330.812681ms","start":"2026-09-22T02:09:52.783204Z","end":"2026-09-22T02:09:53.114016Z","steps":["trace[703147843] 'agreement among raft nodes before linearized reading' (duration: 330.250077ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:53.114267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:09:52.78319Z","time spent":"330.913424ms","remote":"127.0.0.1:47656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-09-22T02:10:10.539147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.361177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:10:10.539242Z","caller":"traceutil/trace.go:171","msg":"trace[926865140] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:807; }","duration":"447.514681ms","start":"2026-09-22T02:10:10.091708Z","end":"2026-09-22T02:10:10.539223Z","steps":["trace[926865140] 'count revisions from in-memory index tree' (duration: 447.220474ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:10:10.539212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.32549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T02:10:10.539284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:10.091684Z","time spent":"447.589653ms","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-09-22T02:10:10.5393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.790695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-swp87\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-22T02:10:10.539333Z","caller":"traceutil/trace.go:171","msg":"trace[344383034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"304.511454ms","start":"2026-09-22T02:10:10.234799Z","end":"2026-09-22T02:10:10.53931Z","steps":["trace[344383034] 'range keys from in-memory index tree' (duration: 304.236277ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:10:10.539395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:10.234781Z","time spent":"304.601366ms","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T02:10:10.539405Z","caller":"traceutil/trace.go:171","msg":"trace[1278575495] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-swp87; range_end:; response_count:1; response_revision:807; }","duration":"314.929659ms","start":"2026-09-22T02:10:10.224436Z","end":"2026-09-22T02:10:10.539366Z","steps":["trace[1278575495] 'range keys from in-memory index tree' (duration: 314.533888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:10:10.539488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:10:10.224416Z","time spent":"315.02685ms","remote":"127.0.0.1:47644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-swp87\" "} {"level":"info","ts":"2026-09-22T02:10:51.627533Z","caller":"traceutil/trace.go:171","msg":"trace[305235247] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"138.229606ms","start":"2026-09-22T02:10:51.489283Z","end":"2026-09-22T02:10:51.627513Z","steps":["trace[305235247] 'process raft request' (duration: 138.124334ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:08.991868Z","caller":"traceutil/trace.go:171","msg":"trace[1811912115] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"142.607867ms","start":"2026-09-22T02:11:08.849233Z","end":"2026-09-22T02:11:08.991841Z","steps":["trace[1811912115] 'process raft request' (duration: 142.478564ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:09.194374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.748893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.55\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-22T02:11:09.194819Z","caller":"traceutil/trace.go:171","msg":"trace[533646482] range","detail":"{range_begin:/registry/masterleases/162.253.55.55; range_end:; response_count:1; response_revision:1176; }","duration":"184.232195ms","start":"2026-09-22T02:11:09.010557Z","end":"2026-09-22T02:11:09.194789Z","steps":["trace[533646482] 'range keys from in-memory index tree' (duration: 183.553808ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:09.809976Z","caller":"traceutil/trace.go:171","msg":"trace[985336461] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"130.783016ms","start":"2026-09-22T02:11:09.679177Z","end":"2026-09-22T02:11:09.80996Z","steps":["trace[985336461] 'process raft request' (duration: 130.53126ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:10.03384Z","caller":"traceutil/trace.go:171","msg":"trace[50518338] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"218.480576ms","start":"2026-09-22T02:11:09.815325Z","end":"2026-09-22T02:11:10.033806Z","steps":["trace[50518338] 'process raft request' (duration: 207.156838ms)","trace[50518338] 'compare' (duration: 11.0073ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:11:10.04597Z","caller":"traceutil/trace.go:171","msg":"trace[147460140] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"230.432641ms","start":"2026-09-22T02:11:09.815509Z","end":"2026-09-22T02:11:10.045942Z","steps":["trace[147460140] 'process raft request' (duration: 230.280648ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:10.046158Z","caller":"traceutil/trace.go:171","msg":"trace[1566258774] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"230.558474ms","start":"2026-09-22T02:11:09.815582Z","end":"2026-09-22T02:11:10.046141Z","steps":["trace[1566258774] 'process raft request' (duration: 230.311088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:10.550745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.755937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:11:10.550824Z","caller":"traceutil/trace.go:171","msg":"trace[587727379] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1185; }","duration":"145.883791ms","start":"2026-09-22T02:11:10.404919Z","end":"2026-09-22T02:11:10.550803Z","steps":["trace[587727379] 'range keys from in-memory index tree' (duration: 145.664065ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:10.751071Z","caller":"traceutil/trace.go:171","msg":"trace[1799872360] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"160.018899ms","start":"2026-09-22T02:11:10.590984Z","end":"2026-09-22T02:11:10.751003Z","steps":["trace[1799872360] 'process raft request' (duration: 159.779623ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:10.751283Z","caller":"traceutil/trace.go:171","msg":"trace[1232230425] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"159.757713ms","start":"2026-09-22T02:11:10.591216Z","end":"2026-09-22T02:11:10.750974Z","steps":["trace[1232230425] 'process raft request' (duration: 159.684462ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:23.143981Z","caller":"traceutil/trace.go:171","msg":"trace[96415687] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1310; }","duration":"142.607866ms","start":"2026-09-22T02:11:23.001348Z","end":"2026-09-22T02:11:23.143956Z","steps":["trace[96415687] 'read index received' (duration: 142.448543ms)","trace[96415687] 'applied index is now lower than readState.Index' (duration: 158.023µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:11:23.144034Z","caller":"traceutil/trace.go:171","msg":"trace[1860710838] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"162.183275ms","start":"2026-09-22T02:11:22.981832Z","end":"2026-09-22T02:11:23.144015Z","steps":["trace[1860710838] 'process raft request' (duration: 161.948838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:23.144147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.785351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:11:23.144182Z","caller":"traceutil/trace.go:171","msg":"trace[1468197074] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1268; }","duration":"142.872334ms","start":"2026-09-22T02:11:23.001301Z","end":"2026-09-22T02:11:23.144173Z","steps":["trace[1468197074] 'agreement among raft nodes before linearized reading' (duration: 142.775511ms)"],"step_count":1}