{"level":"warn","ts":"2026-10-03T09:02:20.013903Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:02:20.014014Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-03T09:02:20.014129Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:02:20.014147Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-10-03T09:02:20.014173Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T09:02:20.014933Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]} {"level":"info","ts":"2026-10-03T09:02:20.015035Z","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.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-03T09:02:20.021229Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.924936ms"} {"level":"info","ts":"2026-10-03T09:02:20.044504Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-10-03T09:02:20.044597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T09:02:20.044626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-10-03T09:02:20.044719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T09:02:20.044741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-10-03T09:02:20.045236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-10-03T09:02:20.054843Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T09:02:20.056171Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T09:02:20.059442Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-03T09:02:20.061596Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T09:02:20.066485Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T09:02:20.066598Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T09:02:20.066678Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-10-03T09:02:20.06671Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-10-03T09:02:20.066702Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:02:20.066799Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:02:20.066815Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T09:02:20.066836Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T09:02:20.066861Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T09:02:20.067392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-10-03T09:02:20.067483Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-10-03T09:02:20.446504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T09:02:20.446564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T09:02:20.446592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-10-03T09:02:20.446675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-10-03T09:02:20.446695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-10-03T09:02:20.446749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-10-03T09:02:20.446798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-10-03T09:02:20.449331Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:02:20.493681Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T09:02:20.493932Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:02:20.493985Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:02:20.494359Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T09:02:20.494524Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T09:02:20.49598Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:02:20.496133Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:02:20.496173Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:02:20.49866Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-03T09:02:20.503645Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"info","ts":"2026-10-03T09:02:42.699182Z","caller":"traceutil/trace.go:171","msg":"trace[936748166] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"131.845047ms","start":"2026-10-03T09:02:42.567301Z","end":"2026-10-03T09:02:42.699146Z","steps":["trace[936748166] 'process raft request' (duration: 131.668273ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:02:42.699657Z","caller":"traceutil/trace.go:171","msg":"trace[1837005853] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"134.354656ms","start":"2026-10-03T09:02:42.565268Z","end":"2026-10-03T09:02:42.699622Z","steps":["trace[1837005853] 'process raft request' (duration: 102.473368ms)","trace[1837005853] 'compare' (duration: 31.109873ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:02:56.602717Z","caller":"traceutil/trace.go:171","msg":"trace[1715479418] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"116.827649ms","start":"2026-10-03T09:02:56.485863Z","end":"2026-10-03T09:02:56.602691Z","steps":["trace[1715479418] 'process raft request' (duration: 116.039804ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:02:56.616404Z","caller":"traceutil/trace.go:171","msg":"trace[1433998570] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"108.672267ms","start":"2026-10-03T09:02:56.507698Z","end":"2026-10-03T09:02:56.61637Z","steps":["trace[1433998570] 'process raft request' (duration: 108.473574ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:02:56.616567Z","caller":"traceutil/trace.go:171","msg":"trace[60239819] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"105.399486ms","start":"2026-10-03T09:02:56.511158Z","end":"2026-10-03T09:02:56.616558Z","steps":["trace[60239819] 'process raft request' (duration: 105.208472ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:02:56.616675Z","caller":"traceutil/trace.go:171","msg":"trace[771341418] transaction","detail":"{read_only:false; number_of_response:1; response_revision:498; }","duration":"108.842251ms","start":"2026-10-03T09:02:56.507826Z","end":"2026-10-03T09:02:56.616668Z","steps":["trace[771341418] 'process raft request' (duration: 108.465954ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:02:56.616941Z","caller":"traceutil/trace.go:171","msg":"trace[721607309] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"105.722132ms","start":"2026-10-03T09:02:56.511209Z","end":"2026-10-03T09:02:56.616932Z","steps":["trace[721607309] 'process raft request' (duration: 105.208482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:03:02.571479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.022928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-03T09:03:02.571629Z","caller":"traceutil/trace.go:171","msg":"trace[1129723458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"149.254222ms","start":"2026-10-03T09:03:02.422351Z","end":"2026-10-03T09:03:02.571605Z","steps":["trace[1129723458] 'range keys from in-memory index tree' (duration: 148.841925ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:03:02.826027Z","caller":"traceutil/trace.go:171","msg":"trace[701922176] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"174.141625ms","start":"2026-10-03T09:03:02.651844Z","end":"2026-10-03T09:03:02.825986Z","steps":["trace[701922176] 'process raft request' (duration: 173.89277ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:03:03.04682Z","caller":"traceutil/trace.go:171","msg":"trace[1402081012] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"198.998772ms","start":"2026-10-03T09:03:02.847787Z","end":"2026-10-03T09:03:03.046786Z","steps":["trace[1402081012] 'process raft request' (duration: 198.779908ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:03:03.624652Z","caller":"traceutil/trace.go:171","msg":"trace[1035181606] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"278.949668ms","start":"2026-10-03T09:03:03.345653Z","end":"2026-10-03T09:03:03.624602Z","steps":["trace[1035181606] 'read index received' (duration: 277.562092ms)","trace[1035181606] 'applied index is now lower than readState.Index' (duration: 1.385516ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:03:03.624774Z","caller":"traceutil/trace.go:171","msg":"trace[1469063024] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"306.471026ms","start":"2026-10-03T09:03:03.318238Z","end":"2026-10-03T09:03:03.624709Z","steps":["trace[1469063024] 'process raft request' (duration: 305.429097ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:03:03.625037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.344954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-03T09:03:03.625203Z","caller":"traceutil/trace.go:171","msg":"trace[1186909417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"279.570659ms","start":"2026-10-03T09:03:03.345607Z","end":"2026-10-03T09:03:03.625177Z","steps":["trace[1186909417] 'agreement among raft nodes before linearized reading' (duration: 279.180842ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:03:03.626016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:03:03.318198Z","time spent":"306.767131ms","remote":"127.0.0.1:60974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:03:03.645693Z","caller":"traceutil/trace.go:171","msg":"trace[1347745113] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"190.872634ms","start":"2026-10-03T09:03:03.454796Z","end":"2026-10-03T09:03:03.645668Z","steps":["trace[1347745113] 'process raft request' (duration: 190.731091ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:03:05.129179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.527405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:03:05.129268Z","caller":"traceutil/trace.go:171","msg":"trace[1476620634] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:620; }","duration":"119.648667ms","start":"2026-10-03T09:03:05.009592Z","end":"2026-10-03T09:03:05.129241Z","steps":["trace[1476620634] 'range keys from in-memory index tree' (duration: 110.260118ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:03:05.135034Z","caller":"traceutil/trace.go:171","msg":"trace[1183656460] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"112.266875ms","start":"2026-10-03T09:03:05.022752Z","end":"2026-10-03T09:03:05.135019Z","steps":["trace[1183656460] 'process raft request' (duration: 112.143332ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:03:05.140708Z","caller":"traceutil/trace.go:171","msg":"trace[1876967802] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"117.406487ms","start":"2026-10-03T09:03:05.023284Z","end":"2026-10-03T09:03:05.140691Z","steps":["trace[1876967802] 'process raft request' (duration: 117.315995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:36.492772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.112143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-03T09:04:36.492859Z","caller":"traceutil/trace.go:171","msg":"trace[1583063881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1832; }","duration":"296.229745ms","start":"2026-10-03T09:04:36.196608Z","end":"2026-10-03T09:04:36.492838Z","steps":["trace[1583063881] 'range keys from in-memory index tree' (duration: 295.933121ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:36.492913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.154205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e782e246-4420-442f-95f4-f36af7edf9c2\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-10-03T09:04:36.492899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.407474ms","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-10-03T09:04:36.493014Z","caller":"traceutil/trace.go:171","msg":"trace[796767401] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e782e246-4420-442f-95f4-f36af7edf9c2; range_end:; response_count:1; response_revision:1832; }","duration":"186.296937ms","start":"2026-10-03T09:04:36.306694Z","end":"2026-10-03T09:04:36.492991Z","steps":["trace[796767401] 'range keys from in-memory index tree' (duration: 185.948782ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:04:36.493096Z","caller":"traceutil/trace.go:171","msg":"trace[758010507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1832; }","duration":"304.606096ms","start":"2026-10-03T09:04:36.188405Z","end":"2026-10-03T09:04:36.493011Z","steps":["trace[758010507] 'range keys from in-memory index tree' (duration: 304.197851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:36.493242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:04:36.188379Z","time spent":"304.811629ms","remote":"127.0.0.1:32916","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":"info","ts":"2026-10-03T09:04:36.493399Z","caller":"traceutil/trace.go:171","msg":"trace[1007986569] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"170.056734ms","start":"2026-10-03T09:04:36.323325Z","end":"2026-10-03T09:04:36.493381Z","steps":["trace[1007986569] 'process raft request' (duration: 116.17557ms)","trace[1007986569] 'compare' (duration: 53.003741ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:04:42.632988Z","caller":"traceutil/trace.go:171","msg":"trace[188214836] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"121.35043ms","start":"2026-10-03T09:04:42.511617Z","end":"2026-10-03T09:04:42.632967Z","steps":["trace[188214836] 'process raft request' (duration: 121.211529ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:04:49.484209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.822679ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-03T09:05:15.762258Z","caller":"traceutil/trace.go:171","msg":"trace[1928842579] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"124.262062ms","start":"2026-10-03T09:05:15.637973Z","end":"2026-10-03T09:05:15.762235Z","steps":["trace[1928842579] 'process raft request' (duration: 124.109149ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:16.009227Z","caller":"traceutil/trace.go:171","msg":"trace[1171228385] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"121.104356ms","start":"2026-10-03T09:05:15.888092Z","end":"2026-10-03T09:05:16.009196Z","steps":["trace[1171228385] 'process raft request' (duration: 51.979429ms)","trace[1171228385] 'compare' (duration: 68.810763ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:05:16.358762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.832417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:05:16.358854Z","caller":"traceutil/trace.go:171","msg":"trace[520608533] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"210.432521ms","start":"2026-10-03T09:05:16.148404Z","end":"2026-10-03T09:05:16.358836Z","steps":["trace[520608533] 'process raft request' (duration: 67.452093ms)","trace[520608533] 'compare' (duration: 142.529353ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:05:16.99012Z","caller":"traceutil/trace.go:171","msg":"trace[2049197332] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"146.152103ms","start":"2026-10-03T09:05:16.843944Z","end":"2026-10-03T09:05:16.990096Z","steps":["trace[2049197332] 'process raft request' (duration: 145.92568ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:17.20144Z","caller":"traceutil/trace.go:171","msg":"trace[613866731] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"207.023974ms","start":"2026-10-03T09:05:16.994387Z","end":"2026-10-03T09:05:17.201411Z","steps":["trace[613866731] 'process raft request' (duration: 206.867522ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:17.214723Z","caller":"traceutil/trace.go:171","msg":"trace[1036638283] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2179; }","duration":"198.372473ms","start":"2026-10-03T09:05:17.016336Z","end":"2026-10-03T09:05:17.214709Z","steps":["trace[1036638283] 'read index received' (duration: 184.901167ms)","trace[1036638283] 'applied index is now lower than readState.Index' (duration: 13.470576ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:05:17.214883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.531825ms","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-10-03T09:05:17.214911Z","caller":"traceutil/trace.go:171","msg":"trace[106922945] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2105; }","duration":"198.589897ms","start":"2026-10-03T09:05:17.016311Z","end":"2026-10-03T09:05:17.214901Z","steps":["trace[106922945] 'agreement among raft nodes before linearized reading' (duration: 198.449625ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:05:17.215081Z","caller":"traceutil/trace.go:171","msg":"trace[1862673380] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"220.022953ms","start":"2026-10-03T09:05:16.995051Z","end":"2026-10-03T09:05:17.215074Z","steps":["trace[1862673380] 'process raft request' (duration: 219.598897ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:12.288063Z","caller":"traceutil/trace.go:171","msg":"trace[1419377957] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"113.553876ms","start":"2026-10-03T09:11:12.174478Z","end":"2026-10-03T09:11:12.288032Z","steps":["trace[1419377957] 'process raft request' (duration: 113.336262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:11:12.900409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.195404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-03T09:11:12.900472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.69868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:11:12.900513Z","caller":"traceutil/trace.go:171","msg":"trace[1059729173] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4722; }","duration":"238.378737ms","start":"2026-10-03T09:11:12.662116Z","end":"2026-10-03T09:11:12.900495Z","steps":["trace[1059729173] 'count revisions from in-memory index tree' (duration: 238.114794ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:12.900555Z","caller":"traceutil/trace.go:171","msg":"trace[2003982946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4722; }","duration":"265.841641ms","start":"2026-10-03T09:11:12.634695Z","end":"2026-10-03T09:11:12.900536Z","steps":["trace[2003982946] 'range keys from in-memory index tree' (duration: 265.557236ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:12.900841Z","caller":"traceutil/trace.go:171","msg":"trace[1820419457] linearizableReadLoop","detail":"{readStateIndex:4897; appliedIndex:4896; }","duration":"186.546751ms","start":"2026-10-03T09:11:12.714264Z","end":"2026-10-03T09:11:12.900811Z","steps":["trace[1820419457] 'read index received' (duration: 171.842069ms)","trace[1820419457] 'applied index is now lower than readState.Index' (duration: 14.703542ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:11:12.900864Z","caller":"traceutil/trace.go:171","msg":"trace[1443562766] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"229.644054ms","start":"2026-10-03T09:11:12.671203Z","end":"2026-10-03T09:11:12.900847Z","steps":["trace[1443562766] 'process raft request' (duration: 214.958271ms)","trace[1443562766] 'compare' (duration: 14.149284ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:11:12.900993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.725494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-03T09:11:12.901028Z","caller":"traceutil/trace.go:171","msg":"trace[1370627682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4723; }","duration":"186.791186ms","start":"2026-10-03T09:11:12.714228Z","end":"2026-10-03T09:11:12.901019Z","steps":["trace[1370627682] 'agreement among raft nodes before linearized reading' (duration: 186.733875ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:13.229084Z","caller":"traceutil/trace.go:171","msg":"trace[239086058] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"155.821863ms","start":"2026-10-03T09:11:13.073199Z","end":"2026-10-03T09:11:13.229021Z","steps":["trace[239086058] 'process raft request' (duration: 139.603355ms)","trace[239086058] 'compare' (duration: 16.038135ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:11:13.236963Z","caller":"traceutil/trace.go:171","msg":"trace[1804176049] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"161.373284ms","start":"2026-10-03T09:11:13.075572Z","end":"2026-10-03T09:11:13.236945Z","steps":["trace[1804176049] 'process raft request' (duration: 161.072249ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:13.237204Z","caller":"traceutil/trace.go:171","msg":"trace[1813137089] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"161.290473ms","start":"2026-10-03T09:11:13.075888Z","end":"2026-10-03T09:11:13.237179Z","steps":["trace[1813137089] 'process raft request' (duration: 160.888677ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:19.836812Z","caller":"traceutil/trace.go:171","msg":"trace[1465152943] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"116.677441ms","start":"2026-10-03T09:11:19.720107Z","end":"2026-10-03T09:11:19.836784Z","steps":["trace[1465152943] 'process raft request' (duration: 71.927805ms)","trace[1465152943] 'compare' (duration: 44.526473ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:11:19.989895Z","caller":"traceutil/trace.go:171","msg":"trace[150647127] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"241.253441ms","start":"2026-10-03T09:11:19.748594Z","end":"2026-10-03T09:11:19.989848Z","steps":["trace[150647127] 'process raft request' (duration: 240.865575ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:22.417317Z","caller":"traceutil/trace.go:171","msg":"trace[594501372] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"173.217277ms","start":"2026-10-03T09:11:22.244078Z","end":"2026-10-03T09:11:22.417295Z","steps":["trace[594501372] 'process raft request' (duration: 173.092035ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:22.446Z","caller":"traceutil/trace.go:171","msg":"trace[1171386423] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"189.665158ms","start":"2026-10-03T09:11:22.256312Z","end":"2026-10-03T09:11:22.445977Z","steps":["trace[1171386423] 'process raft request' (duration: 189.476555ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:22.446142Z","caller":"traceutil/trace.go:171","msg":"trace[1638542510] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5085; }","duration":"109.54294ms","start":"2026-10-03T09:11:22.33657Z","end":"2026-10-03T09:11:22.446113Z","steps":["trace[1638542510] 'read index received' (duration: 80.645885ms)","trace[1638542510] 'applied index is now lower than readState.Index' (duration: 28.894955ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:11:22.446354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.772355ms","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-10-03T09:11:22.446433Z","caller":"traceutil/trace.go:171","msg":"trace[395549001] 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:4907; }","duration":"109.900966ms","start":"2026-10-03T09:11:22.336518Z","end":"2026-10-03T09:11:22.446419Z","steps":["trace[395549001] 'agreement among raft nodes before linearized reading' (duration: 109.690633ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:26.117779Z","caller":"traceutil/trace.go:171","msg":"trace[228211465] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"105.121344ms","start":"2026-10-03T09:11:26.012639Z","end":"2026-10-03T09:11:26.11776Z","steps":["trace[228211465] 'process raft request' (duration: 105.009562ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:11:36.497827Z","caller":"traceutil/trace.go:171","msg":"trace[2091110361] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"336.114639ms","start":"2026-10-03T09:11:36.161647Z","end":"2026-10-03T09:11:36.497762Z","steps":["trace[2091110361] 'process raft request' (duration: 335.938486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:11:36.498116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:11:36.161624Z","time spent":"336.400673ms","remote":"127.0.0.1:32916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T09:11:36.546301Z","caller":"traceutil/trace.go:171","msg":"trace[278351257] linearizableReadLoop","detail":"{readStateIndex:5288; appliedIndex:5286; }","duration":"142.922363ms","start":"2026-10-03T09:11:36.403356Z","end":"2026-10-03T09:11:36.546279Z","steps":["trace[278351257] 'read index received' (duration: 94.240928ms)","trace[278351257] 'applied index is now lower than readState.Index' (duration: 48.680265ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:11:36.546396Z","caller":"traceutil/trace.go:171","msg":"trace[41093149] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"307.338109ms","start":"2026-10-03T09:11:36.239025Z","end":"2026-10-03T09:11:36.546363Z","steps":["trace[41093149] 'process raft request' (duration: 307.067324ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:11:36.546567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:11:36.238999Z","time spent":"307.46702ms","remote":"127.0.0.1:32916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:11:36.54662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.206259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16552"} {"level":"info","ts":"2026-10-03T09:11:36.546661Z","caller":"traceutil/trace.go:171","msg":"trace[301832772] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5101; }","duration":"143.29767ms","start":"2026-10-03T09:11:36.40335Z","end":"2026-10-03T09:11:36.546648Z","steps":["trace[301832772] 'agreement among raft nodes before linearized reading' (duration: 143.052226ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:11:36.559229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.282227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-03T09:11:36.559289Z","caller":"traceutil/trace.go:171","msg":"trace[518848403] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5102; }","duration":"111.376938ms","start":"2026-10-03T09:11:36.447897Z","end":"2026-10-03T09:11:36.559274Z","steps":["trace[518848403] 'agreement among raft nodes before linearized reading' (duration: 111.223406ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:12:20.727204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-10-03T09:12:20.849755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"120.898631ms","hash":2656896544,"current-db-size-bytes":53813248,"current-db-size":"54 MB","current-db-size-in-use-bytes":28577792,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-03T09:12:20.849816Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2656896544,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-10-03T09:15:23.505147Z","caller":"traceutil/trace.go:171","msg":"trace[238447600] transaction","detail":"{read_only:false; response_revision:6729; number_of_response:1; }","duration":"124.709894ms","start":"2026-10-03T09:15:23.380091Z","end":"2026-10-03T09:15:23.504801Z","steps":["trace[238447600] 'process raft request' (duration: 124.531459ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:23.511031Z","caller":"traceutil/trace.go:171","msg":"trace[669112555] transaction","detail":"{read_only:false; response_revision:6730; number_of_response:1; }","duration":"129.894232ms","start":"2026-10-03T09:15:23.381117Z","end":"2026-10-03T09:15:23.511011Z","steps":["trace[669112555] 'process raft request' (duration: 129.782079ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:17:20.737877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5462} {"level":"info","ts":"2026-10-03T09:17:20.821682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5462,"took":"82.03231ms","hash":3323223484,"current-db-size-bytes":53813248,"current-db-size":"54 MB","current-db-size-in-use-bytes":18542592,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-10-03T09:17:20.82175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3323223484,"revision":5462,"compact-revision":2878}