{"level":"warn","ts":"2026-10-09T02:24:43.016671Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:24:43.016812Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.164: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.164:2380","--initial-cluster=instance=https://162.253.55.164:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.164:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.164: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-10-09T02:24:43.016911Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:24:43.016927Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-10-09T02:24:43.01698Z","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-10-09T02:24:43.017967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"]} {"level":"info","ts":"2026-10-09T02:24:43.01807Z","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.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.164: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-10-09T02:24:43.045987Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"27.58185ms"} {"level":"info","ts":"2026-10-09T02:24:43.063245Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"777352cb93f4c05d","cluster-id":"ebb6470dab83b2e8"} {"level":"info","ts":"2026-10-09T02:24:43.063412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:24:43.063479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 0"} {"level":"info","ts":"2026-10-09T02:24:43.063519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 777352cb93f4c05d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:24:43.063581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 1"} {"level":"info","ts":"2026-10-09T02:24:43.063699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"warn","ts":"2026-10-09T02:24:43.06951Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:24:43.071212Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:24:43.073714Z","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-10-09T02:24:43.0766Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"777352cb93f4c05d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:24:43.076895Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"777352cb93f4c05d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:24:43.077199Z","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-10-09T02:24:43.0773Z","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-10-09T02:24:43.077308Z","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-10-09T02:24:43.079833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"info","ts":"2026-10-09T02:24:43.081439Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","added-peer-id":"777352cb93f4c05d","added-peer-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-10-09T02:24:43.084082Z","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-10-09T02:24:43.08438Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-10-09T02:24:43.084473Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-10-09T02:24:43.084647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"777352cb93f4c05d","initial-advertise-peer-urls":["https://162.253.55.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:24:43.084713Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:24:44.064849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:24:44.064926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:24:44.06496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgPreVoteResp from 777352cb93f4c05d at term 1"} {"level":"info","ts":"2026-10-09T02:24:44.06498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:24:44.064989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgVoteResp from 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-10-09T02:24:44.065004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became leader at term 2"} {"level":"info","ts":"2026-10-09T02:24:44.065022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 777352cb93f4c05d elected leader 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-10-09T02:24:44.067065Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:44.067248Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"777352cb93f4c05d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.164:2379]}","request-path":"/0/members/777352cb93f4c05d/attributes","cluster-id":"ebb6470dab83b2e8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:24:44.067249Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:24:44.067337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:24:44.068171Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:44.068287Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:44.068344Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:44.069743Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:24:44.069833Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:24:44.070768Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T02:24:44.070906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.164:2379"} {"level":"warn","ts":"2026-10-09T02:24:46.167142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.265366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-09T02:24:46.167397Z","caller":"traceutil/trace.go:171","msg":"trace[316775195] linearizableReadLoop","detail":"{readStateIndex:67; appliedIndex:65; }","duration":"274.265996ms","start":"2026-10-09T02:24:45.893111Z","end":"2026-10-09T02:24:46.167377Z","steps":["trace[316775195] 'read index received' (duration: 68.02584ms)","trace[316775195] 'applied index is now lower than readState.Index' (duration: 206.239236ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:46.167677Z","caller":"traceutil/trace.go:171","msg":"trace[806667879] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"300.883765ms","start":"2026-10-09T02:24:45.866782Z","end":"2026-10-09T02:24:46.167666Z","steps":["trace[806667879] 'process raft request' (duration: 300.484885ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:46.167847Z","caller":"traceutil/trace.go:171","msg":"trace[783671455] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"348.652349ms","start":"2026-10-09T02:24:45.819123Z","end":"2026-10-09T02:24:46.167775Z","steps":["trace[783671455] 'process raft request' (duration: 142.096345ms)","trace[783671455] 'compare' (duration: 205.03081ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:46.167926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:45.866757Z","time spent":"300.953656ms","remote":"127.0.0.1:38576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1121,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:46.168119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.008033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-09T02:24:46.16812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:45.819112Z","time spent":"348.864693ms","remote":"127.0.0.1:38576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":581,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:46.168164Z","caller":"traceutil/trace.go:171","msg":"trace[1982214299] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:63; }","duration":"275.097485ms","start":"2026-10-09T02:24:45.893052Z","end":"2026-10-09T02:24:46.168149Z","steps":["trace[1982214299] 'agreement among raft nodes before linearized reading' (duration: 275.017822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:46.168133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.220774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-09T02:24:46.168336Z","caller":"traceutil/trace.go:171","msg":"trace[565387026] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:63; }","duration":"185.457999ms","start":"2026-10-09T02:24:45.9828Z","end":"2026-10-09T02:24:46.168258Z","steps":["trace[565387026] 'agreement among raft nodes before linearized reading' (duration: 185.183703ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:46.536574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.4526ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-09T02:24:46.536961Z","caller":"traceutil/trace.go:171","msg":"trace[86800244] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"363.907571ms","start":"2026-10-09T02:24:46.173029Z","end":"2026-10-09T02:24:46.536936Z","steps":["trace[86800244] 'process raft request' (duration: 261.835367ms)","trace[86800244] 'compare' (duration: 101.237866ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:46.537129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:46.173005Z","time spent":"364.007523ms","remote":"127.0.0.1:38436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:46.537254Z","caller":"traceutil/trace.go:171","msg":"trace[286490909] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"361.887426ms","start":"2026-10-09T02:24:46.175345Z","end":"2026-10-09T02:24:46.537232Z","steps":["trace[286490909] 'process raft request' (duration: 361.452297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:46.537429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:46.175306Z","time spent":"362.036839ms","remote":"127.0.0.1:38576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:46.537521Z","caller":"traceutil/trace.go:171","msg":"trace[1855922327] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"364.261519ms","start":"2026-10-09T02:24:46.173127Z","end":"2026-10-09T02:24:46.537389Z","steps":["trace[1855922327] 'process raft request' (duration: 363.557054ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:46.537685Z","caller":"traceutil/trace.go:171","msg":"trace[1728155880] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"361.365024ms","start":"2026-10-09T02:24:46.176302Z","end":"2026-10-09T02:24:46.537667Z","steps":["trace[1728155880] 'process raft request' (duration: 360.550595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:46.537774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:46.176284Z","time spent":"361.454386ms","remote":"127.0.0.1:38542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:46.537925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:46.173108Z","time spent":"364.590607ms","remote":"127.0.0.1:38576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:46.538525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:46.204642Z","time spent":"333.880217ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-10-09T02:25:37.396263Z","caller":"traceutil/trace.go:171","msg":"trace[1923068462] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"140.164613ms","start":"2026-10-09T02:25:37.25606Z","end":"2026-10-09T02:25:37.396224Z","steps":["trace[1923068462] 'process raft request' (duration: 139.383046ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:37.660204Z","caller":"traceutil/trace.go:171","msg":"trace[1601796517] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"206.763719ms","start":"2026-10-09T02:25:37.453406Z","end":"2026-10-09T02:25:37.66017Z","steps":["trace[1601796517] 'process raft request' (duration: 141.040511ms)","trace[1601796517] 'compare' (duration: 65.469424ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:37.669828Z","caller":"traceutil/trace.go:171","msg":"trace[1471614596] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:679; }","duration":"155.76778ms","start":"2026-10-09T02:25:37.514034Z","end":"2026-10-09T02:25:37.669802Z","steps":["trace[1471614596] 'read index received' (duration: 80.494288ms)","trace[1471614596] 'applied index is now lower than readState.Index' (duration: 75.272382ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:37.669948Z","caller":"traceutil/trace.go:171","msg":"trace[1124273822] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"189.100886ms","start":"2026-10-09T02:25:37.480822Z","end":"2026-10-09T02:25:37.669922Z","steps":["trace[1124273822] 'process raft request' (duration: 188.887611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:37.670052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.997126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.164\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-09T02:25:37.670096Z","caller":"traceutil/trace.go:171","msg":"trace[1084366728] range","detail":"{range_begin:/registry/masterleases/162.253.55.164; range_end:; response_count:1; response_revision:655; }","duration":"156.110418ms","start":"2026-10-09T02:25:37.513971Z","end":"2026-10-09T02:25:37.670082Z","steps":["trace[1084366728] 'agreement among raft nodes before linearized reading' (duration: 155.961635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:37.670503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.109922ms","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-10-09T02:25:37.670681Z","caller":"traceutil/trace.go:171","msg":"trace[1617009084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"128.272606ms","start":"2026-10-09T02:25:37.542326Z","end":"2026-10-09T02:25:37.670599Z","steps":["trace[1617009084] 'agreement among raft nodes before linearized reading' (duration: 127.909088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:38.184273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.901306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:25:38.184441Z","caller":"traceutil/trace.go:171","msg":"trace[460966255] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"192.708266ms","start":"2026-10-09T02:25:37.991708Z","end":"2026-10-09T02:25:38.184416Z","steps":["trace[460966255] 'process raft request' (duration: 56.545953ms)","trace[460966255] 'compare' (duration: 135.735763ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:38.220508Z","caller":"traceutil/trace.go:171","msg":"trace[970648505] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"112.654747ms","start":"2026-10-09T02:25:38.107825Z","end":"2026-10-09T02:25:38.22048Z","steps":["trace[970648505] 'process raft request' (duration: 111.923321ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:52.834479Z","caller":"traceutil/trace.go:171","msg":"trace[362255176] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"213.347647ms","start":"2026-10-09T02:25:52.621098Z","end":"2026-10-09T02:25:52.834446Z","steps":["trace[362255176] 'read index received' (duration: 212.914748ms)","trace[362255176] 'applied index is now lower than readState.Index' (duration: 431.349µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:52.834874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.695865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-09T02:25:52.834926Z","caller":"traceutil/trace.go:171","msg":"trace[677843169] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"293.113979ms","start":"2026-10-09T02:25:52.541767Z","end":"2026-10-09T02:25:52.834881Z","steps":["trace[677843169] 'process raft request' (duration: 292.454244ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:52.835007Z","caller":"traceutil/trace.go:171","msg":"trace[1872037609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:820; }","duration":"213.964232ms","start":"2026-10-09T02:25:52.621024Z","end":"2026-10-09T02:25:52.834988Z","steps":["trace[1872037609] 'agreement among raft nodes before linearized reading' (duration: 213.558603ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:34.950485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.807804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:34.950628Z","caller":"traceutil/trace.go:171","msg":"trace[1105910419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1107; }","duration":"109.01663ms","start":"2026-10-09T02:26:34.841581Z","end":"2026-10-09T02:26:34.950598Z","steps":["trace[1105910419] 'range keys from in-memory index tree' (duration: 108.688733ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:51.694651Z","caller":"traceutil/trace.go:171","msg":"trace[1108671553] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1223; }","duration":"193.292158ms","start":"2026-10-09T02:26:51.501337Z","end":"2026-10-09T02:26:51.694629Z","steps":["trace[1108671553] 'read index received' (duration: 97.469023ms)","trace[1108671553] 'applied index is now lower than readState.Index' (duration: 95.822145ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:51.694763Z","caller":"traceutil/trace.go:171","msg":"trace[177170948] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"233.262499ms","start":"2026-10-09T02:26:51.461492Z","end":"2026-10-09T02:26:51.694755Z","steps":["trace[177170948] 'process raft request' (duration: 137.029954ms)","trace[177170948] 'compare' (duration: 95.97344ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:51.695021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.657016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:51.695152Z","caller":"traceutil/trace.go:171","msg":"trace[2066147029] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1178; }","duration":"193.830369ms","start":"2026-10-09T02:26:51.501296Z","end":"2026-10-09T02:26:51.695126Z","steps":["trace[2066147029] 'agreement among raft nodes before linearized reading' (duration: 193.635615ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:52.361567Z","caller":"traceutil/trace.go:171","msg":"trace[1167483678] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"126.983601ms","start":"2026-10-09T02:26:52.234549Z","end":"2026-10-09T02:26:52.361532Z","steps":["trace[1167483678] 'process raft request' (duration: 122.081241ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:52.836369Z","caller":"traceutil/trace.go:171","msg":"trace[1090243388] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"100.803246ms","start":"2026-10-09T02:26:52.735538Z","end":"2026-10-09T02:26:52.836341Z","steps":["trace[1090243388] 'process raft request' (duration: 100.593312ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:53.330904Z","caller":"traceutil/trace.go:171","msg":"trace[1695776170] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"131.697656ms","start":"2026-10-09T02:26:53.199172Z","end":"2026-10-09T02:26:53.330869Z","steps":["trace[1695776170] 'process raft request' (duration: 121.713154ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:53.346606Z","caller":"traceutil/trace.go:171","msg":"trace[639019820] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"143.470848ms","start":"2026-10-09T02:26:53.203116Z","end":"2026-10-09T02:26:53.346586Z","steps":["trace[639019820] 'process raft request' (duration: 143.422317ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:53.346979Z","caller":"traceutil/trace.go:171","msg":"trace[44690432] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"145.955652ms","start":"2026-10-09T02:26:53.20092Z","end":"2026-10-09T02:26:53.346876Z","steps":["trace[44690432] 'process raft request' (duration: 145.506023ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:08.202786Z","caller":"traceutil/trace.go:171","msg":"trace[2093180728] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"297.41525ms","start":"2026-10-09T02:27:07.905339Z","end":"2026-10-09T02:27:08.202754Z","steps":["trace[2093180728] 'process raft request' (duration: 297.243795ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:08.279406Z","caller":"traceutil/trace.go:171","msg":"trace[767794093] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1334; }","duration":"195.057798ms","start":"2026-10-09T02:27:08.084316Z","end":"2026-10-09T02:27:08.279374Z","steps":["trace[767794093] 'read index received' (duration: 118.290927ms)","trace[767794093] 'applied index is now lower than readState.Index' (duration: 76.765481ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:08.279637Z","caller":"traceutil/trace.go:171","msg":"trace[1240262005] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"231.383356ms","start":"2026-10-09T02:27:08.048241Z","end":"2026-10-09T02:27:08.279624Z","steps":["trace[1240262005] 'process raft request' (duration: 230.924236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:27:08.279928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.336946ms","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-10-09T02:27:08.280008Z","caller":"traceutil/trace.go:171","msg":"trace[1000941364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1286; }","duration":"144.476331ms","start":"2026-10-09T02:27:08.135509Z","end":"2026-10-09T02:27:08.279985Z","steps":["trace[1000941364] 'agreement among raft nodes before linearized reading' (duration: 144.240276ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:27:08.279946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.60809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-09T02:27:08.280124Z","caller":"traceutil/trace.go:171","msg":"trace[1499710791] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1286; }","duration":"195.831655ms","start":"2026-10-09T02:27:08.084263Z","end":"2026-10-09T02:27:08.280095Z","steps":["trace[1499710791] 'agreement among raft nodes before linearized reading' (duration: 195.504378ms)"],"step_count":1}