{"level":"warn","ts":"2026-09-02T01:11:22.819686Z","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-02T01:11:22.819779Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-02T01:11:22.819848Z","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-02T01:11:22.819856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-02T01:11:22.819874Z","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-02T01:11:22.820726Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-09-02T01:11:22.820825Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-02T01:11:22.827411Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.299115ms"} {"level":"info","ts":"2026-09-02T01:11:22.837191Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-09-02T01:11:22.83727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T01:11:22.837292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-09-02T01:11:22.837303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-02T01:11:22.837308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-09-02T01:11:22.837336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-09-02T01:11:22.852876Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T01:11:22.854604Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T01:11:22.858496Z","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-02T01:11:22.860568Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-02T01:11:22.863496Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-02T01:11:22.865352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-09-02T01:11:22.86531Z","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-02T01:11:22.865446Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-02T01:11:22.865583Z","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-02T01:11:22.865652Z","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-02T01:11:22.865664Z","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-02T01:11:22.865669Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-02T01:11:22.865703Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T01:11:22.865768Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-02T01:11:22.865799Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-02T01:11:23.439318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T01:11:23.439804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T01:11:23.439844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-09-02T01:11:23.43987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-09-02T01:11:23.43988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-02T01:11:23.439922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-09-02T01:11:23.439935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-02T01:11:23.443868Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-09-02T01:11:23.444031Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T01:11:23.44418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T01:11:23.444684Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:11:23.44485Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T01:11:23.444872Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T01:11:23.445326Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:11:23.445406Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:11:23.445436Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:11:23.44683Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-02T01:11:23.459998Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-09-02T01:11:41.258692Z","caller":"traceutil/trace.go:171","msg":"trace[1420569009] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"126.342239ms","start":"2026-09-02T01:11:41.132319Z","end":"2026-09-02T01:11:41.258661Z","steps":["trace[1420569009] 'process raft request' (duration: 126.204617ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:11:41.584317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.914528ms","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-02T01:11:41.584515Z","caller":"traceutil/trace.go:171","msg":"trace[826875143] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:418; }","duration":"134.157931ms","start":"2026-09-02T01:11:41.450338Z","end":"2026-09-02T01:11:41.584496Z","steps":["trace[826875143] 'range keys from in-memory index tree' (duration: 133.807327ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:11:41.584414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.448815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-02T01:11:41.584643Z","caller":"traceutil/trace.go:171","msg":"trace[818115782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:418; }","duration":"121.771539ms","start":"2026-09-02T01:11:41.462848Z","end":"2026-09-02T01:11:41.58462Z","steps":["trace[818115782] 'range keys from in-memory index tree' (duration: 121.280863ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:41.703953Z","caller":"traceutil/trace.go:171","msg":"trace[1737013746] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"114.699247ms","start":"2026-09-02T01:11:41.589223Z","end":"2026-09-02T01:11:41.703923Z","steps":["trace[1737013746] 'process raft request' (duration: 114.508285ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:41.718337Z","caller":"traceutil/trace.go:171","msg":"trace[25232888] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"128.637958ms","start":"2026-09-02T01:11:41.589643Z","end":"2026-09-02T01:11:41.718281Z","steps":["trace[25232888] 'process raft request' (duration: 128.515347ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:19.212184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.328483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T01:12:19.212347Z","caller":"traceutil/trace.go:171","msg":"trace[268325844] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"228.775075ms","start":"2026-09-02T01:12:18.983549Z","end":"2026-09-02T01:12:19.212324Z","steps":["trace[268325844] 'process raft request' (duration: 59.705863ms)","trace[268325844] 'compare' (duration: 168.184962ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:19.213068Z","caller":"traceutil/trace.go:171","msg":"trace[354951014] transaction","detail":"{read_only:false; number_of_response:1; response_revision:582; }","duration":"221.262502ms","start":"2026-09-02T01:12:18.991773Z","end":"2026-09-02T01:12:19.213035Z","steps":["trace[354951014] 'process raft request' (duration: 221.033469ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.213251Z","caller":"traceutil/trace.go:171","msg":"trace[564488330] transaction","detail":"{read_only:false; number_of_response:1; response_revision:583; }","duration":"217.729017ms","start":"2026-09-02T01:12:18.995479Z","end":"2026-09-02T01:12:19.213208Z","steps":["trace[564488330] 'process raft request' (duration: 217.503584ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.213445Z","caller":"traceutil/trace.go:171","msg":"trace[1387980608] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"221.362093ms","start":"2026-09-02T01:12:18.99207Z","end":"2026-09-02T01:12:19.213432Z","steps":["trace[1387980608] 'process raft request' (duration: 220.838627ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.21355Z","caller":"traceutil/trace.go:171","msg":"trace[533243285] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"210.465998ms","start":"2026-09-02T01:12:19.003065Z","end":"2026-09-02T01:12:19.213531Z","steps":["trace[533243285] 'process raft request' (duration: 209.962551ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.213889Z","caller":"traceutil/trace.go:171","msg":"trace[1214569604] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"209.947991ms","start":"2026-09-02T01:12:19.00391Z","end":"2026-09-02T01:12:19.213858Z","steps":["trace[1214569604] 'process raft request' (duration: 209.338963ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.214287Z","caller":"traceutil/trace.go:171","msg":"trace[842819448] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"209.199412ms","start":"2026-09-02T01:12:19.005073Z","end":"2026-09-02T01:12:19.214273Z","steps":["trace[842819448] 'process raft request' (duration: 208.470773ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.214508Z","caller":"traceutil/trace.go:171","msg":"trace[1873764756] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"210.65481ms","start":"2026-09-02T01:12:19.003122Z","end":"2026-09-02T01:12:19.213777Z","steps":["trace[1873764756] 'process raft request' (duration: 209.967551ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.215586Z","caller":"traceutil/trace.go:171","msg":"trace[1985716953] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"206.238185ms","start":"2026-09-02T01:12:19.008745Z","end":"2026-09-02T01:12:19.214983Z","steps":["trace[1985716953] 'process raft request' (duration: 205.743229ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.218305Z","caller":"traceutil/trace.go:171","msg":"trace[1307146857] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:602; }","duration":"180.296461ms","start":"2026-09-02T01:12:19.037907Z","end":"2026-09-02T01:12:19.218204Z","steps":["trace[1307146857] 'read index received' (duration: 5.386397ms)","trace[1307146857] 'applied index is now lower than readState.Index' (duration: 174.826343ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:19.218907Z","caller":"traceutil/trace.go:171","msg":"trace[1609441152] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"200.242549ms","start":"2026-09-02T01:12:19.018636Z","end":"2026-09-02T01:12:19.218878Z","steps":["trace[1609441152] 'process raft request' (duration: 196.21345ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:19.222424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.493974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:19.222496Z","caller":"traceutil/trace.go:171","msg":"trace[445583285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"184.580605ms","start":"2026-09-02T01:12:19.037887Z","end":"2026-09-02T01:12:19.222468Z","steps":["trace[445583285] 'agreement among raft nodes before linearized reading' (duration: 180.495493ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.225596Z","caller":"traceutil/trace.go:171","msg":"trace[1824719078] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"110.011608ms","start":"2026-09-02T01:12:19.115566Z","end":"2026-09-02T01:12:19.225578Z","steps":["trace[1824719078] 'process raft request' (duration: 109.732804ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.870265Z","caller":"traceutil/trace.go:171","msg":"trace[1761716766] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"300.733239ms","start":"2026-09-02T01:12:19.569496Z","end":"2026-09-02T01:12:19.870229Z","steps":["trace[1761716766] 'process raft request' (duration: 201.334353ms)","trace[1761716766] 'compare' (duration: 99.000732ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:19.870358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:19.569484Z","time spent":"300.82887ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-02T01:12:19.870566Z","caller":"traceutil/trace.go:171","msg":"trace[2138752039] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"278.971289ms","start":"2026-09-02T01:12:19.591546Z","end":"2026-09-02T01:12:19.870517Z","steps":["trace[2138752039] 'process raft request' (duration: 278.545894ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.870618Z","caller":"traceutil/trace.go:171","msg":"trace[1960602706] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"258.415483ms","start":"2026-09-02T01:12:19.612169Z","end":"2026-09-02T01:12:19.870584Z","steps":["trace[1960602706] 'process raft request' (duration: 258.017558ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.870811Z","caller":"traceutil/trace.go:171","msg":"trace[1286892676] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"245.996478ms","start":"2026-09-02T01:12:19.624802Z","end":"2026-09-02T01:12:19.870798Z","steps":["trace[1286892676] 'process raft request' (duration: 245.483632ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:19.870823Z","caller":"traceutil/trace.go:171","msg":"trace[527123485] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"195.362089ms","start":"2026-09-02T01:12:19.675435Z","end":"2026-09-02T01:12:19.870797Z","steps":["trace[527123485] 'process raft request' (duration: 195.047436ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.49296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.247295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T01:12:26.493148Z","caller":"traceutil/trace.go:171","msg":"trace[4176072] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"547.127711ms","start":"2026-09-02T01:12:25.945987Z","end":"2026-09-02T01:12:26.493115Z","steps":["trace[4176072] 'process raft request' (duration: 19.634663ms)","trace[4176072] 'compare' (duration: 527.122533ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:26.493188Z","caller":"traceutil/trace.go:171","msg":"trace[472547969] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"490.774294ms","start":"2026-09-02T01:12:26.002398Z","end":"2026-09-02T01:12:26.493172Z","steps":["trace[472547969] 'process raft request' (duration: 490.681863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.493237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:25.945964Z","time spent":"547.229582ms","remote":"127.0.0.1:44100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T01:12:26.493261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:26.002376Z","time spent":"490.854445ms","remote":"127.0.0.1:44302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-02T01:12:26.493286Z","caller":"traceutil/trace.go:171","msg":"trace[987648876] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"546.022917ms","start":"2026-09-02T01:12:25.947207Z","end":"2026-09-02T01:12:26.49323Z","steps":["trace[987648876] 'read index received' (duration: 18.336887ms)","trace[987648876] 'applied index is now lower than readState.Index' (duration: 527.67762ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:26.493565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.335732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-02T01:12:26.493603Z","caller":"traceutil/trace.go:171","msg":"trace[1602962957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"546.423683ms","start":"2026-09-02T01:12:25.947167Z","end":"2026-09-02T01:12:26.493591Z","steps":["trace[1602962957] 'agreement among raft nodes before linearized reading' (duration: 546.22691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.493661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:25.947149Z","time spent":"546.504173ms","remote":"127.0.0.1:44100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-02T01:12:26.522827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.477483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:26.522885Z","caller":"traceutil/trace.go:171","msg":"trace[1101029351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"482.583954ms","start":"2026-09-02T01:12:26.040287Z","end":"2026-09-02T01:12:26.522871Z","steps":["trace[1101029351] 'agreement among raft nodes before linearized reading' (duration: 482.480673ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.522918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:26.040265Z","time spent":"482.647504ms","remote":"127.0.0.1:43792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-02T01:12:26.523025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.279212ms","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-02T01:12:26.52308Z","caller":"traceutil/trace.go:171","msg":"trace[1591720133] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"568.355483ms","start":"2026-09-02T01:12:25.954708Z","end":"2026-09-02T01:12:26.523064Z","steps":["trace[1591720133] 'agreement among raft nodes before linearized reading' (duration: 568.207721ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.523135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:25.954697Z","time spent":"568.430395ms","remote":"127.0.0.1:44100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-02T01:12:27.97073Z","caller":"traceutil/trace.go:171","msg":"trace[964836850] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:728; }","duration":"133.66513ms","start":"2026-09-02T01:12:27.837042Z","end":"2026-09-02T01:12:27.970707Z","steps":["trace[964836850] 'read index received' (duration: 133.531569ms)","trace[964836850] 'applied index is now lower than readState.Index' (duration: 132.291µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:27.970887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.817812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.970927Z","caller":"traceutil/trace.go:171","msg":"trace[377847008] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"133.902314ms","start":"2026-09-02T01:12:27.837011Z","end":"2026-09-02T01:12:27.970914Z","steps":["trace[377847008] 'agreement among raft nodes before linearized reading' (duration: 133.820093ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:27.970893Z","caller":"traceutil/trace.go:171","msg":"trace[1793301231] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"134.828766ms","start":"2026-09-02T01:12:27.83597Z","end":"2026-09-02T01:12:27.970799Z","steps":["trace[1793301231] 'process raft request' (duration: 134.585793ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.359717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971174Z","caller":"traceutil/trace.go:171","msg":"trace[1261239643] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"133.494259ms","start":"2026-09-02T01:12:27.837662Z","end":"2026-09-02T01:12:27.971156Z","steps":["trace[1261239643] 'agreement among raft nodes before linearized reading' (duration: 133.345727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.103447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971385Z","caller":"traceutil/trace.go:171","msg":"trace[2106491259] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"130.176797ms","start":"2026-09-02T01:12:27.841197Z","end":"2026-09-02T01:12:27.971373Z","steps":["trace[2106491259] 'agreement among raft nodes before linearized reading' (duration: 130.105067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.074231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971476Z","caller":"traceutil/trace.go:171","msg":"trace[1283655375] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"132.112331ms","start":"2026-09-02T01:12:27.83934Z","end":"2026-09-02T01:12:27.971453Z","steps":["trace[1283655375] 'agreement among raft nodes before linearized reading' (duration: 132.054641ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.241913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-02T01:12:27.971561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.667564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971563Z","caller":"traceutil/trace.go:171","msg":"trace[1882286156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"132.343794ms","start":"2026-09-02T01:12:27.839207Z","end":"2026-09-02T01:12:27.971551Z","steps":["trace[1882286156] 'agreement among raft nodes before linearized reading' (duration: 132.196452ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:27.971588Z","caller":"traceutil/trace.go:171","msg":"trace[1345962283] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"126.726854ms","start":"2026-09-02T01:12:27.844853Z","end":"2026-09-02T01:12:27.971579Z","steps":["trace[1345962283] 'agreement among raft nodes before linearized reading' (duration: 126.689973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.298647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971671Z","caller":"traceutil/trace.go:171","msg":"trace[1182245122] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"104.47604ms","start":"2026-09-02T01:12:27.867188Z","end":"2026-09-02T01:12:27.971664Z","steps":["trace[1182245122] 'agreement among raft nodes before linearized reading' (duration: 104.309728ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.781838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971756Z","caller":"traceutil/trace.go:171","msg":"trace[688534955] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"127.830758ms","start":"2026-09-02T01:12:27.843917Z","end":"2026-09-02T01:12:27.971748Z","steps":["trace[688534955] 'agreement among raft nodes before linearized reading' (duration: 127.788867ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.971785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.775545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.971827Z","caller":"traceutil/trace.go:171","msg":"trace[1102150109] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"130.859786ms","start":"2026-09-02T01:12:27.840956Z","end":"2026-09-02T01:12:27.971816Z","steps":["trace[1102150109] 'agreement among raft nodes before linearized reading' (duration: 130.785885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:27.972083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.090499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:12:27.972162Z","caller":"traceutil/trace.go:171","msg":"trace[59259242] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:703; }","duration":"131.19355ms","start":"2026-09-02T01:12:27.840953Z","end":"2026-09-02T01:12:27.972147Z","steps":["trace[59259242] 'agreement among raft nodes before linearized reading' (duration: 130.38896ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:42.129342Z","caller":"traceutil/trace.go:171","msg":"trace[1471589257] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"367.131634ms","start":"2026-09-02T01:12:41.762187Z","end":"2026-09-02T01:12:42.129319Z","steps":["trace[1471589257] 'process raft request' (duration: 366.984232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:42.129493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:41.762145Z","time spent":"367.269135ms","remote":"127.0.0.1:44016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T01:12:42.159026Z","caller":"traceutil/trace.go:171","msg":"trace[1729690332] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:874; }","duration":"123.587758ms","start":"2026-09-02T01:12:42.03538Z","end":"2026-09-02T01:12:42.158967Z","steps":["trace[1729690332] 'read index received' (duration: 93.769225ms)","trace[1729690332] 'applied index is now lower than readState.Index' (duration: 29.816663ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:42.159214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.805611ms","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-09-02T01:12:42.159296Z","caller":"traceutil/trace.go:171","msg":"trace[1398378016] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:846; }","duration":"123.957143ms","start":"2026-09-02T01:12:42.035324Z","end":"2026-09-02T01:12:42.159281Z","steps":["trace[1398378016] 'agreement among raft nodes before linearized reading' (duration: 123.663419ms)"],"step_count":1}