{"level":"warn","ts":"2026-09-18T05:26:01.967212Z","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-18T05:26:01.967307Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.124: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.124:2380","--initial-cluster=instance=https://162.253.55.124:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.124:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.124: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-18T05:26:01.967376Z","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-18T05:26:01.967387Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.124:2380"]} {"level":"info","ts":"2026-09-18T05:26:01.967631Z","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-18T05:26:01.968414Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"]} {"level":"info","ts":"2026-09-18T05:26:01.96849Z","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.124:2380"],"listen-peer-urls":["https://162.253.55.124:2380"],"advertise-client-urls":["https://162.253.55.124:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.124: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-18T05:26:01.972481Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.783855ms"} {"level":"info","ts":"2026-09-18T05:26:01.979497Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ad1df4dc3f3835d","cluster-id":"5f6d28152804218"} {"level":"info","ts":"2026-09-18T05:26:01.979579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T05:26:01.9796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became follower at term 0"} {"level":"info","ts":"2026-09-18T05:26:01.979615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ad1df4dc3f3835d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T05:26:01.979624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became follower at term 1"} {"level":"info","ts":"2026-09-18T05:26:01.979659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=(11155943277066421085)"} {"level":"warn","ts":"2026-09-18T05:26:01.98628Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T05:26:01.995782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T05:26:01.999085Z","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-18T05:26:02.00138Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ad1df4dc3f3835d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T05:26:02.001741Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ad1df4dc3f3835d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T05:26:02.00177Z","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-18T05:26:02.002368Z","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-18T05:26:02.002388Z","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-18T05:26:02.007122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d switched to configuration voters=(11155943277066421085)"} {"level":"info","ts":"2026-09-18T05:26:02.007341Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f6d28152804218","local-member-id":"9ad1df4dc3f3835d","added-peer-id":"9ad1df4dc3f3835d","added-peer-peer-urls":["https://162.253.55.124:2380"]} {"level":"info","ts":"2026-09-18T05:26:02.008682Z","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-18T05:26:02.008792Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.124:2380"} {"level":"info","ts":"2026-09-18T05:26:02.00881Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.124:2380"} {"level":"info","ts":"2026-09-18T05:26:02.009059Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ad1df4dc3f3835d","initial-advertise-peer-urls":["https://162.253.55.124:2380"],"listen-peer-urls":["https://162.253.55.124:2380"],"advertise-client-urls":["https://162.253.55.124:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.124:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T05:26:02.009108Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T05:26:02.379919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T05:26:02.379968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T05:26:02.38002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d received MsgPreVoteResp from 9ad1df4dc3f3835d at term 1"} {"level":"info","ts":"2026-09-18T05:26:02.380034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became candidate at term 2"} {"level":"info","ts":"2026-09-18T05:26:02.380046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d received MsgVoteResp from 9ad1df4dc3f3835d at term 2"} {"level":"info","ts":"2026-09-18T05:26:02.380056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ad1df4dc3f3835d became leader at term 2"} {"level":"info","ts":"2026-09-18T05:26:02.380066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ad1df4dc3f3835d elected leader 9ad1df4dc3f3835d at term 2"} {"level":"info","ts":"2026-09-18T05:26:02.381015Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ad1df4dc3f3835d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.124:2379]}","request-path":"/0/members/9ad1df4dc3f3835d/attributes","cluster-id":"5f6d28152804218","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T05:26:02.381091Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:26:02.38113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:26:02.381162Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:26:02.382278Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f6d28152804218","local-member-id":"9ad1df4dc3f3835d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:26:02.382428Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:26:02.382476Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:26:02.396686Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T05:26:02.382448Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T05:26:02.397318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T05:26:02.398869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.124:2379"} {"level":"info","ts":"2026-09-18T05:26:05.057691Z","caller":"traceutil/trace.go:171","msg":"trace[1010171418] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"138.547557ms","start":"2026-09-18T05:26:04.919118Z","end":"2026-09-18T05:26:05.057666Z","steps":["trace[1010171418] 'process raft request' (duration: 137.327672ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:07.34467Z","caller":"traceutil/trace.go:171","msg":"trace[795107747] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"443.549457ms","start":"2026-09-18T05:26:06.901099Z","end":"2026-09-18T05:26:07.344649Z","steps":["trace[795107747] 'process raft request' (duration: 434.160125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:07.345137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:06.901082Z","time spent":"443.648171ms","remote":"127.0.0.1:52342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:26:07.346729Z","caller":"traceutil/trace.go:171","msg":"trace[263133823] linearizableReadLoop","detail":"{readStateIndex:216; appliedIndex:214; }","duration":"366.200934ms","start":"2026-09-18T05:26:06.980517Z","end":"2026-09-18T05:26:07.346718Z","steps":["trace[263133823] 'read index received' (duration: 354.751395ms)","trace[263133823] 'applied index is now lower than readState.Index' (duration: 11.448879ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:26:07.346821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.298096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:26:07.346868Z","caller":"traceutil/trace.go:171","msg":"trace[1689413051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:211; }","duration":"366.348388ms","start":"2026-09-18T05:26:06.980511Z","end":"2026-09-18T05:26:07.34686Z","steps":["trace[1689413051] 'agreement among raft nodes before linearized reading' (duration: 366.269895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:07.346909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:06.980455Z","time spent":"366.447841ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T05:26:07.347043Z","caller":"traceutil/trace.go:171","msg":"trace[613426530] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"445.489772ms","start":"2026-09-18T05:26:06.901546Z","end":"2026-09-18T05:26:07.347035Z","steps":["trace[613426530] 'process raft request' (duration: 445.119241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:07.34711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:06.901525Z","time spent":"445.557453ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:26:07.567753Z","caller":"traceutil/trace.go:171","msg":"trace[1177587356] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"217.279598ms","start":"2026-09-18T05:26:07.350456Z","end":"2026-09-18T05:26:07.567735Z","steps":["trace[1177587356] 'process raft request' (duration: 217.180565ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:07.59727Z","caller":"traceutil/trace.go:171","msg":"trace[1918786765] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:216; }","duration":"225.808816ms","start":"2026-09-18T05:26:07.371416Z","end":"2026-09-18T05:26:07.597225Z","steps":["trace[1918786765] 'read index received' (duration: 196.235323ms)","trace[1918786765] 'applied index is now lower than readState.Index' (duration: 29.572423ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:26:07.597475Z","caller":"traceutil/trace.go:171","msg":"trace[1943396988] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"244.796785ms","start":"2026-09-18T05:26:07.352661Z","end":"2026-09-18T05:26:07.597458Z","steps":["trace[1943396988] 'process raft request' (duration: 244.433135ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:07.597707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.266279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:26:07.598272Z","caller":"traceutil/trace.go:171","msg":"trace[995425218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:213; }","duration":"226.510807ms","start":"2026-09-18T05:26:07.371363Z","end":"2026-09-18T05:26:07.597873Z","steps":["trace[995425218] 'agreement among raft nodes before linearized reading' (duration: 226.181577ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:07.809442Z","caller":"traceutil/trace.go:171","msg":"trace[1312347605] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"205.740328ms","start":"2026-09-18T05:26:07.603666Z","end":"2026-09-18T05:26:07.809407Z","steps":["trace[1312347605] 'process raft request' (duration: 205.697607ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:07.809548Z","caller":"traceutil/trace.go:171","msg":"trace[1918093482] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"206.553209ms","start":"2026-09-18T05:26:07.602978Z","end":"2026-09-18T05:26:07.809532Z","steps":["trace[1918093482] 'process raft request' (duration: 206.335383ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:07.809493Z","caller":"traceutil/trace.go:171","msg":"trace[1199432406] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"207.251379ms","start":"2026-09-18T05:26:07.602106Z","end":"2026-09-18T05:26:07.809358Z","steps":["trace[1199432406] 'process raft request' (duration: 166.637118ms)","trace[1199432406] 'compare' (duration: 40.426376ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:26:33.708084Z","caller":"traceutil/trace.go:171","msg":"trace[1358385938] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"186.225843ms","start":"2026-09-18T05:26:33.521839Z","end":"2026-09-18T05:26:33.708065Z","steps":["trace[1358385938] 'process raft request' (duration: 186.11157ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:36.044362Z","caller":"traceutil/trace.go:171","msg":"trace[1984805544] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:456; }","duration":"255.095081ms","start":"2026-09-18T05:26:35.789252Z","end":"2026-09-18T05:26:36.044347Z","steps":["trace[1984805544] 'read index received' (duration: 254.915607ms)","trace[1984805544] 'applied index is now lower than readState.Index' (duration: 178.914µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:26:36.04459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.317537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.124\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-18T05:26:36.044689Z","caller":"traceutil/trace.go:171","msg":"trace[1007374498] range","detail":"{range_begin:/registry/masterleases/162.253.55.124; range_end:; response_count:1; response_revision:440; }","duration":"255.471311ms","start":"2026-09-18T05:26:35.789193Z","end":"2026-09-18T05:26:36.044664Z","steps":["trace[1007374498] 'agreement among raft nodes before linearized reading' (duration: 255.304446ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:36.044813Z","caller":"traceutil/trace.go:171","msg":"trace[825951376] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"327.574809ms","start":"2026-09-18T05:26:35.717208Z","end":"2026-09-18T05:26:36.044783Z","steps":["trace[825951376] 'process raft request' (duration: 326.998214ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:36.044894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:35.717184Z","time spent":"327.654392ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:26:41.503367Z","caller":"traceutil/trace.go:171","msg":"trace[1451388881] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"195.042287ms","start":"2026-09-18T05:26:41.308276Z","end":"2026-09-18T05:26:41.503319Z","steps":["trace[1451388881] 'process raft request' (duration: 187.576085ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.523558Z","caller":"traceutil/trace.go:171","msg":"trace[1321124744] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"197.693368ms","start":"2026-09-18T05:26:43.325837Z","end":"2026-09-18T05:26:43.52353Z","steps":["trace[1321124744] 'process raft request' (duration: 197.560844ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531034Z","caller":"traceutil/trace.go:171","msg":"trace[818708347] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"183.042931ms","start":"2026-09-18T05:26:43.347969Z","end":"2026-09-18T05:26:43.531012Z","steps":["trace[818708347] 'process raft request' (duration: 182.735933ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531308Z","caller":"traceutil/trace.go:171","msg":"trace[819285938] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"200.725629ms","start":"2026-09-18T05:26:43.330574Z","end":"2026-09-18T05:26:43.5313Z","steps":["trace[819285938] 'process raft request' (duration: 199.930578ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.53141Z","caller":"traceutil/trace.go:171","msg":"trace[846202270] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"192.95895ms","start":"2026-09-18T05:26:43.338427Z","end":"2026-09-18T05:26:43.531386Z","steps":["trace[846202270] 'process raft request' (duration: 192.153128ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531557Z","caller":"traceutil/trace.go:171","msg":"trace[359512226] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"183.526995ms","start":"2026-09-18T05:26:43.348024Z","end":"2026-09-18T05:26:43.531551Z","steps":["trace[359512226] 'process raft request' (duration: 182.703603ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531626Z","caller":"traceutil/trace.go:171","msg":"trace[35771886] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"181.798339ms","start":"2026-09-18T05:26:43.349802Z","end":"2026-09-18T05:26:43.5316Z","steps":["trace[35771886] 'process raft request' (duration: 180.948915ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531671Z","caller":"traceutil/trace.go:171","msg":"trace[2046108044] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"171.928133ms","start":"2026-09-18T05:26:43.359723Z","end":"2026-09-18T05:26:43.531651Z","steps":["trace[2046108044] 'process raft request' (duration: 171.108ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531459Z","caller":"traceutil/trace.go:171","msg":"trace[9811913] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"190.214846ms","start":"2026-09-18T05:26:43.34116Z","end":"2026-09-18T05:26:43.531374Z","steps":["trace[9811913] 'process raft request' (duration: 189.511297ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531702Z","caller":"traceutil/trace.go:171","msg":"trace[1287128628] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"179.412745ms","start":"2026-09-18T05:26:43.352119Z","end":"2026-09-18T05:26:43.531532Z","steps":["trace[1287128628] 'process raft request' (duration: 178.676645ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531728Z","caller":"traceutil/trace.go:171","msg":"trace[85450617] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"190.581686ms","start":"2026-09-18T05:26:43.341051Z","end":"2026-09-18T05:26:43.531632Z","steps":["trace[85450617] 'process raft request' (duration: 189.557348ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:43.531755Z","caller":"traceutil/trace.go:171","msg":"trace[552075460] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"141.314157ms","start":"2026-09-18T05:26:43.390434Z","end":"2026-09-18T05:26:43.531749Z","steps":["trace[552075460] 'process raft request' (duration: 140.427612ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:26:50.155383Z","caller":"traceutil/trace.go:171","msg":"trace[1757588335] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"264.120832ms","start":"2026-09-18T05:26:49.891208Z","end":"2026-09-18T05:26:50.155329Z","steps":["trace[1757588335] 'process raft request' (duration: 263.266609ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:50.958259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.976988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:26:50.958564Z","caller":"traceutil/trace.go:171","msg":"trace[1674966940] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"771.83822ms","start":"2026-09-18T05:26:50.186631Z","end":"2026-09-18T05:26:50.958469Z","steps":["trace[1674966940] 'process raft request' (duration: 484.334158ms)","trace[1674966940] 'compare' (duration: 286.845774ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:26:50.958703Z","caller":"traceutil/trace.go:171","msg":"trace[815443585] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"728.721906ms","start":"2026-09-18T05:26:50.229942Z","end":"2026-09-18T05:26:50.958663Z","steps":["trace[815443585] 'read index received' (duration: 441.041219ms)","trace[815443585] 'applied index is now lower than readState.Index' (duration: 287.675017ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:26:50.958799Z","caller":"traceutil/trace.go:171","msg":"trace[313022523] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"714.517533ms","start":"2026-09-18T05:26:50.244264Z","end":"2026-09-18T05:26:50.958782Z","steps":["trace[313022523] 'process raft request' (duration: 714.372409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:50.958993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.044765ms","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-09-18T05:26:50.959076Z","caller":"traceutil/trace.go:171","msg":"trace[2138159815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"729.144308ms","start":"2026-09-18T05:26:50.229916Z","end":"2026-09-18T05:26:50.95906Z","steps":["trace[2138159815] 'agreement among raft nodes before linearized reading' (duration: 728.897701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:50.959111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:50.229902Z","time spent":"729.20072ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-18T05:26:50.958821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:50.186604Z","time spent":"772.084776ms","remote":"127.0.0.1:52400","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-18T05:26:50.959157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.367072ms","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-18T05:26:50.959364Z","caller":"traceutil/trace.go:171","msg":"trace[1303520815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"323.595638ms","start":"2026-09-18T05:26:50.635739Z","end":"2026-09-18T05:26:50.959335Z","steps":["trace[1303520815] 'agreement among raft nodes before linearized reading' (duration: 323.30428ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:50.959451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:50.635718Z","time spent":"323.719201ms","remote":"127.0.0.1:52400","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":"warn","ts":"2026-09-18T05:26:50.959445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:50.244205Z","time spent":"714.977905ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:26:50.959378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.582892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:26:50.959849Z","caller":"traceutil/trace.go:171","msg":"trace[1675633281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"519.298691ms","start":"2026-09-18T05:26:50.440443Z","end":"2026-09-18T05:26:50.959741Z","steps":["trace[1675633281] 'agreement among raft nodes before linearized reading' (duration: 518.572361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:26:50.960031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:26:50.440398Z","time spent":"519.552719ms","remote":"127.0.0.1:52176","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-18T05:27:08.574692Z","caller":"traceutil/trace.go:171","msg":"trace[210656603] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"132.042745ms","start":"2026-09-18T05:27:08.442625Z","end":"2026-09-18T05:27:08.574667Z","steps":["trace[210656603] 'read index received' (duration: 68.385295ms)","trace[210656603] 'applied index is now lower than readState.Index' (duration: 63.65651ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:27:08.574783Z","caller":"traceutil/trace.go:171","msg":"trace[572827159] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"253.3229ms","start":"2026-09-18T05:27:08.321422Z","end":"2026-09-18T05:27:08.574745Z","steps":["trace[572827159] 'process raft request' (duration: 189.490326ms)","trace[572827159] 'compare' (duration: 63.659939ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:27:08.574863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.215969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:27:08.574894Z","caller":"traceutil/trace.go:171","msg":"trace[379475470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:774; }","duration":"132.298722ms","start":"2026-09-18T05:27:08.442587Z","end":"2026-09-18T05:27:08.574886Z","steps":["trace[379475470] 'agreement among raft nodes before linearized reading' (duration: 132.22444ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:27:48.912675Z","caller":"traceutil/trace.go:171","msg":"trace[564045595] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"129.884168ms","start":"2026-09-18T05:27:48.782765Z","end":"2026-09-18T05:27:48.91265Z","steps":["trace[564045595] 'read index received' (duration: 129.742204ms)","trace[564045595] 'applied index is now lower than readState.Index' (duration: 141.344µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:27:48.912939Z","caller":"traceutil/trace.go:171","msg":"trace[1357105958] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"375.674263ms","start":"2026-09-18T05:27:48.537228Z","end":"2026-09-18T05:27:48.912903Z","steps":["trace[1357105958] 'process raft request' (duration: 375.326784ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:27:48.913036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:27:48.537191Z","time spent":"375.779766ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:27:48.913271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.498304ms","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-09-18T05:27:48.913318Z","caller":"traceutil/trace.go:171","msg":"trace[1659871390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1061; }","duration":"130.578037ms","start":"2026-09-18T05:27:48.782728Z","end":"2026-09-18T05:27:48.913306Z","steps":["trace[1659871390] 'agreement among raft nodes before linearized reading' (duration: 130.446713ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:28:02.109762Z","caller":"traceutil/trace.go:171","msg":"trace[1661191598] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"249.286171ms","start":"2026-09-18T05:28:01.860457Z","end":"2026-09-18T05:28:02.109743Z","steps":["trace[1661191598] 'process raft request' (duration: 249.171277ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:28:06.026652Z","caller":"traceutil/trace.go:171","msg":"trace[1050809094] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"172.951589ms","start":"2026-09-18T05:28:05.853665Z","end":"2026-09-18T05:28:06.026617Z","steps":["trace[1050809094] 'process raft request' (duration: 148.93903ms)","trace[1050809094] 'compare' (duration: 23.812124ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:28:07.365525Z","caller":"traceutil/trace.go:171","msg":"trace[1834108327] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"165.17042ms","start":"2026-09-18T05:28:07.200318Z","end":"2026-09-18T05:28:07.365489Z","steps":["trace[1834108327] 'process raft request' (duration: 125.013646ms)","trace[1834108327] 'compare' (duration: 39.938198ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:28:07.644291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.041432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:28:07.644408Z","caller":"traceutil/trace.go:171","msg":"trace[417581860] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"213.455013ms","start":"2026-09-18T05:28:07.430937Z","end":"2026-09-18T05:28:07.644392Z","steps":["trace[417581860] 'read index received' (duration: 90.094382ms)","trace[417581860] 'applied index is now lower than readState.Index' (duration: 123.359531ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:28:07.644519Z","caller":"traceutil/trace.go:171","msg":"trace[1994518735] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"222.371905ms","start":"2026-09-18T05:28:07.422079Z","end":"2026-09-18T05:28:07.644451Z","steps":["trace[1994518735] 'process raft request' (duration: 99.042615ms)","trace[1994518735] 'compare' (duration: 122.911258ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:28:07.644605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.646218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:28:07.644712Z","caller":"traceutil/trace.go:171","msg":"trace[1249911351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1150; }","duration":"213.774242ms","start":"2026-09-18T05:28:07.430901Z","end":"2026-09-18T05:28:07.644675Z","steps":["trace[1249911351] 'agreement among raft nodes before linearized reading' (duration: 213.561416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:28:07.64472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.960814ms","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-18T05:28:07.644772Z","caller":"traceutil/trace.go:171","msg":"trace[1835475709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1150; }","duration":"195.051676ms","start":"2026-09-18T05:28:07.449702Z","end":"2026-09-18T05:28:07.644754Z","steps":["trace[1835475709] 'agreement among raft nodes before linearized reading' (duration: 194.894032ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:28:07.644953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.479361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:28:07.644991Z","caller":"traceutil/trace.go:171","msg":"trace[467987978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1150; }","duration":"204.514622ms","start":"2026-09-18T05:28:07.440465Z","end":"2026-09-18T05:28:07.64498Z","steps":["trace[467987978] 'agreement among raft nodes before linearized reading' (duration: 204.07655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:28:07.893934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.958985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:28:07.89409Z","caller":"traceutil/trace.go:171","msg":"trace[1225221874] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"244.744979ms","start":"2026-09-18T05:28:07.649318Z","end":"2026-09-18T05:28:07.894063Z","steps":["trace[1225221874] 'process raft request' (duration: 96.555747ms)","trace[1225221874] 'compare' (duration: 147.842262ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:28:20.400753Z","caller":"traceutil/trace.go:171","msg":"trace[1453630726] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"447.642597ms","start":"2026-09-18T05:28:19.953087Z","end":"2026-09-18T05:28:20.40073Z","steps":["trace[1453630726] 'process raft request' (duration: 447.498454ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:28:20.400927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:28:19.953055Z","time spent":"447.78219ms","remote":"127.0.0.1:52400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:28:20.417551Z","caller":"traceutil/trace.go:171","msg":"trace[815851648] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1279; }","duration":"103.155285ms","start":"2026-09-18T05:28:20.314359Z","end":"2026-09-18T05:28:20.417515Z","steps":["trace[815851648] 'read index received' (duration: 86.213348ms)","trace[815851648] 'applied index is now lower than readState.Index' (duration: 16.940997ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:28:20.417609Z","caller":"traceutil/trace.go:171","msg":"trace[1267053499] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"167.072331ms","start":"2026-09-18T05:28:20.250508Z","end":"2026-09-18T05:28:20.417581Z","steps":["trace[1267053499] 'process raft request' (duration: 166.870646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:28:20.417798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.421893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-09-18T05:28:20.417839Z","caller":"traceutil/trace.go:171","msg":"trace[360886169] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1235; }","duration":"103.529085ms","start":"2026-09-18T05:28:20.314298Z","end":"2026-09-18T05:28:20.417827Z","steps":["trace[360886169] 'agreement among raft nodes before linearized reading' (duration: 103.33842ms)"],"step_count":1}