{"level":"warn","ts":"2026-09-10T17:43:35.17024Z","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-10T17:43:35.170365Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.111: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.111:2380","--initial-cluster=instance=https://162.253.55.111:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.111:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.111: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-10T17:43:35.17046Z","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-10T17:43:35.170472Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.111:2380"]} {"level":"info","ts":"2026-09-10T17:43:35.170508Z","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-10T17:43:35.171202Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"]} {"level":"info","ts":"2026-09-10T17:43:35.171288Z","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.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.111: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-10T17:43:35.177784Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.202945ms"} {"level":"info","ts":"2026-09-10T17:43:35.453284Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"299bf3744060cbd","cluster-id":"83d94f04ddaf7996"} {"level":"info","ts":"2026-09-10T17:43:35.45341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=()"} {"level":"info","ts":"2026-09-10T17:43:35.453489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 0"} {"level":"info","ts":"2026-09-10T17:43:35.453542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 299bf3744060cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-10T17:43:35.453567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became follower at term 1"} {"level":"info","ts":"2026-09-10T17:43:35.453772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"} {"level":"warn","ts":"2026-09-10T17:43:35.463426Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-10T17:43:35.465263Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-10T17:43:35.466469Z","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-10T17:43:35.469431Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"299bf3744060cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-10T17:43:35.469683Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"299bf3744060cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-10T17:43:35.469828Z","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-10T17:43:35.470129Z","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-10T17:43:35.47016Z","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-10T17:43:35.472211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd switched to configuration voters=(187391103597939901)"} {"level":"info","ts":"2026-09-10T17:43:35.472695Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","added-peer-id":"299bf3744060cbd","added-peer-peer-urls":["https://162.253.55.111:2380"]} {"level":"info","ts":"2026-09-10T17:43:35.475956Z","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-10T17:43:35.476069Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.111:2380"} {"level":"info","ts":"2026-09-10T17:43:35.476108Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.111:2380"} {"level":"info","ts":"2026-09-10T17:43:35.476448Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"299bf3744060cbd","initial-advertise-peer-urls":["https://162.253.55.111:2380"],"listen-peer-urls":["https://162.253.55.111:2380"],"advertise-client-urls":["https://162.253.55.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-10T17:43:35.476497Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-10T17:43:36.45468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd is starting a new election at term 1"} {"level":"info","ts":"2026-09-10T17:43:36.454726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-09-10T17:43:36.45475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgPreVoteResp from 299bf3744060cbd at term 1"} {"level":"info","ts":"2026-09-10T17:43:36.454764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became candidate at term 2"} {"level":"info","ts":"2026-09-10T17:43:36.454771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd received MsgVoteResp from 299bf3744060cbd at term 2"} {"level":"info","ts":"2026-09-10T17:43:36.454781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"299bf3744060cbd became leader at term 2"} {"level":"info","ts":"2026-09-10T17:43:36.454793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 299bf3744060cbd elected leader 299bf3744060cbd at term 2"} {"level":"info","ts":"2026-09-10T17:43:36.455668Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:43:36.456319Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"299bf3744060cbd","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.111:2379]}","request-path":"/0/members/299bf3744060cbd/attributes","cluster-id":"83d94f04ddaf7996","publish-timeout":"7s"} {"level":"info","ts":"2026-09-10T17:43:36.456639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T17:43:36.456762Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T17:43:36.456901Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-10T17:43:36.456952Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-10T17:43:36.45716Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"83d94f04ddaf7996","local-member-id":"299bf3744060cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:43:36.457285Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:43:36.457321Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T17:43:36.458829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-10T17:43:36.458983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.111:2379"} {"level":"info","ts":"2026-09-10T17:43:38.150704Z","caller":"traceutil/trace.go:171","msg":"trace[329897187] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"138.699727ms","start":"2026-09-10T17:43:38.011965Z","end":"2026-09-10T17:43:38.150665Z","steps":["trace[329897187] 'process raft request' (duration: 138.487343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:38.151323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.165746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-10T17:43:38.151413Z","caller":"traceutil/trace.go:171","msg":"trace[2051979846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:9; }","duration":"138.262848ms","start":"2026-09-10T17:43:38.013104Z","end":"2026-09-10T17:43:38.151367Z","steps":["trace[2051979846] 'agreement among raft nodes before linearized reading' (duration: 138.151015ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:38.151277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.608175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-10T17:43:38.151525Z","caller":"traceutil/trace.go:171","msg":"trace[1184767138] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"126.891151ms","start":"2026-09-10T17:43:38.024611Z","end":"2026-09-10T17:43:38.151502Z","steps":["trace[1184767138] 'agreement among raft nodes before linearized reading' (duration: 126.589044ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:43:43.952385Z","caller":"traceutil/trace.go:171","msg":"trace[1343731909] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"308.421279ms","start":"2026-09-10T17:43:43.643915Z","end":"2026-09-10T17:43:43.952336Z","steps":["trace[1343731909] 'process raft request' (duration: 308.288807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:43.956574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:43.643883Z","time spent":"312.236822ms","remote":"127.0.0.1:59684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-10T17:43:45.015655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053525108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:43:45.01574Z","caller":"traceutil/trace.go:171","msg":"trace[1496231846] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:292; }","duration":"1.05366374s","start":"2026-09-10T17:43:43.962056Z","end":"2026-09-10T17:43:45.015719Z","steps":["trace[1496231846] 'range keys from in-memory index tree' (duration: 1.053433516s)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.015735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.583469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-10T17:43:45.015768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.187181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-10T17:43:45.015827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:43.962036Z","time spent":"1.053780953s","remote":"127.0.0.1:59684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-09-10T17:43:45.015796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.259809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-10T17:43:45.015865Z","caller":"traceutil/trace.go:171","msg":"trace[670430256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:292; }","duration":"371.820253ms","start":"2026-09-10T17:43:44.644012Z","end":"2026-09-10T17:43:45.015833Z","steps":["trace[670430256] 'range keys from in-memory index tree' (duration: 371.397644ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:43:45.015882Z","caller":"traceutil/trace.go:171","msg":"trace[142543913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:292; }","duration":"801.349824ms","start":"2026-09-10T17:43:44.2145Z","end":"2026-09-10T17:43:45.01585Z","steps":["trace[142543913] 'range keys from in-memory index tree' (duration: 801.076458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.015928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:44.643992Z","time spent":"371.925245ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-10T17:43:45.01593Z","caller":"traceutil/trace.go:171","msg":"trace[477852809] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:292; }","duration":"906.468604ms","start":"2026-09-10T17:43:44.109423Z","end":"2026-09-10T17:43:45.015891Z","steps":["trace[477852809] 'range keys from in-memory index tree' (duration: 906.065705ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.015948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:44.214485Z","time spent":"801.450536ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-10T17:43:45.015774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.654135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-10T17:43:45.016022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:44.109407Z","time spent":"906.589067ms","remote":"127.0.0.1:59746","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":"info","ts":"2026-09-10T17:43:45.016066Z","caller":"traceutil/trace.go:171","msg":"trace[701541511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:292; }","duration":"719.004313ms","start":"2026-09-10T17:43:44.297036Z","end":"2026-09-10T17:43:45.01604Z","steps":["trace[701541511] 'range keys from in-memory index tree' (duration: 718.566703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.016126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:44.297017Z","time spent":"719.092704ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-10T17:43:45.369615Z","caller":"traceutil/trace.go:171","msg":"trace[1242494881] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"347.866536ms","start":"2026-09-10T17:43:45.021724Z","end":"2026-09-10T17:43:45.369591Z","steps":["trace[1242494881] 'process raft request' (duration: 347.698642ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.370101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:45.021669Z","time spent":"348.127142ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:43:45.554239Z","caller":"traceutil/trace.go:171","msg":"trace[708859061] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"532.387069ms","start":"2026-09-10T17:43:45.021823Z","end":"2026-09-10T17:43:45.55421Z","steps":["trace[708859061] 'process raft request' (duration: 532.132393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.554525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:45.021804Z","time spent":"532.621024ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T17:43:45.554748Z","caller":"traceutil/trace.go:171","msg":"trace[1133757261] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"532.508382ms","start":"2026-09-10T17:43:45.022199Z","end":"2026-09-10T17:43:45.554707Z","steps":["trace[1133757261] 'process raft request' (duration: 531.91212ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:43:45.554753Z","caller":"traceutil/trace.go:171","msg":"trace[534213396] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"529.660061ms","start":"2026-09-10T17:43:45.025057Z","end":"2026-09-10T17:43:45.554717Z","steps":["trace[534213396] 'process raft request' (duration: 529.58549ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:43:45.554828Z","caller":"traceutil/trace.go:171","msg":"trace[1708633981] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"532.025781ms","start":"2026-09-10T17:43:45.022756Z","end":"2026-09-10T17:43:45.554782Z","steps":["trace[1708633981] 'process raft request' (duration: 531.746356ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:43:45.554899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:45.022186Z","time spent":"532.629594ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:43:45.554939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:45.025018Z","time spent":"529.828735ms","remote":"127.0.0.1:59684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-10T17:43:45.555023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:43:45.022746Z","time spent":"532.176785ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:44:17.039955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.682288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-10T17:44:17.040318Z","caller":"traceutil/trace.go:171","msg":"trace[2131488874] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"211.464486ms","start":"2026-09-10T17:44:16.828839Z","end":"2026-09-10T17:44:17.040303Z","steps":["trace[2131488874] 'process raft request' (duration: 211.372705ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.040431Z","caller":"traceutil/trace.go:171","msg":"trace[308521800] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"216.924107ms","start":"2026-09-10T17:44:16.823481Z","end":"2026-09-10T17:44:17.040405Z","steps":["trace[308521800] 'process raft request' (duration: 95.625658ms)","trace[308521800] 'compare' (duration: 120.567466ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:44:17.040488Z","caller":"traceutil/trace.go:171","msg":"trace[1579452421] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"214.532037ms","start":"2026-09-10T17:44:16.825949Z","end":"2026-09-10T17:44:17.040481Z","steps":["trace[1579452421] 'process raft request' (duration: 214.08604ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.040581Z","caller":"traceutil/trace.go:171","msg":"trace[290721302] transaction","detail":"{read_only:false; number_of_response:1; response_revision:495; }","duration":"214.128651ms","start":"2026-09-10T17:44:16.826447Z","end":"2026-09-10T17:44:17.040576Z","steps":["trace[290721302] 'process raft request' (duration: 213.646943ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.040694Z","caller":"traceutil/trace.go:171","msg":"trace[765007460] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"212.272329ms","start":"2026-09-10T17:44:16.828416Z","end":"2026-09-10T17:44:17.040688Z","steps":["trace[765007460] 'process raft request' (duration: 211.754841ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.040933Z","caller":"traceutil/trace.go:171","msg":"trace[884472292] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"206.86379ms","start":"2026-09-10T17:44:16.834062Z","end":"2026-09-10T17:44:17.040926Z","steps":["trace[884472292] 'process raft request' (duration: 206.19838ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041129Z","caller":"traceutil/trace.go:171","msg":"trace[1063454736] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"198.759767ms","start":"2026-09-10T17:44:16.842354Z","end":"2026-09-10T17:44:17.041113Z","steps":["trace[1063454736] 'process raft request' (duration: 198.537154ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041281Z","caller":"traceutil/trace.go:171","msg":"trace[263543843] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"195.936741ms","start":"2026-09-10T17:44:16.845335Z","end":"2026-09-10T17:44:17.041271Z","steps":["trace[263543843] 'process raft request' (duration: 195.776857ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041363Z","caller":"traceutil/trace.go:171","msg":"trace[562443140] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"198.876299ms","start":"2026-09-10T17:44:16.842479Z","end":"2026-09-10T17:44:17.041356Z","steps":["trace[562443140] 'process raft request' (duration: 198.596904ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041378Z","caller":"traceutil/trace.go:171","msg":"trace[1728636785] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"160.293942ms","start":"2026-09-10T17:44:16.881077Z","end":"2026-09-10T17:44:17.041371Z","steps":["trace[1728636785] 'process raft request' (duration: 160.261092ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041437Z","caller":"traceutil/trace.go:171","msg":"trace[948586716] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"189.724828ms","start":"2026-09-10T17:44:16.851702Z","end":"2026-09-10T17:44:17.041427Z","steps":["trace[948586716] 'process raft request' (duration: 189.462743ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041464Z","caller":"traceutil/trace.go:171","msg":"trace[323605759] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"178.489493ms","start":"2026-09-10T17:44:16.86297Z","end":"2026-09-10T17:44:17.041459Z","steps":["trace[323605759] 'process raft request' (duration: 178.296149ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041444Z","caller":"traceutil/trace.go:171","msg":"trace[1183985899] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"187.660263ms","start":"2026-09-10T17:44:16.853778Z","end":"2026-09-10T17:44:17.041438Z","steps":["trace[1183985899] 'process raft request' (duration: 187.420738ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:17.041514Z","caller":"traceutil/trace.go:171","msg":"trace[1897287598] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"194.248712ms","start":"2026-09-10T17:44:16.847257Z","end":"2026-09-10T17:44:17.041506Z","steps":["trace[1897287598] 'process raft request' (duration: 193.883346ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:21.930404Z","caller":"traceutil/trace.go:171","msg":"trace[108617237] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"180.270334ms","start":"2026-09-10T17:44:21.750104Z","end":"2026-09-10T17:44:21.930374Z","steps":["trace[108617237] 'process raft request' (duration: 179.734576ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:22.155947Z","caller":"traceutil/trace.go:171","msg":"trace[481183368] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"222.263148ms","start":"2026-09-10T17:44:21.933635Z","end":"2026-09-10T17:44:22.155899Z","steps":["trace[481183368] 'process raft request' (duration: 220.465109ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:22.163612Z","caller":"traceutil/trace.go:171","msg":"trace[1434384677] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"229.609553ms","start":"2026-09-10T17:44:21.933969Z","end":"2026-09-10T17:44:22.163579Z","steps":["trace[1434384677] 'process raft request' (duration: 229.253228ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:22.165457Z","caller":"traceutil/trace.go:171","msg":"trace[724728318] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:610; }","duration":"122.410118ms","start":"2026-09-10T17:44:22.043024Z","end":"2026-09-10T17:44:22.165434Z","steps":["trace[724728318] 'read index received' (duration: 111.044679ms)","trace[724728318] 'applied index is now lower than readState.Index' (duration: 11.363899ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:44:22.16616Z","caller":"traceutil/trace.go:171","msg":"trace[1621754767] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"141.295298ms","start":"2026-09-10T17:44:22.02483Z","end":"2026-09-10T17:44:22.166126Z","steps":["trace[1621754767] 'process raft request' (duration: 139.218904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:22.166532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.490466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T17:44:22.166585Z","caller":"traceutil/trace.go:171","msg":"trace[746248994] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"123.577836ms","start":"2026-09-10T17:44:22.042982Z","end":"2026-09-10T17:44:22.166559Z","steps":["trace[746248994] 'agreement among raft nodes before linearized reading' (duration: 122.56314ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:23.290933Z","caller":"traceutil/trace.go:171","msg":"trace[1989812020] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"129.67637ms","start":"2026-09-10T17:44:23.161228Z","end":"2026-09-10T17:44:23.290904Z","steps":["trace[1989812020] 'process raft request' (duration: 129.117261ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:23.740378Z","caller":"traceutil/trace.go:171","msg":"trace[1390623077] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"208.653362ms","start":"2026-09-10T17:44:23.5317Z","end":"2026-09-10T17:44:23.740353Z","steps":["trace[1390623077] 'read index received' (duration: 208.465709ms)","trace[1390623077] 'applied index is now lower than readState.Index' (duration: 186.643µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:44:23.740536Z","caller":"traceutil/trace.go:171","msg":"trace[758163905] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"375.111761ms","start":"2026-09-10T17:44:23.365299Z","end":"2026-09-10T17:44:23.740411Z","steps":["trace[758163905] 'process raft request' (duration: 374.932478ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:23.740623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.503106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-10T17:44:23.740656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.932476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sdtxw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-10T17:44:23.740693Z","caller":"traceutil/trace.go:171","msg":"trace[585417455] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sdtxw; range_end:; response_count:1; response_revision:599; }","duration":"209.018308ms","start":"2026-09-10T17:44:23.531663Z","end":"2026-09-10T17:44:23.740682Z","steps":["trace[585417455] 'agreement among raft nodes before linearized reading' (duration: 208.810235ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:23.74069Z","caller":"traceutil/trace.go:171","msg":"trace[1784864585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"134.611428ms","start":"2026-09-10T17:44:23.606062Z","end":"2026-09-10T17:44:23.740673Z","steps":["trace[1784864585] 'agreement among raft nodes before linearized reading' (duration: 134.449535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:23.740888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:23.365278Z","time spent":"375.490326ms","remote":"127.0.0.1:59982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-10T17:44:24.07589Z","caller":"traceutil/trace.go:171","msg":"trace[1052147425] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"141.757593ms","start":"2026-09-10T17:44:23.934113Z","end":"2026-09-10T17:44:24.07587Z","steps":["trace[1052147425] 'read index received' (duration: 141.450898ms)","trace[1052147425] 'applied index is now lower than readState.Index' (duration: 305.385µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:44:24.07599Z","caller":"traceutil/trace.go:171","msg":"trace[87238752] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"311.612735ms","start":"2026-09-10T17:44:23.764351Z","end":"2026-09-10T17:44:24.075964Z","steps":["trace[87238752] 'process raft request' (duration: 311.26486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:24.076051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.929235ms","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-10T17:44:24.076463Z","caller":"traceutil/trace.go:171","msg":"trace[658909842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"142.389012ms","start":"2026-09-10T17:44:23.934061Z","end":"2026-09-10T17:44:24.07645Z","steps":["trace[658909842] 'agreement among raft nodes before linearized reading' (duration: 141.908424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:24.076111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:23.764325Z","time spent":"311.723577ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:44:40.562028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.662736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T17:44:40.56217Z","caller":"traceutil/trace.go:171","msg":"trace[1786128779] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"519.66887ms","start":"2026-09-10T17:44:40.042483Z","end":"2026-09-10T17:44:40.562152Z","steps":["trace[1786128779] 'read index received' (duration: 48.562µs)","trace[1786128779] 'applied index is now lower than readState.Index' (duration: 519.619068ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T17:44:40.56227Z","caller":"traceutil/trace.go:171","msg":"trace[1190004672] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"638.675871ms","start":"2026-09-10T17:44:39.923584Z","end":"2026-09-10T17:44:40.562259Z","steps":["trace[1190004672] 'process raft request' (duration: 66.655639ms)","trace[1190004672] 'compare' (duration: 571.533775ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T17:44:40.562321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:39.923559Z","time spent":"638.734432ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T17:44:40.562728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.242317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-10T17:44:40.562712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.538633ms","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-09-10T17:44:40.562803Z","caller":"traceutil/trace.go:171","msg":"trace[325578791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"520.352439ms","start":"2026-09-10T17:44:40.042426Z","end":"2026-09-10T17:44:40.562779Z","steps":["trace[325578791] 'agreement among raft nodes before linearized reading' (duration: 520.240208ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T17:44:40.562813Z","caller":"traceutil/trace.go:171","msg":"trace[589562806] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"412.686494ms","start":"2026-09-10T17:44:40.150104Z","end":"2026-09-10T17:44:40.56279Z","steps":["trace[589562806] 'agreement among raft nodes before linearized reading' (duration: 412.38048ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:40.562821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.847698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-10T17:44:40.562823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.585854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-10T17:44:40.562856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:40.15008Z","time spent":"412.767285ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-10T17:44:40.562871Z","caller":"traceutil/trace.go:171","msg":"trace[1641344990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:767; }","duration":"326.95935ms","start":"2026-09-10T17:44:40.235897Z","end":"2026-09-10T17:44:40.562857Z","steps":["trace[1641344990] 'agreement among raft nodes before linearized reading' (duration: 326.772348ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:40.562913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:40.235864Z","time spent":"327.041921ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-10T17:44:40.562913Z","caller":"traceutil/trace.go:171","msg":"trace[366497780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:767; }","duration":"321.725457ms","start":"2026-09-10T17:44:40.241169Z","end":"2026-09-10T17:44:40.562895Z","steps":["trace[366497780] 'agreement among raft nodes before linearized reading' (duration: 321.482983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T17:44:40.56295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:40.241138Z","time spent":"321.804587ms","remote":"127.0.0.1:59746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-10T17:44:40.562857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T17:44:40.042407Z","time spent":"520.43688ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-10T17:45:48.381501Z","caller":"traceutil/trace.go:171","msg":"trace[2113470786] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"107.192458ms","start":"2026-09-10T17:45:48.274285Z","end":"2026-09-10T17:45:48.381477Z","steps":["trace[2113470786] 'process raft request' (duration: 107.013776ms)"],"step_count":1}