{"level":"warn","ts":"2026-10-09T02:25:25.577411Z","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:25:25.577485Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.250: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.250:2380","--initial-cluster=instance=https://162.253.55.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.250: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:25:25.577552Z","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:25:25.577561Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.250:2380"]} {"level":"info","ts":"2026-10-09T02:25:25.577577Z","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:25:25.578179Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"]} {"level":"info","ts":"2026-10-09T02:25:25.578257Z","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.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.250: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:25:25.582358Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.916649ms"} {"level":"info","ts":"2026-10-09T02:25:25.591014Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e4a0bccff66c64d","cluster-id":"8ba64f6e83da771"} {"level":"info","ts":"2026-10-09T02:25:25.591115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:25:25.591151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 0"} {"level":"info","ts":"2026-10-09T02:25:25.591165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e4a0bccff66c64d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:25:25.591177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became follower at term 1"} {"level":"info","ts":"2026-10-09T02:25:25.591253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"} {"level":"warn","ts":"2026-10-09T02:25:25.598317Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:25:25.599727Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:25:25.600935Z","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:25:25.604164Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e4a0bccff66c64d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:25:25.604645Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e4a0bccff66c64d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:25:25.606814Z","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:25:25.606892Z","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:25:25.606902Z","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:25:25.607416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d switched to configuration voters=(2182569944500586061)"} {"level":"info","ts":"2026-10-09T02:25:25.607929Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","added-peer-id":"1e4a0bccff66c64d","added-peer-peer-urls":["https://162.253.55.250:2380"]} {"level":"info","ts":"2026-10-09T02:25:25.608579Z","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:25:25.608732Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e4a0bccff66c64d","initial-advertise-peer-urls":["https://162.253.55.250:2380"],"listen-peer-urls":["https://162.253.55.250:2380"],"advertise-client-urls":["https://162.253.55.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:25:25.608752Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:25:25.608807Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.250:2380"} {"level":"info","ts":"2026-10-09T02:25:25.608815Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.250:2380"} {"level":"info","ts":"2026-10-09T02:25:25.992303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:25:25.992366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:25:25.992403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgPreVoteResp from 1e4a0bccff66c64d at term 1"} {"level":"info","ts":"2026-10-09T02:25:25.992423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:25:25.992439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d received MsgVoteResp from 1e4a0bccff66c64d at term 2"} {"level":"info","ts":"2026-10-09T02:25:25.992455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e4a0bccff66c64d became leader at term 2"} {"level":"info","ts":"2026-10-09T02:25:25.992472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e4a0bccff66c64d elected leader 1e4a0bccff66c64d at term 2"} {"level":"info","ts":"2026-10-09T02:25:25.993517Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e4a0bccff66c64d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.250:2379]}","request-path":"/0/members/1e4a0bccff66c64d/attributes","cluster-id":"8ba64f6e83da771","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:25:25.99353Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:25:25.993747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:25:25.99379Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:25:25.993987Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:25:25.994037Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:25:25.99444Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ba64f6e83da771","local-member-id":"1e4a0bccff66c64d","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:25:25.994641Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:25:25.994724Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:25:25.997033Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.250:2379"} {"level":"info","ts":"2026-10-09T02:25:25.99828Z","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:25:28.5827Z","caller":"traceutil/trace.go:171","msg":"trace[1494361787] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"104.564458ms","start":"2026-10-09T02:25:28.47811Z","end":"2026-10-09T02:25:28.582675Z","steps":["trace[1494361787] 'read index received' (duration: 104.342562ms)","trace[1494361787] 'applied index is now lower than readState.Index' (duration: 220.886µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:28.583016Z","caller":"traceutil/trace.go:171","msg":"trace[280183426] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"106.863228ms","start":"2026-10-09T02:25:28.476136Z","end":"2026-10-09T02:25:28.582999Z","steps":["trace[280183426] 'process raft request' (duration: 106.392314ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:28.583343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.186186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-09T02:25:28.583433Z","caller":"traceutil/trace.go:171","msg":"trace[1434513859] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:113; }","duration":"105.340731ms","start":"2026-10-09T02:25:28.478074Z","end":"2026-10-09T02:25:28.583414Z","steps":["trace[1434513859] 'agreement among raft nodes before linearized reading' (duration: 105.156376ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:16.917966Z","caller":"traceutil/trace.go:171","msg":"trace[1305220031] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"247.303556ms","start":"2026-10-09T02:26:16.670635Z","end":"2026-10-09T02:26:16.917939Z","steps":["trace[1305220031] 'read index received' (duration: 246.321657ms)","trace[1305220031] 'applied index is now lower than readState.Index' (duration: 981.099µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:16.918061Z","caller":"traceutil/trace.go:171","msg":"trace[785280480] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"390.526079ms","start":"2026-10-09T02:26:16.527519Z","end":"2026-10-09T02:26:16.918045Z","steps":["trace[785280480] 'process raft request' (duration: 389.933211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:16.918171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.527394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h4cj5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-09T02:26:16.918226Z","caller":"traceutil/trace.go:171","msg":"trace[1430810583] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h4cj5; range_end:; response_count:1; response_revision:644; }","duration":"247.593976ms","start":"2026-10-09T02:26:16.670598Z","end":"2026-10-09T02:26:16.918192Z","steps":["trace[1430810583] 'agreement among raft nodes before linearized reading' (duration: 247.470761ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:16.91836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.440729ms","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-10-09T02:26:16.918456Z","caller":"traceutil/trace.go:171","msg":"trace[84964399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:644; }","duration":"217.594784ms","start":"2026-10-09T02:26:16.700835Z","end":"2026-10-09T02:26:16.91843Z","steps":["trace[84964399] 'agreement among raft nodes before linearized reading' (duration: 217.290975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:16.918696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:16.527489Z","time spent":"390.605102ms","remote":"127.0.0.1:47648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:26:17.084268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.439188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:26:17.084381Z","caller":"traceutil/trace.go:171","msg":"trace[1042340887] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"162.583122ms","start":"2026-10-09T02:26:16.921776Z","end":"2026-10-09T02:26:17.084359Z","steps":["trace[1042340887] 'process raft request' (duration: 48.718431ms)","trace[1042340887] 'compare' (duration: 113.17412ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:17.167136Z","caller":"traceutil/trace.go:171","msg":"trace[1379921030] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"204.402633ms","start":"2026-10-09T02:26:16.962693Z","end":"2026-10-09T02:26:17.167096Z","steps":["trace[1379921030] 'process raft request' (duration: 204.113434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:17.674788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14289254344997493879,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:26:17.821323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.997522ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:17.82146Z","caller":"traceutil/trace.go:171","msg":"trace[723677985] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"587.133216ms","start":"2026-10-09T02:26:17.234297Z","end":"2026-10-09T02:26:17.82143Z","steps":["trace[723677985] 'range keys from in-memory index tree' (duration: 586.981432ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:17.821605Z","caller":"traceutil/trace.go:171","msg":"trace[1434514203] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"647.392047ms","start":"2026-10-09T02:26:17.174174Z","end":"2026-10-09T02:26:17.821566Z","steps":["trace[1434514203] 'read index received' (duration: 618.573271ms)","trace[1434514203] 'applied index is now lower than readState.Index' (duration: 28.817536ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:17.82175Z","caller":"traceutil/trace.go:171","msg":"trace[709539383] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"822.404326ms","start":"2026-10-09T02:26:16.99933Z","end":"2026-10-09T02:26:17.821734Z","steps":["trace[709539383] 'process raft request' (duration: 793.473807ms)","trace[709539383] 'compare' (duration: 28.190176ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:17.821844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:16.999306Z","time spent":"822.473958ms","remote":"127.0.0.1:42302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:26:17.821863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.294177ms","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:17.821911Z","caller":"traceutil/trace.go:171","msg":"trace[1681162676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"451.379559ms","start":"2026-10-09T02:26:17.370521Z","end":"2026-10-09T02:26:17.821901Z","steps":["trace[1681162676] 'agreement among raft nodes before linearized reading' (duration: 451.263426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:17.82195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:17.370502Z","time spent":"451.43085ms","remote":"127.0.0.1:47596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:26:17.821978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.767129ms","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:26:17.822071Z","caller":"traceutil/trace.go:171","msg":"trace[884186213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"647.913953ms","start":"2026-10-09T02:26:17.174137Z","end":"2026-10-09T02:26:17.822051Z","steps":["trace[884186213] 'agreement among raft nodes before linearized reading' (duration: 647.650235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:17.82211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:17.17412Z","time spent":"647.979945ms","remote":"127.0.0.1:42204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-09T02:26:18.410909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.838454ms","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:26:18.410985Z","caller":"traceutil/trace.go:171","msg":"trace[813843789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"350.957167ms","start":"2026-10-09T02:26:18.060007Z","end":"2026-10-09T02:26:18.410964Z","steps":["trace[813843789] 'range keys from in-memory index tree' (duration: 350.676249ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:18.41102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:18.059987Z","time spent":"351.024449ms","remote":"127.0.0.1:42204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-09T02:26:18.437125Z","caller":"traceutil/trace.go:171","msg":"trace[393978334] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"194.737749ms","start":"2026-10-09T02:26:18.242364Z","end":"2026-10-09T02:26:18.437102Z","steps":["trace[393978334] 'process raft request' (duration: 194.007978ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:32.992092Z","caller":"traceutil/trace.go:171","msg":"trace[1684616243] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"213.821394ms","start":"2026-10-09T02:26:32.778249Z","end":"2026-10-09T02:26:32.99207Z","steps":["trace[1684616243] 'read index received' (duration: 213.66516ms)","trace[1684616243] 'applied index is now lower than readState.Index' (duration: 155.344µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:32.992296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.028731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9rz5m\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-09T02:26:32.992352Z","caller":"traceutil/trace.go:171","msg":"trace[1270194813] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"217.163246ms","start":"2026-10-09T02:26:32.775174Z","end":"2026-10-09T02:26:32.992337Z","steps":["trace[1270194813] 'process raft request' (duration: 216.758874ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:32.992327Z","caller":"traceutil/trace.go:171","msg":"trace[683035434] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9rz5m; range_end:; response_count:1; response_revision:813; }","duration":"214.072322ms","start":"2026-10-09T02:26:32.778244Z","end":"2026-10-09T02:26:32.992316Z","steps":["trace[683035434] 'agreement among raft nodes before linearized reading' (duration: 213.913287ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:16.424405Z","caller":"traceutil/trace.go:171","msg":"trace[1551201627] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1157; }","duration":"194.771201ms","start":"2026-10-09T02:27:16.229615Z","end":"2026-10-09T02:27:16.424386Z","steps":["trace[1551201627] 'read index received' (duration: 194.548824ms)","trace[1551201627] 'applied index is now lower than readState.Index' (duration: 221.617µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:16.424468Z","caller":"traceutil/trace.go:171","msg":"trace[180197297] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"223.372837ms","start":"2026-10-09T02:27:16.201074Z","end":"2026-10-09T02:27:16.424446Z","steps":["trace[180197297] 'process raft request' (duration: 223.19422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:27:16.424635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.016859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:27:16.424673Z","caller":"traceutil/trace.go:171","msg":"trace[553520762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1116; }","duration":"195.106391ms","start":"2026-10-09T02:27:16.229555Z","end":"2026-10-09T02:27:16.424662Z","steps":["trace[553520762] 'agreement among raft nodes before linearized reading' (duration: 194.963587ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:16.541863Z","caller":"traceutil/trace.go:171","msg":"trace[618311287] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"105.88618ms","start":"2026-10-09T02:27:16.435949Z","end":"2026-10-09T02:27:16.541835Z","steps":["trace[618311287] 'process raft request' (duration: 67.96525ms)","trace[618311287] 'compare' (duration: 37.513898ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:38.226866Z","caller":"traceutil/trace.go:171","msg":"trace[1830018753] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"132.833611ms","start":"2026-10-09T02:27:38.093989Z","end":"2026-10-09T02:27:38.226823Z","steps":["trace[1830018753] 'process raft request' (duration: 132.626805ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:38.421889Z","caller":"traceutil/trace.go:171","msg":"trace[2112618517] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"183.959728ms","start":"2026-10-09T02:27:38.23791Z","end":"2026-10-09T02:27:38.42187Z","steps":["trace[2112618517] 'read index received' (duration: 182.980669ms)","trace[2112618517] 'applied index is now lower than readState.Index' (duration: 970.179µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:38.421905Z","caller":"traceutil/trace.go:171","msg":"trace[70119939] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"190.064794ms","start":"2026-10-09T02:27:38.231815Z","end":"2026-10-09T02:27:38.42188Z","steps":["trace[70119939] 'process raft request' (duration: 189.088305ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:27:38.42202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.086692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-09T02:27:38.422055Z","caller":"traceutil/trace.go:171","msg":"trace[120130099] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1244; }","duration":"184.160274ms","start":"2026-10-09T02:27:38.237885Z","end":"2026-10-09T02:27:38.422045Z","steps":["trace[120130099] 'agreement among raft nodes before linearized reading' (duration: 184.083042ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:39.173347Z","caller":"traceutil/trace.go:171","msg":"trace[1214169193] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"249.373634ms","start":"2026-10-09T02:27:38.923948Z","end":"2026-10-09T02:27:39.173321Z","steps":["trace[1214169193] 'process raft request' (duration: 249.200018ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:43.679927Z","caller":"traceutil/trace.go:171","msg":"trace[1150000362] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"147.872362ms","start":"2026-10-09T02:27:43.532032Z","end":"2026-10-09T02:27:43.679904Z","steps":["trace[1150000362] 'process raft request' (duration: 147.709066ms)"],"step_count":1}