{"level":"warn","ts":"2026-09-18T00:04:58.943194Z","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-18T00:04:58.943282Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.102: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.102:2380","--initial-cluster=instance=https://162.253.55.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.102: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-18T00:04:58.943348Z","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-18T00:04:58.943364Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-09-18T00:04:58.943388Z","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-18T00:04:58.94419Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"]} {"level":"info","ts":"2026-09-18T00:04:58.944306Z","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.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.102: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-18T00:04:58.950422Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.874237ms"} {"level":"info","ts":"2026-09-18T00:04:58.964986Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2af340d70e332c3","cluster-id":"da2a6dcf93591a68"} {"level":"info","ts":"2026-09-18T00:04:58.965082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T00:04:58.9651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 0"} {"level":"info","ts":"2026-09-18T00:04:58.965112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2af340d70e332c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T00:04:58.965121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 1"} {"level":"info","ts":"2026-09-18T00:04:58.965154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"warn","ts":"2026-09-18T00:04:58.97767Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T00:04:58.979042Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T00:04:58.980817Z","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-18T00:04:58.982571Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2af340d70e332c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T00:04:58.982706Z","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-18T00:04:58.982826Z","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-18T00:04:58.982839Z","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-18T00:04:58.983173Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2af340d70e332c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T00:04:58.983932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"info","ts":"2026-09-18T00:04:58.984369Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","added-peer-id":"e2af340d70e332c3","added-peer-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-09-18T00:04:58.988275Z","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-18T00:04:58.988479Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2af340d70e332c3","initial-advertise-peer-urls":["https://162.253.55.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T00:04:58.98851Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T00:04:58.988597Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-09-18T00:04:58.988619Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-09-18T00:04:59.165919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T00:04:59.165987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T00:04:59.166004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgPreVoteResp from e2af340d70e332c3 at term 1"} {"level":"info","ts":"2026-09-18T00:04:59.16602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became candidate at term 2"} {"level":"info","ts":"2026-09-18T00:04:59.166028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgVoteResp from e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-09-18T00:04:59.166039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became leader at term 2"} {"level":"info","ts":"2026-09-18T00:04:59.166048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2af340d70e332c3 elected leader e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-09-18T00:04:59.167851Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2af340d70e332c3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.102:2379]}","request-path":"/0/members/e2af340d70e332c3/attributes","cluster-id":"da2a6dcf93591a68","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T00:04:59.168807Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T00:04:59.168889Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T00:04:59.168972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T00:04:59.169114Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T00:04:59.170666Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T00:04:59.170434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.102:2379"} {"level":"info","ts":"2026-09-18T00:04:59.172068Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T00:04:59.176788Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T00:04:59.176837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T00:04:59.176852Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-18T00:05:33.812545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.683858ms","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-18T00:05:33.812676Z","caller":"traceutil/trace.go:171","msg":"trace[130600591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:445; }","duration":"154.893273ms","start":"2026-09-18T00:05:33.657759Z","end":"2026-09-18T00:05:33.812652Z","steps":["trace[130600591] 'range keys from in-memory index tree' (duration: 154.493605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:05:43.967708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.110494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T00:05:43.967841Z","caller":"traceutil/trace.go:171","msg":"trace[228862056] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"204.385063ms","start":"2026-09-18T00:05:43.763441Z","end":"2026-09-18T00:05:43.967826Z","steps":["trace[228862056] 'read index received' (duration: 44.562µs)","trace[228862056] 'applied index is now lower than readState.Index' (duration: 204.339301ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:05:43.967954Z","caller":"traceutil/trace.go:171","msg":"trace[1792491307] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"334.060271ms","start":"2026-09-18T00:05:43.633843Z","end":"2026-09-18T00:05:43.967903Z","steps":["trace[1792491307] 'process raft request' (duration: 68.160747ms)","trace[1792491307] 'compare' (duration: 264.971505ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T00:05:43.968019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.584456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7pqc5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-18T00:05:43.968049Z","caller":"traceutil/trace.go:171","msg":"trace[1430466715] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7pqc5; range_end:; response_count:1; response_revision:584; }","duration":"204.65386ms","start":"2026-09-18T00:05:43.763386Z","end":"2026-09-18T00:05:43.968039Z","steps":["trace[1430466715] 'agreement among raft nodes before linearized reading' (duration: 204.501731ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:05:43.968114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:05:43.633835Z","time spent":"334.19368ms","remote":"127.0.0.1:47816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T00:05:44.001035Z","caller":"traceutil/trace.go:171","msg":"trace[327709576] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"163.064277ms","start":"2026-09-18T00:05:43.837931Z","end":"2026-09-18T00:05:44.000995Z","steps":["trace[327709576] 'process raft request' (duration: 162.30517ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:05:44.001048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.681038ms","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-18T00:05:44.001138Z","caller":"traceutil/trace.go:171","msg":"trace[1269831178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"133.781454ms","start":"2026-09-18T00:05:43.867344Z","end":"2026-09-18T00:05:44.001125Z","steps":["trace[1269831178] 'agreement among raft nodes before linearized reading' (duration: 133.616164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:05:44.55187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.916793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T00:05:44.551973Z","caller":"traceutil/trace.go:171","msg":"trace[986513678] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"485.395412ms","start":"2026-09-18T00:05:44.066559Z","end":"2026-09-18T00:05:44.551954Z","steps":["trace[986513678] 'process raft request' (duration: 319.223304ms)","trace[986513678] 'compare' (duration: 165.746861ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T00:05:44.552025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:05:44.066534Z","time spent":"485.469916ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T00:06:00.434929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.500047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T00:06:00.435023Z","caller":"traceutil/trace.go:171","msg":"trace[939201317] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:761; }","duration":"199.638573ms","start":"2026-09-18T00:06:00.235365Z","end":"2026-09-18T00:06:00.435003Z","steps":["trace[939201317] 'count revisions from in-memory index tree' (duration: 199.441324ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:06:00.435076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.633526ms","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-18T00:06:00.435176Z","caller":"traceutil/trace.go:171","msg":"trace[1812014761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:761; }","duration":"304.776263ms","start":"2026-09-18T00:06:00.130377Z","end":"2026-09-18T00:06:00.435153Z","steps":["trace[1812014761] 'range keys from in-memory index tree' (duration: 304.447216ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:06:00.435189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.560271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-18T00:06:00.435228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:06:00.130363Z","time spent":"304.850427ms","remote":"127.0.0.1:47816","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-18T00:06:00.435248Z","caller":"traceutil/trace.go:171","msg":"trace[1048445219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"321.651676ms","start":"2026-09-18T00:06:00.113584Z","end":"2026-09-18T00:06:00.435235Z","steps":["trace[1048445219] 'range keys from in-memory index tree' (duration: 321.426784ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:06:00.435277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:06:00.113567Z","time spent":"321.70268ms","remote":"127.0.0.1:47816","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-18T00:06:31.680342Z","caller":"traceutil/trace.go:171","msg":"trace[946418770] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"169.180122ms","start":"2026-09-18T00:06:31.511139Z","end":"2026-09-18T00:06:31.680319Z","steps":["trace[946418770] 'process raft request' (duration: 169.036136ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:07:22.539394Z","caller":"traceutil/trace.go:171","msg":"trace[1961420567] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"253.090644ms","start":"2026-09-18T00:07:22.286278Z","end":"2026-09-18T00:07:22.539368Z","steps":["trace[1961420567] 'read index received' (duration: 252.919758ms)","trace[1961420567] 'applied index is now lower than readState.Index' (duration: 169.746µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:07:22.539534Z","caller":"traceutil/trace.go:171","msg":"trace[1335391385] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"399.59468ms","start":"2026-09-18T00:07:22.139872Z","end":"2026-09-18T00:07:22.539467Z","steps":["trace[1335391385] 'process raft request' (duration: 399.342273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:22.53998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.475295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e57467d6-5749-4b76-b0ad-bb86cfcfe331\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-18T00:07:22.540165Z","caller":"traceutil/trace.go:171","msg":"trace[1290499046] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e57467d6-5749-4b76-b0ad-bb86cfcfe331; range_end:; response_count:1; response_revision:1857; }","duration":"253.807374ms","start":"2026-09-18T00:07:22.286228Z","end":"2026-09-18T00:07:22.540035Z","steps":["trace[1290499046] 'agreement among raft nodes before linearized reading' (duration: 253.258569ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:22.541528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:07:22.139839Z","time spent":"399.974221ms","remote":"127.0.0.1:47816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T00:07:22.95569Z","caller":"traceutil/trace.go:171","msg":"trace[1324450206] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1940; }","duration":"149.754228ms","start":"2026-09-18T00:07:22.805913Z","end":"2026-09-18T00:07:22.955668Z","steps":["trace[1324450206] 'read index received' (duration: 98.207373ms)","trace[1324450206] 'applied index is now lower than readState.Index' (duration: 51.545155ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:07:22.9559Z","caller":"traceutil/trace.go:171","msg":"trace[1600278500] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"225.47508ms","start":"2026-09-18T00:07:22.730377Z","end":"2026-09-18T00:07:22.955852Z","steps":["trace[1600278500] 'process raft request' (duration: 225.145311ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:22.956205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.286583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T00:07:22.956297Z","caller":"traceutil/trace.go:171","msg":"trace[1181979427] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1862; }","duration":"150.441256ms","start":"2026-09-18T00:07:22.805837Z","end":"2026-09-18T00:07:22.956279Z","steps":["trace[1181979427] 'agreement among raft nodes before linearized reading' (duration: 150.087287ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:07:56.81228Z","caller":"traceutil/trace.go:171","msg":"trace[1864363302] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"144.745405ms","start":"2026-09-18T00:07:56.667511Z","end":"2026-09-18T00:07:56.812256Z","steps":["trace[1864363302] 'process raft request' (duration: 144.54955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:56.812479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.311283ms","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-18T00:07:56.81252Z","caller":"traceutil/trace.go:171","msg":"trace[1089560546] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2097; }","duration":"113.415496ms","start":"2026-09-18T00:07:56.699094Z","end":"2026-09-18T00:07:56.812509Z","steps":["trace[1089560546] 'agreement among raft nodes before linearized reading' (duration: 113.230101ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:07:56.81227Z","caller":"traceutil/trace.go:171","msg":"trace[530841390] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"113.076078ms","start":"2026-09-18T00:07:56.699153Z","end":"2026-09-18T00:07:56.812229Z","steps":["trace[530841390] 'read index received' (duration: 112.817262ms)","trace[530841390] 'applied index is now lower than readState.Index' (duration: 257.756µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:07:57.200501Z","caller":"traceutil/trace.go:171","msg":"trace[218179960] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2186; }","duration":"110.696741ms","start":"2026-09-18T00:07:57.089774Z","end":"2026-09-18T00:07:57.20047Z","steps":["trace[218179960] 'read index received' (duration: 106.889589ms)","trace[218179960] 'applied index is now lower than readState.Index' (duration: 3.806052ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T00:07:57.20081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.992447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T00:07:57.200887Z","caller":"traceutil/trace.go:171","msg":"trace[418309903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2100; }","duration":"111.171081ms","start":"2026-09-18T00:07:57.089697Z","end":"2026-09-18T00:07:57.200868Z","steps":["trace[418309903] 'agreement among raft nodes before linearized reading' (duration: 111.001527ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:07:57.201107Z","caller":"traceutil/trace.go:171","msg":"trace[2003229578] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"117.71163ms","start":"2026-09-18T00:07:57.083381Z","end":"2026-09-18T00:07:57.201093Z","steps":["trace[2003229578] 'process raft request' (duration: 113.296943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:57.610623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.13231ms","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-18T00:07:57.610711Z","caller":"traceutil/trace.go:171","msg":"trace[163627661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2102; }","duration":"227.266633ms","start":"2026-09-18T00:07:57.383422Z","end":"2026-09-18T00:07:57.610689Z","steps":["trace[163627661] 'range keys from in-memory index tree' (duration: 226.956836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:07:57.610902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.722474ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T00:07:57.611027Z","caller":"traceutil/trace.go:171","msg":"trace[1387567727] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"176.223172ms","start":"2026-09-18T00:07:57.43478Z","end":"2026-09-18T00:07:57.611003Z","steps":["trace[1387567727] 'process raft request' (duration: 50.298654ms)","trace[1387567727] 'compare' (duration: 125.56884ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T00:07:58.020294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.556281ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T00:09:40.703259Z","caller":"traceutil/trace.go:171","msg":"trace[2004374926] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"159.713749ms","start":"2026-09-18T00:09:40.543515Z","end":"2026-09-18T00:09:40.703229Z","steps":["trace[2004374926] 'process raft request' (duration: 120.95826ms)","trace[2004374926] 'compare' (duration: 38.639737ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:14:18.249176Z","caller":"traceutil/trace.go:171","msg":"trace[864333865] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"329.227975ms","start":"2026-09-18T00:14:17.919922Z","end":"2026-09-18T00:14:18.24915Z","steps":["trace[864333865] 'process raft request' (duration: 329.078321ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:14:18.249347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:14:17.919907Z","time spent":"329.346408ms","remote":"127.0.0.1:35354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1950,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T00:14:18.685899Z","caller":"traceutil/trace.go:171","msg":"trace[526458521] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"281.861953ms","start":"2026-09-18T00:14:18.404007Z","end":"2026-09-18T00:14:18.685869Z","steps":["trace[526458521] 'process raft request' (duration: 280.395961ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:14:18.685962Z","caller":"traceutil/trace.go:171","msg":"trace[2100617493] linearizableReadLoop","detail":"{readStateIndex:5134; appliedIndex:5132; }","duration":"252.649067ms","start":"2026-09-18T00:14:18.433282Z","end":"2026-09-18T00:14:18.685931Z","steps":["trace[2100617493] 'read index received' (duration: 251.134934ms)","trace[2100617493] 'applied index is now lower than readState.Index' (duration: 1.512533ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:14:18.685972Z","caller":"traceutil/trace.go:171","msg":"trace[196878352] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"281.921504ms","start":"2026-09-18T00:14:18.404029Z","end":"2026-09-18T00:14:18.68595Z","steps":["trace[196878352] 'process raft request' (duration: 281.758941ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:14:18.686286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.980144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-18T00:14:18.688672Z","caller":"traceutil/trace.go:171","msg":"trace[179593184] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4940; }","duration":"255.386967ms","start":"2026-09-18T00:14:18.433261Z","end":"2026-09-18T00:14:18.688648Z","steps":["trace[179593184] 'agreement among raft nodes before linearized reading' (duration: 252.7668ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:14:31.962925Z","caller":"traceutil/trace.go:171","msg":"trace[114854773] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"176.469746ms","start":"2026-09-18T00:14:31.786431Z","end":"2026-09-18T00:14:31.962901Z","steps":["trace[114854773] 'process raft request' (duration: 176.297902ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:14:32.190545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.011516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T00:14:32.190642Z","caller":"traceutil/trace.go:171","msg":"trace[680288624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5171; }","duration":"103.155719ms","start":"2026-09-18T00:14:32.087465Z","end":"2026-09-18T00:14:32.19062Z","steps":["trace[680288624] 'range keys from in-memory index tree' (duration: 102.949894ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:14:32.545822Z","caller":"traceutil/trace.go:171","msg":"trace[1896061689] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"102.573716ms","start":"2026-09-18T00:14:32.443213Z","end":"2026-09-18T00:14:32.545787Z","steps":["trace[1896061689] 'process raft request' (duration: 102.25042ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:14:59.410024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862} {"level":"info","ts":"2026-09-18T00:14:59.490425Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"79.329685ms","hash":3689614418,"current-db-size-bytes":52056064,"current-db-size":"52 MB","current-db-size-in-use-bytes":27906048,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-18T00:14:59.490491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3689614418,"revision":2862,"compact-revision":-1} {"level":"info","ts":"2026-09-18T00:18:52.742055Z","caller":"traceutil/trace.go:171","msg":"trace[1429397897] transaction","detail":"{read_only:false; response_revision:7027; number_of_response:1; }","duration":"102.263382ms","start":"2026-09-18T00:18:52.639762Z","end":"2026-09-18T00:18:52.742026Z","steps":["trace[1429397897] 'process raft request' (duration: 101.923933ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:20.075097Z","caller":"traceutil/trace.go:171","msg":"trace[1221861352] transaction","detail":"{read_only:false; response_revision:7191; number_of_response:1; }","duration":"160.261826ms","start":"2026-09-18T00:19:19.914809Z","end":"2026-09-18T00:19:20.075071Z","steps":["trace[1221861352] 'process raft request' (duration: 160.095131ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:20.257405Z","caller":"traceutil/trace.go:171","msg":"trace[1574284442] transaction","detail":"{read_only:false; response_revision:7192; number_of_response:1; }","duration":"110.735491ms","start":"2026-09-18T00:19:20.146646Z","end":"2026-09-18T00:19:20.257381Z","steps":["trace[1574284442] 'process raft request' (duration: 108.885219ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:23.246551Z","caller":"traceutil/trace.go:171","msg":"trace[1739896144] transaction","detail":"{read_only:false; response_revision:7208; number_of_response:1; }","duration":"140.500367ms","start":"2026-09-18T00:19:23.106013Z","end":"2026-09-18T00:19:23.246513Z","steps":["trace[1739896144] 'process raft request' (duration: 73.331835ms)","trace[1739896144] 'compare' (duration: 67.029188ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:19:24.288886Z","caller":"traceutil/trace.go:171","msg":"trace[482675509] transaction","detail":"{read_only:false; response_revision:7212; number_of_response:1; }","duration":"144.452743ms","start":"2026-09-18T00:19:24.144414Z","end":"2026-09-18T00:19:24.288867Z","steps":["trace[482675509] 'process raft request' (duration: 144.319349ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:24.718795Z","caller":"traceutil/trace.go:171","msg":"trace[436771088] transaction","detail":"{read_only:false; response_revision:7216; number_of_response:1; }","duration":"118.27742ms","start":"2026-09-18T00:19:24.60049Z","end":"2026-09-18T00:19:24.718768Z","steps":["trace[436771088] 'process raft request' (duration: 118.127126ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:25.431816Z","caller":"traceutil/trace.go:171","msg":"trace[1047824723] transaction","detail":"{read_only:false; response_revision:7217; number_of_response:1; }","duration":"322.211441ms","start":"2026-09-18T00:19:25.109557Z","end":"2026-09-18T00:19:25.431769Z","steps":["trace[1047824723] 'process raft request' (duration: 321.942584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:19:25.432095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:19:25.109521Z","time spent":"322.407437ms","remote":"127.0.0.1:47816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T00:19:25.473423Z","caller":"traceutil/trace.go:171","msg":"trace[1796539907] linearizableReadLoop","detail":"{readStateIndex:7489; appliedIndex:7487; }","duration":"222.451731ms","start":"2026-09-18T00:19:25.250943Z","end":"2026-09-18T00:19:25.473395Z","steps":["trace[1796539907] 'read index received' (duration: 180.613812ms)","trace[1796539907] 'applied index is now lower than readState.Index' (duration: 41.836679ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:19:25.473474Z","caller":"traceutil/trace.go:171","msg":"trace[683380301] transaction","detail":"{read_only:false; response_revision:7218; number_of_response:1; }","duration":"333.904468ms","start":"2026-09-18T00:19:25.139538Z","end":"2026-09-18T00:19:25.473442Z","steps":["trace[683380301] 'process raft request' (duration: 333.692152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:19:25.473801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.91083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:698"} {"level":"warn","ts":"2026-09-18T00:19:25.473782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T00:19:25.1395Z","time spent":"334.041503ms","remote":"127.0.0.1:47816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T00:19:25.473861Z","caller":"traceutil/trace.go:171","msg":"trace[1208103687] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:7218; }","duration":"127.016582ms","start":"2026-09-18T00:19:25.346829Z","end":"2026-09-18T00:19:25.473846Z","steps":["trace[1208103687] 'agreement among raft nodes before linearized reading' (duration: 126.812056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:19:25.473948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.021853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-18T00:19:25.474119Z","caller":"traceutil/trace.go:171","msg":"trace[905414948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7218; }","duration":"176.231599ms","start":"2026-09-18T00:19:25.297859Z","end":"2026-09-18T00:19:25.474091Z","steps":["trace[905414948] 'agreement among raft nodes before linearized reading' (duration: 175.767796ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T00:19:25.474281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.337076ms","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-18T00:19:25.474322Z","caller":"traceutil/trace.go:171","msg":"trace[1403594090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7218; }","duration":"223.413468ms","start":"2026-09-18T00:19:25.250896Z","end":"2026-09-18T00:19:25.474309Z","steps":["trace[1403594090] 'agreement among raft nodes before linearized reading' (duration: 222.644727ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T00:19:25.676937Z","caller":"traceutil/trace.go:171","msg":"trace[569205405] transaction","detail":"{read_only:false; response_revision:7221; number_of_response:1; }","duration":"112.591959ms","start":"2026-09-18T00:19:25.564309Z","end":"2026-09-18T00:19:25.676901Z","steps":["trace[569205405] 'process raft request' (duration: 85.516771ms)","trace[569205405] 'compare' (duration: 26.732819ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T00:19:59.418143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5343} {"level":"info","ts":"2026-09-18T00:19:59.526394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5343,"took":"107.18256ms","hash":3216658710,"current-db-size-bytes":52056064,"current-db-size":"52 MB","current-db-size-in-use-bytes":18804736,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T00:19:59.526435Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3216658710,"revision":5343,"compact-revision":2862}