{"level":"warn","ts":"2026-05-10T00:44:32.466134Z","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-10T00:44:32.466206Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-10T00:44:32.466259Z","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-10T00:44:32.466277Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-10T00:44:32.466295Z","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-10T00:44:32.466975Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-05-10T00:44:32.467045Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-10T00:44:32.520024Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"52.281316ms"} {"level":"info","ts":"2026-05-10T00:44:32.610098Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-05-10T00:44:32.610275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T00:44:32.610312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-05-10T00:44:32.610337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T00:44:32.610359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-05-10T00:44:32.610418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-05-10T00:44:32.624581Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T00:44:32.625727Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T00:44:32.626927Z","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-10T00:44:32.630385Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T00:44:32.630488Z","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-10T00:44:32.630581Z","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-10T00:44:32.630592Z","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-10T00:44:32.630939Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T00:44:32.63389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-05-10T00:44:32.634007Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-10T00:44:32.634774Z","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-10T00:44:32.634993Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T00:44:32.635022Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T00:44:32.635091Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-10T00:44:32.635103Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-10T00:44:32.912457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T00:44:32.912506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T00:44:32.912526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-05-10T00:44:32.912539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-05-10T00:44:32.912547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-10T00:44:32.912558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-05-10T00:44:32.912568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-10T00:44:32.913283Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:44:32.913471Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T00:44:32.913794Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:44:32.914132Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:44:32.914276Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:44:32.914331Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:44:32.914351Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:44:32.916635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-05-10T00:44:32.917585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T00:44:32.917606Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T00:44:32.92101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-10T00:45:07.902083Z","caller":"traceutil/trace.go:171","msg":"trace[1235214801] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"361.382587ms","start":"2026-05-10T00:45:07.540602Z","end":"2026-05-10T00:45:07.901984Z","steps":["trace[1235214801] 'read index received' (duration: 354.361354ms)","trace[1235214801] 'applied index is now lower than readState.Index' (duration: 7.020313ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:07.902241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.623709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-10T00:45:07.90224Z","caller":"traceutil/trace.go:171","msg":"trace[1739357066] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"442.413456ms","start":"2026-05-10T00:45:07.459783Z","end":"2026-05-10T00:45:07.902196Z","steps":["trace[1739357066] 'process raft request' (duration: 436.13909ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:07.902321Z","caller":"traceutil/trace.go:171","msg":"trace[1531418360] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:571; }","duration":"361.752491ms","start":"2026-05-10T00:45:07.540556Z","end":"2026-05-10T00:45:07.902308Z","steps":["trace[1531418360] 'agreement among raft nodes before linearized reading' (duration: 361.605779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:07.902524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:07.540532Z","time spent":"361.980862ms","remote":"127.0.0.1:46498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-10T00:45:07.903317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:07.459758Z","time spent":"442.633637ms","remote":"127.0.0.1:46484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:45:08.152897Z","caller":"traceutil/trace.go:171","msg":"trace[1196995684] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"172.678432ms","start":"2026-05-10T00:45:07.980174Z","end":"2026-05-10T00:45:08.152853Z","steps":["trace[1196995684] 'read index received' (duration: 170.440672ms)","trace[1196995684] 'applied index is now lower than readState.Index' (duration: 2.23633ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:08.152914Z","caller":"traceutil/trace.go:171","msg":"trace[1895088086] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"195.195134ms","start":"2026-05-10T00:45:07.957686Z","end":"2026-05-10T00:45:08.152881Z","steps":["trace[1895088086] 'process raft request' (duration: 193.011064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:08.153255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.056985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j7b6v\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-10T00:45:08.153335Z","caller":"traceutil/trace.go:171","msg":"trace[2019096870] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j7b6v; range_end:; response_count:1; response_revision:572; }","duration":"173.199207ms","start":"2026-05-10T00:45:07.980126Z","end":"2026-05-10T00:45:08.153325Z","steps":["trace[2019096870] 'agreement among raft nodes before linearized reading' (duration: 172.856494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:08.575181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.493646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:45:08.575263Z","caller":"traceutil/trace.go:171","msg":"trace[491812508] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"361.486137ms","start":"2026-05-10T00:45:08.213764Z","end":"2026-05-10T00:45:08.57525Z","steps":["trace[491812508] 'process raft request' (duration: 230.76538ms)","trace[491812508] 'compare' (duration: 130.386244ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:45:08.575305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:08.213738Z","time spent":"361.548997ms","remote":"127.0.0.1:46656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:45:09.112749Z","caller":"traceutil/trace.go:171","msg":"trace[1101965886] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"253.300866ms","start":"2026-05-10T00:45:08.859426Z","end":"2026-05-10T00:45:09.112727Z","steps":["trace[1101965886] 'read index received' (duration: 252.412129ms)","trace[1101965886] 'applied index is now lower than readState.Index' (duration: 887.767µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:09.11279Z","caller":"traceutil/trace.go:171","msg":"trace[1375866683] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"554.036011ms","start":"2026-05-10T00:45:08.558719Z","end":"2026-05-10T00:45:09.112755Z","steps":["trace[1375866683] 'process raft request' (duration: 553.402665ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:09.112881Z","caller":"traceutil/trace.go:171","msg":"trace[1893953386] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"548.371899ms","start":"2026-05-10T00:45:08.564487Z","end":"2026-05-10T00:45:09.112859Z","steps":["trace[1893953386] 'process raft request' (duration: 548.180218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:09.112951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:08.55869Z","time spent":"554.174142ms","remote":"127.0.0.1:46484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:09.11301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:45:08.564468Z","time spent":"548.46394ms","remote":"127.0.0.1:46572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:45:09.113015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.525248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:45:09.113103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.049334ms","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-10T00:45:09.113132Z","caller":"traceutil/trace.go:171","msg":"trace[892852967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"253.71876ms","start":"2026-05-10T00:45:08.859385Z","end":"2026-05-10T00:45:09.113104Z","steps":["trace[892852967] 'agreement among raft nodes before linearized reading' (duration: 253.469657ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:09.113165Z","caller":"traceutil/trace.go:171","msg":"trace[278809663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"121.153335ms","start":"2026-05-10T00:45:08.991995Z","end":"2026-05-10T00:45:09.113148Z","steps":["trace[278809663] 'agreement among raft nodes before linearized reading' (duration: 121.037864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:45:10.321554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.394834ms","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-05-10T00:45:10.32163Z","caller":"traceutil/trace.go:171","msg":"trace[1440971243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"126.515186ms","start":"2026-05-10T00:45:10.195096Z","end":"2026-05-10T00:45:10.321611Z","steps":["trace[1440971243] 'range keys from in-memory index tree' (duration: 126.183392ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:25.279667Z","caller":"traceutil/trace.go:171","msg":"trace[105067475] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"202.701808ms","start":"2026-05-10T00:45:25.076936Z","end":"2026-05-10T00:45:25.279638Z","steps":["trace[105067475] 'process raft request' (duration: 202.513576ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:25.540714Z","caller":"traceutil/trace.go:171","msg":"trace[513309017] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"255.964023ms","start":"2026-05-10T00:45:25.284448Z","end":"2026-05-10T00:45:25.540412Z","steps":["trace[513309017] 'process raft request' (duration: 223.341406ms)","trace[513309017] 'compare' (duration: 32.339785ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:45:25.562269Z","caller":"traceutil/trace.go:171","msg":"trace[971439756] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"277.442309ms","start":"2026-05-10T00:45:25.284721Z","end":"2026-05-10T00:45:25.562164Z","steps":["trace[971439756] 'process raft request' (duration: 277.311438ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:45:58.221519Z","caller":"traceutil/trace.go:171","msg":"trace[1736990913] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"204.395834ms","start":"2026-05-10T00:45:58.017097Z","end":"2026-05-10T00:45:58.221493Z","steps":["trace[1736990913] 'process raft request' (duration: 204.157556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:45.202758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.302641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-10T00:46:45.202904Z","caller":"traceutil/trace.go:171","msg":"trace[361545373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1817; }","duration":"123.476485ms","start":"2026-05-10T00:46:45.079408Z","end":"2026-05-10T00:46:45.202884Z","steps":["trace[361545373] 'range keys from in-memory index tree' (duration: 123.142428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:46:45.202647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.515976ms","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-05-10T00:46:45.20355Z","caller":"traceutil/trace.go:171","msg":"trace[923395810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1817; }","duration":"104.484375ms","start":"2026-05-10T00:46:45.09905Z","end":"2026-05-10T00:46:45.203534Z","steps":["trace[923395810] 'range keys from in-memory index tree' (duration: 103.2559ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:45.690568Z","caller":"traceutil/trace.go:171","msg":"trace[1981783006] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"236.386478ms","start":"2026-05-10T00:46:45.454153Z","end":"2026-05-10T00:46:45.69054Z","steps":["trace[1981783006] 'process raft request' (duration: 236.230785ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:45.699573Z","caller":"traceutil/trace.go:171","msg":"trace[672147846] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"232.673055ms","start":"2026-05-10T00:46:45.466877Z","end":"2026-05-10T00:46:45.69955Z","steps":["trace[672147846] 'process raft request' (duration: 232.509771ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:46:59.903186Z","caller":"traceutil/trace.go:171","msg":"trace[586408698] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"159.17136ms","start":"2026-05-10T00:46:59.743984Z","end":"2026-05-10T00:46:59.903156Z","steps":["trace[586408698] 'process raft request' (duration: 158.909665ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:33.818398Z","caller":"traceutil/trace.go:171","msg":"trace[139425620] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"266.049014ms","start":"2026-05-10T00:47:33.552323Z","end":"2026-05-10T00:47:33.818372Z","steps":["trace[139425620] 'process raft request' (duration: 265.892512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:34.307007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.045407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-05-10T00:47:34.307085Z","caller":"traceutil/trace.go:171","msg":"trace[330795409] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2133; }","duration":"388.17406ms","start":"2026-05-10T00:47:33.918892Z","end":"2026-05-10T00:47:34.307066Z","steps":["trace[330795409] 'range keys from in-memory index tree' (duration: 387.851805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:34.30714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:33.918873Z","time spent":"388.259181ms","remote":"127.0.0.1:46576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12406,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-10T00:47:34.308344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.317881ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:34.308476Z","caller":"traceutil/trace.go:171","msg":"trace[1008131463] linearizableReadLoop","detail":"{readStateIndex:2224; appliedIndex:2223; }","duration":"259.894983ms","start":"2026-05-10T00:47:34.048567Z","end":"2026-05-10T00:47:34.308462Z","steps":["trace[1008131463] 'read index received' (duration: 55.148202ms)","trace[1008131463] 'applied index is now lower than readState.Index' (duration: 204.745071ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:34.308527Z","caller":"traceutil/trace.go:171","msg":"trace[1088421866] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"284.165938ms","start":"2026-05-10T00:47:34.024304Z","end":"2026-05-10T00:47:34.308454Z","steps":["trace[1088421866] 'process raft request' (duration: 79.461577ms)","trace[1088421866] 'compare' (duration: 203.034177ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:34.308675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.109966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-10T00:47:34.308735Z","caller":"traceutil/trace.go:171","msg":"trace[556914564] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2134; }","duration":"260.224918ms","start":"2026-05-10T00:47:34.048492Z","end":"2026-05-10T00:47:34.308717Z","steps":["trace[556914564] 'agreement among raft nodes before linearized reading' (duration: 260.057946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:34.30876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.172132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-10T00:47:34.308842Z","caller":"traceutil/trace.go:171","msg":"trace[1880919709] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"175.255422ms","start":"2026-05-10T00:47:34.133535Z","end":"2026-05-10T00:47:34.308791Z","steps":["trace[1880919709] 'agreement among raft nodes before linearized reading' (duration: 175.059348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:34.309387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.630586ms","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-05-10T00:47:34.309482Z","caller":"traceutil/trace.go:171","msg":"trace[353619617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2134; }","duration":"133.775748ms","start":"2026-05-10T00:47:34.175686Z","end":"2026-05-10T00:47:34.309462Z","steps":["trace[353619617] 'agreement among raft nodes before linearized reading' (duration: 133.076298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:34.31015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.129979ms","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-10T00:47:34.310205Z","caller":"traceutil/trace.go:171","msg":"trace[1993884777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"133.20672ms","start":"2026-05-10T00:47:34.176986Z","end":"2026-05-10T00:47:34.310193Z","steps":["trace[1993884777] 'agreement among raft nodes before linearized reading' (duration: 132.47167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.99334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.369871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:15.993423Z","caller":"traceutil/trace.go:171","msg":"trace[1058228139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2464; }","duration":"132.491022ms","start":"2026-05-10T00:48:15.860914Z","end":"2026-05-10T00:48:15.993405Z","steps":["trace[1058228139] 'range keys from in-memory index tree' (duration: 131.791464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:49.036222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.658736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:48:49.036323Z","caller":"traceutil/trace.go:171","msg":"trace[181597179] transaction","detail":"{read_only:false; response_revision:2647; number_of_response:1; }","duration":"353.300857ms","start":"2026-05-10T00:48:48.683009Z","end":"2026-05-10T00:48:49.03631Z","steps":["trace[181597179] 'process raft request' (duration: 140.47341ms)","trace[181597179] 'compare' (duration: 212.477243ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:48:49.036312Z","caller":"traceutil/trace.go:171","msg":"trace[2129159982] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2753; }","duration":"339.831585ms","start":"2026-05-10T00:48:48.696466Z","end":"2026-05-10T00:48:49.036298Z","steps":["trace[2129159982] 'read index received' (duration: 7.02951ms)","trace[2129159982] 'applied index is now lower than readState.Index' (duration: 332.800895ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:48:49.03651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.044437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-10T00:48:49.036528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.235215ms","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-10T00:48:49.036559Z","caller":"traceutil/trace.go:171","msg":"trace[473233531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2647; }","duration":"336.321465ms","start":"2026-05-10T00:48:48.700229Z","end":"2026-05-10T00:48:49.03655Z","steps":["trace[473233531] 'agreement among raft nodes before linearized reading' (duration: 336.188593ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:49.036543Z","caller":"traceutil/trace.go:171","msg":"trace[859125417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2647; }","duration":"340.077098ms","start":"2026-05-10T00:48:48.696457Z","end":"2026-05-10T00:48:49.036534Z","steps":["trace[859125417] 'agreement among raft nodes before linearized reading' (duration: 339.993377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:49.036591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:48.700213Z","time spent":"336.373345ms","remote":"127.0.0.1:46656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T00:48:49.036623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:48.696413Z","time spent":"340.181788ms","remote":"127.0.0.1:46656","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":"warn","ts":"2026-05-10T00:48:49.036622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.596736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:49.036756Z","caller":"traceutil/trace.go:171","msg":"trace[788123948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2647; }","duration":"175.755898ms","start":"2026-05-10T00:48:48.860953Z","end":"2026-05-10T00:48:49.036709Z","steps":["trace[788123948] 'agreement among raft nodes before linearized reading' (duration: 175.579916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:49.036836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.643635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-05-10T00:48:49.036898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.934993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ae0dd46e67a235\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-10T00:48:49.0369Z","caller":"traceutil/trace.go:171","msg":"trace[1392155085] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2647; }","duration":"333.706746ms","start":"2026-05-10T00:48:48.703184Z","end":"2026-05-10T00:48:49.036891Z","steps":["trace[1392155085] 'agreement among raft nodes before linearized reading' (duration: 333.600354ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:49.03692Z","caller":"traceutil/trace.go:171","msg":"trace[472811454] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ae0dd46e67a235; range_end:; response_count:1; response_revision:2647; }","duration":"140.006974ms","start":"2026-05-10T00:48:48.896908Z","end":"2026-05-10T00:48:49.036915Z","steps":["trace[472811454] 'agreement among raft nodes before linearized reading' (duration: 139.536479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:49.036926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:48.703175Z","time spent":"333.744076ms","remote":"127.0.0.1:46656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-10T00:48:49.036391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:48.682988Z","time spent":"353.381388ms","remote":"127.0.0.1:46656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:48:54.334414Z","caller":"traceutil/trace.go:171","msg":"trace[1667662255] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"129.751861ms","start":"2026-05-10T00:48:54.204641Z","end":"2026-05-10T00:48:54.334393Z","steps":["trace[1667662255] 'process raft request' (duration: 129.573229ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:13.573585Z","caller":"traceutil/trace.go:171","msg":"trace[348828523] transaction","detail":"{read_only:false; response_revision:3093; number_of_response:1; }","duration":"102.288137ms","start":"2026-05-10T00:50:13.471267Z","end":"2026-05-10T00:50:13.573555Z","steps":["trace[348828523] 'process raft request' (duration: 75.165229ms)","trace[348828523] 'compare' (duration: 26.990727ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:52:29.350568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.087987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-10T00:52:29.35069Z","caller":"traceutil/trace.go:171","msg":"trace[405324027] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4513; }","duration":"129.236478ms","start":"2026-05-10T00:52:29.221427Z","end":"2026-05-10T00:52:29.350663Z","steps":["trace[405324027] 'range keys from in-memory index tree' (duration: 128.909375ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:29.502961Z","caller":"traceutil/trace.go:171","msg":"trace[426876899] transaction","detail":"{read_only:false; response_revision:4514; number_of_response:1; }","duration":"115.217751ms","start":"2026-05-10T00:52:29.387717Z","end":"2026-05-10T00:52:29.502934Z","steps":["trace[426876899] 'process raft request' (duration: 115.045049ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:29.737123Z","caller":"traceutil/trace.go:171","msg":"trace[288679029] linearizableReadLoop","detail":"{readStateIndex:4694; appliedIndex:4693; }","duration":"253.698569ms","start":"2026-05-10T00:52:29.483399Z","end":"2026-05-10T00:52:29.737098Z","steps":["trace[288679029] 'read index received' (duration: 19.519633ms)","trace[288679029] 'applied index is now lower than readState.Index' (duration: 234.177826ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:52:29.737213Z","caller":"traceutil/trace.go:171","msg":"trace[22792732] transaction","detail":"{read_only:false; response_revision:4515; number_of_response:1; }","duration":"347.507117ms","start":"2026-05-10T00:52:29.389697Z","end":"2026-05-10T00:52:29.737204Z","steps":["trace[22792732] 'process raft request' (duration: 347.276035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:29.737301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:52:29.389684Z","time spent":"347.546807ms","remote":"127.0.0.1:42118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7450,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:52:29.737512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.090343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-10T00:52:29.737593Z","caller":"traceutil/trace.go:171","msg":"trace[951555099] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4515; }","duration":"254.219003ms","start":"2026-05-10T00:52:29.483357Z","end":"2026-05-10T00:52:29.737576Z","steps":["trace[951555099] 'agreement among raft nodes before linearized reading' (duration: 253.967561ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:29.74846Z","caller":"traceutil/trace.go:171","msg":"trace[1102846354] transaction","detail":"{read_only:false; response_revision:4516; number_of_response:1; }","duration":"241.160925ms","start":"2026-05-10T00:52:29.507284Z","end":"2026-05-10T00:52:29.748445Z","steps":["trace[1102846354] 'process raft request' (duration: 240.973633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:29.748727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.612786ms","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-10T00:52:29.748778Z","caller":"traceutil/trace.go:171","msg":"trace[1958085976] 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:4517; }","duration":"195.674006ms","start":"2026-05-10T00:52:29.55309Z","end":"2026-05-10T00:52:29.748764Z","steps":["trace[1958085976] 'agreement among raft nodes before linearized reading' (duration: 195.497584ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:29.748618Z","caller":"traceutil/trace.go:171","msg":"trace[1437191417] transaction","detail":"{read_only:false; response_revision:4517; number_of_response:1; }","duration":"211.025617ms","start":"2026-05-10T00:52:29.537576Z","end":"2026-05-10T00:52:29.748602Z","steps":["trace[1437191417] 'process raft request' (duration: 210.780814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:29.748566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.126564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-05-10T00:52:29.749517Z","caller":"traceutil/trace.go:171","msg":"trace[1452296195] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4517; }","duration":"238.114605ms","start":"2026-05-10T00:52:29.511387Z","end":"2026-05-10T00:52:29.749502Z","steps":["trace[1452296195] 'agreement among raft nodes before linearized reading' (duration: 237.030454ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:35.774089Z","caller":"traceutil/trace.go:171","msg":"trace[1455223054] linearizableReadLoop","detail":"{readStateIndex:4814; appliedIndex:4813; }","duration":"256.142962ms","start":"2026-05-10T00:52:35.517916Z","end":"2026-05-10T00:52:35.774059Z","steps":["trace[1455223054] 'read index received' (duration: 255.98551ms)","trace[1455223054] 'applied index is now lower than readState.Index' (duration: 156.122µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:52:35.774232Z","caller":"traceutil/trace.go:171","msg":"trace[1285248747] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"284.465462ms","start":"2026-05-10T00:52:35.489751Z","end":"2026-05-10T00:52:35.774217Z","steps":["trace[1285248747] 'process raft request' (duration: 284.133089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:35.775278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.342274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"} {"level":"info","ts":"2026-05-10T00:52:35.77539Z","caller":"traceutil/trace.go:171","msg":"trace[1034510922] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4634; }","duration":"257.489815ms","start":"2026-05-10T00:52:35.517881Z","end":"2026-05-10T00:52:35.775371Z","steps":["trace[1034510922] 'agreement among raft nodes before linearized reading' (duration: 256.449364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:35.801181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.231658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T00:52:35.801245Z","caller":"traceutil/trace.go:171","msg":"trace[1185400302] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:4635; }","duration":"121.346519ms","start":"2026-05-10T00:52:35.679887Z","end":"2026-05-10T00:52:35.801233Z","steps":["trace[1185400302] 'agreement among raft nodes before linearized reading' (duration: 121.217198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:35.801314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.4879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T00:52:35.801403Z","caller":"traceutil/trace.go:171","msg":"trace[1180083420] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:4635; }","duration":"220.625401ms","start":"2026-05-10T00:52:35.580755Z","end":"2026-05-10T00:52:35.80138Z","steps":["trace[1180083420] 'agreement among raft nodes before linearized reading' (duration: 220.47083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.305045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.4674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:52:36.305162Z","caller":"traceutil/trace.go:171","msg":"trace[876009989] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"224.142666ms","start":"2026-05-10T00:52:36.080999Z","end":"2026-05-10T00:52:36.305142Z","steps":["trace[876009989] 'process raft request' (duration: 89.482134ms)","trace[876009989] 'compare' (duration: 134.288558ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:52:36.307251Z","caller":"traceutil/trace.go:171","msg":"trace[125424526] linearizableReadLoop","detail":"{readStateIndex:4821; appliedIndex:4819; }","duration":"184.585195ms","start":"2026-05-10T00:52:36.122642Z","end":"2026-05-10T00:52:36.307227Z","steps":["trace[125424526] 'read index received' (duration: 47.849233ms)","trace[125424526] 'applied index is now lower than readState.Index' (duration: 136.734632ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:52:36.307399Z","caller":"traceutil/trace.go:171","msg":"trace[1622221420] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"223.719022ms","start":"2026-05-10T00:52:36.083666Z","end":"2026-05-10T00:52:36.307385Z","steps":["trace[1622221420] 'process raft request' (duration: 223.383198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.307685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.035029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-10T00:52:36.307763Z","caller":"traceutil/trace.go:171","msg":"trace[588918222] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4641; }","duration":"185.14358ms","start":"2026-05-10T00:52:36.122598Z","end":"2026-05-10T00:52:36.307742Z","steps":["trace[588918222] 'agreement among raft nodes before linearized reading' (duration: 184.914998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.307804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.334317ms","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-10T00:52:36.307844Z","caller":"traceutil/trace.go:171","msg":"trace[1924195888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4641; }","duration":"145.450578ms","start":"2026-05-10T00:52:36.162383Z","end":"2026-05-10T00:52:36.307834Z","steps":["trace[1924195888] 'agreement among raft nodes before linearized reading' (duration: 145.330797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.307928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.914411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-10T00:52:36.307979Z","caller":"traceutil/trace.go:171","msg":"trace[588396131] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:4641; }","duration":"158.982743ms","start":"2026-05-10T00:52:36.148983Z","end":"2026-05-10T00:52:36.307965Z","steps":["trace[588396131] 'agreement among raft nodes before linearized reading' (duration: 158.876502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.308064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.062918ms","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-10T00:52:36.308109Z","caller":"traceutil/trace.go:171","msg":"trace[614715993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4641; }","duration":"110.157799ms","start":"2026-05-10T00:52:36.197933Z","end":"2026-05-10T00:52:36.308091Z","steps":["trace[614715993] 'agreement among raft nodes before linearized reading' (duration: 110.067978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.308317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.792791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-478cfeb3-72b9-49b2-8670-bf3c1afff7dc\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-10T00:52:36.30838Z","caller":"traceutil/trace.go:171","msg":"trace[51556344] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-478cfeb3-72b9-49b2-8670-bf3c1afff7dc; range_end:; response_count:1; response_revision:4641; }","duration":"151.922661ms","start":"2026-05-10T00:52:36.156442Z","end":"2026-05-10T00:52:36.308365Z","steps":["trace[51556344] 'agreement among raft nodes before linearized reading' (duration: 151.342036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:52:36.510164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.551854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-10T00:52:36.510249Z","caller":"traceutil/trace.go:171","msg":"trace[41932813] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:4650; }","duration":"103.763026ms","start":"2026-05-10T00:52:36.406467Z","end":"2026-05-10T00:52:36.51023Z","steps":["trace[41932813] 'range keys from in-memory index tree' (duration: 103.457623ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:36.526961Z","caller":"traceutil/trace.go:171","msg":"trace[1410056518] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"117.111628ms","start":"2026-05-10T00:52:36.409825Z","end":"2026-05-10T00:52:36.526937Z","steps":["trace[1410056518] 'process raft request' (duration: 116.881906ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:36.537295Z","caller":"traceutil/trace.go:171","msg":"trace[826671769] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"127.066777ms","start":"2026-05-10T00:52:36.410212Z","end":"2026-05-10T00:52:36.537278Z","steps":["trace[826671769] 'process raft request' (duration: 126.626681ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:36.537475Z","caller":"traceutil/trace.go:171","msg":"trace[1959272418] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"126.799364ms","start":"2026-05-10T00:52:36.410669Z","end":"2026-05-10T00:52:36.537469Z","steps":["trace[1959272418] 'process raft request' (duration: 126.259209ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:36.53763Z","caller":"traceutil/trace.go:171","msg":"trace[93634336] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"126.842055ms","start":"2026-05-10T00:52:36.410762Z","end":"2026-05-10T00:52:36.537604Z","steps":["trace[93634336] 'process raft request' (duration: 126.202999ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:37.979952Z","caller":"traceutil/trace.go:171","msg":"trace[1369866279] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"110.14143ms","start":"2026-05-10T00:52:37.869783Z","end":"2026-05-10T00:52:37.979924Z","steps":["trace[1369866279] 'process raft request' (duration: 107.621855ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:37.980006Z","caller":"traceutil/trace.go:171","msg":"trace[2063795295] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"103.833657ms","start":"2026-05-10T00:52:37.876144Z","end":"2026-05-10T00:52:37.979977Z","steps":["trace[2063795295] 'process raft request' (duration: 103.666376ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:37.980196Z","caller":"traceutil/trace.go:171","msg":"trace[1292422308] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"103.11181ms","start":"2026-05-10T00:52:37.877061Z","end":"2026-05-10T00:52:37.980173Z","steps":["trace[1292422308] 'process raft request' (duration: 102.863098ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:47.660832Z","caller":"traceutil/trace.go:171","msg":"trace[2126235943] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"165.06657ms","start":"2026-05-10T00:52:47.495743Z","end":"2026-05-10T00:52:47.66081Z","steps":["trace[2126235943] 'process raft request' (duration: 164.896258ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:48.065762Z","caller":"traceutil/trace.go:171","msg":"trace[1713398800] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"123.690931ms","start":"2026-05-10T00:52:47.942048Z","end":"2026-05-10T00:52:48.065739Z","steps":["trace[1713398800] 'process raft request' (duration: 123.54556ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:52:48.52775Z","caller":"traceutil/trace.go:171","msg":"trace[511144744] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"106.825695ms","start":"2026-05-10T00:52:48.420888Z","end":"2026-05-10T00:52:48.527714Z","steps":["trace[511144744] 'process raft request' (duration: 58.65155ms)","trace[511144744] 'compare' (duration: 47.59766ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:52:48.527941Z","caller":"traceutil/trace.go:171","msg":"trace[1536416458] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"106.042768ms","start":"2026-05-10T00:52:48.421865Z","end":"2026-05-10T00:52:48.527908Z","steps":["trace[1536416458] 'process raft request' (duration: 105.601174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:53:28.39963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.235448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:53:28.399826Z","caller":"traceutil/trace.go:171","msg":"trace[951959120] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"124.141084ms","start":"2026-05-10T00:53:28.27563Z","end":"2026-05-10T00:53:28.399771Z","steps":["trace[951959120] 'process raft request' (duration: 16.688664ms)","trace[951959120] 'compare' (duration: 107.107587ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:54:33.269982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2883} {"level":"info","ts":"2026-05-10T00:54:33.344353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2883,"took":"72.563175ms","hash":3963014301,"current-db-size-bytes":54370304,"current-db-size":"54 MB","current-db-size-in-use-bytes":29544448,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-10T00:54:33.344426Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3963014301,"revision":2883,"compact-revision":-1} {"level":"info","ts":"2026-05-10T00:59:33.275197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5625} {"level":"info","ts":"2026-05-10T00:59:33.353865Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5625,"took":"77.433023ms","hash":4248612935,"current-db-size-bytes":54370304,"current-db-size":"54 MB","current-db-size-in-use-bytes":18251776,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-10T00:59:33.35392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4248612935,"revision":5625,"compact-revision":2883}