{"level":"warn","ts":"2026-05-09T05:08:46.724906Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T05:08:46.724988Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-05-09T05:08:46.725052Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T05:08:46.725064Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-05-09T05:08:46.725081Z","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-05-09T05:08:46.725735Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]}
{"level":"info","ts":"2026-05-09T05:08:46.725803Z","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://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-05-09T05:08:46.729383Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.356179ms"}
{"level":"info","ts":"2026-05-09T05:08:46.735902Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"}
{"level":"info","ts":"2026-05-09T05:08:46.735994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T05:08:46.736023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"}
{"level":"info","ts":"2026-05-09T05:08:46.736037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T05:08:46.73605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"}
{"level":"info","ts":"2026-05-09T05:08:46.736091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"warn","ts":"2026-05-09T05:08:46.744073Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T05:08:46.745326Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T05:08:46.746313Z","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-05-09T05:08:46.748465Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T05:08:46.748734Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T05:08:46.748875Z","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-05-09T05:08:46.749051Z","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-05-09T05:08:46.749079Z","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-05-09T05:08:46.749353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"info","ts":"2026-05-09T05:08:46.750991Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-05-09T05:08:46.753921Z","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-05-09T05:08:46.754098Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-05-09T05:08:46.754179Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-05-09T05:08:46.754232Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T05:08:46.754264Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T05:08:47.536956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T05:08:47.537046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T05:08:47.537076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"}
{"level":"info","ts":"2026-05-09T05:08:47.537099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"}
{"level":"info","ts":"2026-05-09T05:08:47.537176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-05-09T05:08:47.537196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"}
{"level":"info","ts":"2026-05-09T05:08:47.53721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-05-09T05:08:47.538481Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:08:47.539348Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T05:08:47.539381Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T05:08:47.539401Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T05:08:47.539761Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T05:08:47.539799Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T05:08:47.542932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"}
{"level":"info","ts":"2026-05-09T05:08:47.543392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T05:08:47.553392Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:08:47.553525Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:08:47.553551Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:09:22.458644Z","caller":"traceutil/trace.go:171","msg":"trace[1431319106] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"141.942495ms","start":"2026-05-09T05:09:22.316669Z","end":"2026-05-09T05:09:22.458611Z","steps":["trace[1431319106] 'read index received'  (duration: 140.67358ms)","trace[1431319106] 'applied index is now lower than readState.Index'  (duration: 1.268015ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:09:22.458789Z","caller":"traceutil/trace.go:171","msg":"trace[2028185800] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"258.881844ms","start":"2026-05-09T05:09:22.199853Z","end":"2026-05-09T05:09:22.458734Z","steps":["trace[2028185800] 'process raft request'  (duration: 257.90644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:09:22.458849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.149063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T05:09:22.459022Z","caller":"traceutil/trace.go:171","msg":"trace[1519089482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"142.393141ms","start":"2026-05-09T05:09:22.316593Z","end":"2026-05-09T05:09:22.458986Z","steps":["trace[1519089482] 'agreement among raft nodes before linearized reading'  (duration: 142.152193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:09:22.789833Z","caller":"traceutil/trace.go:171","msg":"trace[1677522825] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"267.523617ms","start":"2026-05-09T05:09:22.522259Z","end":"2026-05-09T05:09:22.789782Z","steps":["trace[1677522825] 'process raft request'  (duration: 222.615302ms)","trace[1677522825] 'compare'  (duration: 44.48797ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:09:23.298528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.859537ms","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-05-09T05:09:23.298615Z","caller":"traceutil/trace.go:171","msg":"trace[4431763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"399.970851ms","start":"2026-05-09T05:09:22.898624Z","end":"2026-05-09T05:09:23.298595Z","steps":["trace[4431763] 'range keys from in-memory index tree'  (duration: 399.454223ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:09:23.298659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:09:22.898553Z","time spent":"400.096905ms","remote":"127.0.0.1:38104","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-05-09T05:09:23.299053Z","caller":"traceutil/trace.go:171","msg":"trace[302431245] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"308.426692ms","start":"2026-05-09T05:09:22.990596Z","end":"2026-05-09T05:09:23.299022Z","steps":["trace[302431245] 'process raft request'  (duration: 283.568669ms)","trace[302431245] 'compare'  (duration: 24.100906ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:09:23.299124Z","caller":"traceutil/trace.go:171","msg":"trace[1583002052] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"186.96046ms","start":"2026-05-09T05:09:23.112141Z","end":"2026-05-09T05:09:23.299102Z","steps":["trace[1583002052] 'read index received'  (duration: 162.061517ms)","trace[1583002052] 'applied index is now lower than readState.Index'  (duration: 24.896983ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:09:23.299246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.106526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-09T05:09:23.299279Z","caller":"traceutil/trace.go:171","msg":"trace[76231843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"187.182638ms","start":"2026-05-09T05:09:23.112087Z","end":"2026-05-09T05:09:23.299269Z","steps":["trace[76231843] 'agreement among raft nodes before linearized reading'  (duration: 187.082305ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:09:23.299557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:09:22.990571Z","time spent":"308.541656ms","remote":"127.0.0.1:38026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4584,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:369 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4550 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-05-09T05:09:23.300575Z","caller":"traceutil/trace.go:171","msg":"trace[1761746529] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"106.913811ms","start":"2026-05-09T05:09:23.193643Z","end":"2026-05-09T05:09:23.300557Z","steps":["trace[1761746529] 'process raft request'  (duration: 106.29915ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:09:43.953842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.477265ms","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-05-09T05:09:43.953983Z","caller":"traceutil/trace.go:171","msg":"trace[8888152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:759; }","duration":"166.694133ms","start":"2026-05-09T05:09:43.78726Z","end":"2026-05-09T05:09:43.953954Z","steps":["trace[8888152] 'range keys from in-memory index tree'  (duration: 166.157325ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:10:13.03171Z","caller":"traceutil/trace.go:171","msg":"trace[605279971] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"214.748898ms","start":"2026-05-09T05:10:12.816694Z","end":"2026-05-09T05:10:13.031443Z","steps":["trace[605279971] 'process raft request'  (duration: 214.561224ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:10:57.80011Z","caller":"traceutil/trace.go:171","msg":"trace[55543172] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"163.708524ms","start":"2026-05-09T05:10:57.636366Z","end":"2026-05-09T05:10:57.800074Z","steps":["trace[55543172] 'process raft request'  (duration: 163.435916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:10:57.862463Z","caller":"traceutil/trace.go:171","msg":"trace[939760700] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1890; }","duration":"145.861585ms","start":"2026-05-09T05:10:57.716576Z","end":"2026-05-09T05:10:57.862438Z","steps":["trace[939760700] 'read index received'  (duration: 83.265181ms)","trace[939760700] 'applied index is now lower than readState.Index'  (duration: 62.595374ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:10:57.862591Z","caller":"traceutil/trace.go:171","msg":"trace[1812119491] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"219.723303ms","start":"2026-05-09T05:10:57.642836Z","end":"2026-05-09T05:10:57.862559Z","steps":["trace[1812119491] 'process raft request'  (duration: 203.508749ms)","trace[1812119491] 'compare'  (duration: 15.974367ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:10:57.862826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.224535ms","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-05-09T05:10:57.862886Z","caller":"traceutil/trace.go:171","msg":"trace[578649778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1824; }","duration":"146.341309ms","start":"2026-05-09T05:10:57.716523Z","end":"2026-05-09T05:10:57.862865Z","steps":["trace[578649778] 'agreement among raft nodes before linearized reading'  (duration: 146.03652ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:10:57.863093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.111112ms","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-05-09T05:10:57.86323Z","caller":"traceutil/trace.go:171","msg":"trace[2082776283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1824; }","duration":"141.273916ms","start":"2026-05-09T05:10:57.721921Z","end":"2026-05-09T05:10:57.863195Z","steps":["trace[2082776283] 'agreement among raft nodes before linearized reading'  (duration: 140.795762ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:11:27.123815Z","caller":"traceutil/trace.go:171","msg":"trace[2012360825] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"102.718244ms","start":"2026-05-09T05:11:27.021068Z","end":"2026-05-09T05:11:27.123786Z","steps":["trace[2012360825] 'process raft request'  (duration: 102.549969ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:11:28.319286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.800627ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334367551918055515 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2037 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:11:28.319657Z","caller":"traceutil/trace.go:171","msg":"trace[533717897] linearizableReadLoop","detail":"{readStateIndex:2123; appliedIndex:2122; }","duration":"297.040343ms","start":"2026-05-09T05:11:28.022564Z","end":"2026-05-09T05:11:28.319604Z","steps":["trace[533717897] 'read index received'  (duration: 127.274876ms)","trace[533717897] 'applied index is now lower than readState.Index'  (duration: 169.759257ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:11:28.320446Z","caller":"traceutil/trace.go:171","msg":"trace[894307531] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"299.470687ms","start":"2026-05-09T05:11:28.020869Z","end":"2026-05-09T05:11:28.32034Z","steps":["trace[894307531] 'process raft request'  (duration: 129.03793ms)","trace[894307531] 'compare'  (duration: 168.499519ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:11:28.320973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.395684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-09T05:11:28.321007Z","caller":"traceutil/trace.go:171","msg":"trace[620111764] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2048; }","duration":"298.456566ms","start":"2026-05-09T05:11:28.022543Z","end":"2026-05-09T05:11:28.320999Z","steps":["trace[620111764] 'agreement among raft nodes before linearized reading'  (duration: 298.271091ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:11:28.467531Z","caller":"traceutil/trace.go:171","msg":"trace[967873281] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"142.772337ms","start":"2026-05-09T05:11:28.32473Z","end":"2026-05-09T05:11:28.467502Z","steps":["trace[967873281] 'process raft request'  (duration: 120.411588ms)","trace[967873281] 'compare'  (duration: 22.242915ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:13:17.339615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.317251ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334367551918057186 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2729 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:13:17.339684Z","caller":"traceutil/trace.go:171","msg":"trace[1895060132] linearizableReadLoop","detail":"{readStateIndex:2840; appliedIndex:2839; }","duration":"141.974812ms","start":"2026-05-09T05:13:17.197699Z","end":"2026-05-09T05:13:17.339674Z","steps":["trace[1895060132] 'read index received'  (duration: 11.472964ms)","trace[1895060132] 'applied index is now lower than readState.Index'  (duration: 130.501148ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:13:17.339731Z","caller":"traceutil/trace.go:171","msg":"trace[892446936] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"149.542146ms","start":"2026-05-09T05:13:17.190184Z","end":"2026-05-09T05:13:17.339726Z","steps":["trace[892446936] 'process raft request'  (duration: 19.046198ms)","trace[892446936] 'compare'  (duration: 130.254759ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:13:17.33995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.248611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18adcdae7d969931\" ","response":"range_response_count:1 size:777"}
{"level":"info","ts":"2026-05-09T05:13:17.33997Z","caller":"traceutil/trace.go:171","msg":"trace[1403366539] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18adcdae7d969931; range_end:; response_count:1; response_revision:2740; }","duration":"142.309774ms","start":"2026-05-09T05:13:17.197656Z","end":"2026-05-09T05:13:17.339965Z","steps":["trace[1403366539] 'agreement among raft nodes before linearized reading'  (duration: 142.235751ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:16:52.184201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.739845ms","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-05-09T05:16:52.184319Z","caller":"traceutil/trace.go:171","msg":"trace[1586083918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4514; }","duration":"127.89495ms","start":"2026-05-09T05:16:52.056401Z","end":"2026-05-09T05:16:52.184296Z","steps":["trace[1586083918] 'range keys from in-memory index tree'  (duration: 127.574581ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:16:52.184737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.37043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-09T05:16:52.184799Z","caller":"traceutil/trace.go:171","msg":"trace[1828925928] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4514; }","duration":"163.468343ms","start":"2026-05-09T05:16:52.021313Z","end":"2026-05-09T05:16:52.184781Z","steps":["trace[1828925928] 'range keys from in-memory index tree'  (duration: 163.212606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:16:52.185248Z","caller":"traceutil/trace.go:171","msg":"trace[831532391] transaction","detail":"{read_only:false; response_revision:4515; number_of_response:1; }","duration":"125.690689ms","start":"2026-05-09T05:16:52.059532Z","end":"2026-05-09T05:16:52.185222Z","steps":["trace[831532391] 'process raft request'  (duration: 62.566512ms)","trace[831532391] 'compare'  (duration: 62.967893ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:17:00.251993Z","caller":"traceutil/trace.go:171","msg":"trace[606870266] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"144.964046ms","start":"2026-05-09T05:17:00.107003Z","end":"2026-05-09T05:17:00.251967Z","steps":["trace[606870266] 'process raft request'  (duration: 134.802025ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:00.495139Z","caller":"traceutil/trace.go:171","msg":"trace[1467676061] linearizableReadLoop","detail":"{readStateIndex:4882; appliedIndex:4881; }","duration":"116.48288ms","start":"2026-05-09T05:17:00.378633Z","end":"2026-05-09T05:17:00.495116Z","steps":["trace[1467676061] 'read index received'  (duration: 116.220643ms)","trace[1467676061] 'applied index is now lower than readState.Index'  (duration: 261.367µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:17:00.495216Z","caller":"traceutil/trace.go:171","msg":"trace[1769273009] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"116.991704ms","start":"2026-05-09T05:17:00.378188Z","end":"2026-05-09T05:17:00.495179Z","steps":["trace[1769273009] 'process raft request'  (duration: 116.514381ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:00.495491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.83387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a3467a2c-0efe-4715-bcfe-725ec6b1f9c1\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-05-09T05:17:00.495534Z","caller":"traceutil/trace.go:171","msg":"trace[717005099] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a3467a2c-0efe-4715-bcfe-725ec6b1f9c1; range_end:; response_count:1; response_revision:4709; }","duration":"116.909912ms","start":"2026-05-09T05:17:00.378611Z","end":"2026-05-09T05:17:00.495521Z","steps":["trace[717005099] 'agreement among raft nodes before linearized reading'  (duration: 116.611983ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:00.503088Z","caller":"traceutil/trace.go:171","msg":"trace[1545705578] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"124.351677ms","start":"2026-05-09T05:17:00.378714Z","end":"2026-05-09T05:17:00.503066Z","steps":["trace[1545705578] 'process raft request'  (duration: 124.203753ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:00.503176Z","caller":"traceutil/trace.go:171","msg":"trace[1034091912] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"124.399929ms","start":"2026-05-09T05:17:00.378763Z","end":"2026-05-09T05:17:00.503163Z","steps":["trace[1034091912] 'process raft request'  (duration: 124.235434ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:00.503245Z","caller":"traceutil/trace.go:171","msg":"trace[1619889078] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"124.236994ms","start":"2026-05-09T05:17:00.378973Z","end":"2026-05-09T05:17:00.50321Z","steps":["trace[1619889078] 'process raft request'  (duration: 124.060849ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:00.503251Z","caller":"traceutil/trace.go:171","msg":"trace[1049145730] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"119.082942ms","start":"2026-05-09T05:17:00.384143Z","end":"2026-05-09T05:17:00.503226Z","steps":["trace[1049145730] 'process raft request'  (duration: 118.924597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:12.736082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.400969ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334367551918062269 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" mod_revision:4848 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" value_size:17113 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:17:12.736259Z","caller":"traceutil/trace.go:171","msg":"trace[690327210] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"185.418759ms","start":"2026-05-09T05:17:12.550824Z","end":"2026-05-09T05:17:12.736242Z","steps":["trace[690327210] 'process raft request'  (duration: 185.359167ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:12.736476Z","caller":"traceutil/trace.go:171","msg":"trace[219192045] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"266.545264ms","start":"2026-05-09T05:17:12.469895Z","end":"2026-05-09T05:17:12.73644Z","steps":["trace[219192045] 'process raft request'  (duration: 136.692663ms)","trace[219192045] 'compare'  (duration: 129.306506ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:17:12.736547Z","caller":"traceutil/trace.go:171","msg":"trace[1640103788] linearizableReadLoop","detail":"{readStateIndex:5056; appliedIndex:5055; }","duration":"263.54944ms","start":"2026-05-09T05:17:12.472985Z","end":"2026-05-09T05:17:12.736534Z","steps":["trace[1640103788] 'read index received'  (duration: 133.631077ms)","trace[1640103788] 'applied index is now lower than readState.Index'  (duration: 129.917053ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:17:12.73672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.731705ms","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-05-09T05:17:12.73676Z","caller":"traceutil/trace.go:171","msg":"trace[58555576] 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:4877; }","duration":"263.806907ms","start":"2026-05-09T05:17:12.472941Z","end":"2026-05-09T05:17:12.736747Z","steps":["trace[58555576] 'agreement among raft nodes before linearized reading'  (duration: 263.640602ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:13.725301Z","caller":"traceutil/trace.go:171","msg":"trace[1379701640] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"145.516485ms","start":"2026-05-09T05:17:13.579746Z","end":"2026-05-09T05:17:13.725262Z","steps":["trace[1379701640] 'process raft request'  (duration: 141.131261ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:43.535141Z","caller":"traceutil/trace.go:171","msg":"trace[1889727379] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"157.905114ms","start":"2026-05-09T05:17:43.377164Z","end":"2026-05-09T05:17:43.535069Z","steps":["trace[1889727379] 'process raft request'  (duration: 139.43527ms)","trace[1889727379] 'compare'  (duration: 18.161975ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:17:45.502402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.647473ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334367551918063065 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5174 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:17:45.502869Z","caller":"traceutil/trace.go:171","msg":"trace[252105788] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"164.882863ms","start":"2026-05-09T05:17:45.337957Z","end":"2026-05-09T05:17:45.502839Z","steps":["trace[252105788] 'process raft request'  (duration: 53.644963ms)","trace[252105788] 'compare'  (duration: 110.337774ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:18:47.5736Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900}
{"level":"info","ts":"2026-05-09T05:18:47.671673Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"96.239271ms","hash":3559960121,"current-db-size-bytes":54423552,"current-db-size":"54 MB","current-db-size-in-use-bytes":29573120,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T05:18:47.671772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3559960121,"revision":2900,"compact-revision":-1}
{"level":"info","ts":"2026-05-09T05:23:47.578621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5642}
{"level":"info","ts":"2026-05-09T05:23:47.680537Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5642,"took":"100.795594ms","hash":3967584794,"current-db-size-bytes":54423552,"current-db-size":"54 MB","current-db-size-in-use-bytes":18411520,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-09T05:23:47.680586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3967584794,"revision":5642,"compact-revision":2900}