{"level":"warn","ts":"2026-04-16T06:05:51.949705Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T06:05:51.949865Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-04-16T06:05:51.950002Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T06:05:51.950026Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-16T06:05:51.950062Z","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-04-16T06:05:51.951861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-04-16T06:05:51.951963Z","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":16,"max-cpu-available":16,"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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-04-16T06:05:51.955523Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.260678ms"} {"level":"info","ts":"2026-04-16T06:05:51.961184Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-04-16T06:05:51.961258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:05:51.961282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-04-16T06:05:51.961299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:05:51.961309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-04-16T06:05:51.961355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-04-16T06:05:51.973383Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:05:51.975688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:05:51.976903Z","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-04-16T06:05:51.979892Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:05:51.984659Z","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-04-16T06:05:51.984878Z","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-04-16T06:05:51.984904Z","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-04-16T06:05:51.984873Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:05:51.985699Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-16T06:05:51.98584Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-16T06:05:51.985759Z","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-04-16T06:05:51.986704Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:05:51.986784Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:05:51.988522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-04-16T06:05:51.988873Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-16T06:05:52.56343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:05:52.56353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:05:52.563568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-04-16T06:05:52.563591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:05:52.563603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-16T06:05:52.563622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-04-16T06:05:52.563636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-16T06:05:52.564813Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:52.565757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:05:52.565785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:52.565856Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:52.566175Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:05:52.566263Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:05:52.566352Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:52.566564Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:52.566601Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:52.569541Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:05:52.570097Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-04-16T06:06:17.203516Z","caller":"traceutil/trace.go:171","msg":"trace[922621977] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"110.7388ms","start":"2026-04-16T06:06:17.092749Z","end":"2026-04-16T06:06:17.203488Z","steps":["trace[922621977] 'process raft request' (duration: 110.574616ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:29.817321Z","caller":"traceutil/trace.go:171","msg":"trace[190149774] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"203.399568ms","start":"2026-04-16T06:06:29.613893Z","end":"2026-04-16T06:06:29.817292Z","steps":["trace[190149774] 'read index received' (duration: 202.650619ms)","trace[190149774] 'applied index is now lower than readState.Index' (duration: 747.699µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:29.817392Z","caller":"traceutil/trace.go:171","msg":"trace[131538000] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"281.144228ms","start":"2026-04-16T06:06:29.536204Z","end":"2026-04-16T06:06:29.817349Z","steps":["trace[131538000] 'process raft request' (duration: 280.532883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:29.817497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.555062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:29.817584Z","caller":"traceutil/trace.go:171","msg":"trace[1670282573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"203.693245ms","start":"2026-04-16T06:06:29.613871Z","end":"2026-04-16T06:06:29.817564Z","steps":["trace[1670282573] 'agreement among raft nodes before linearized reading' (duration: 203.529642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:30.310495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.340481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:06:30.310574Z","caller":"traceutil/trace.go:171","msg":"trace[747555443] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"329.932466ms","start":"2026-04-16T06:06:29.980629Z","end":"2026-04-16T06:06:30.310561Z","steps":["trace[747555443] 'read index received' (duration: 162.889308ms)","trace[747555443] 'applied index is now lower than readState.Index' (duration: 167.042238ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:30.310633Z","caller":"traceutil/trace.go:171","msg":"trace[1106172780] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"438.918894ms","start":"2026-04-16T06:06:29.871708Z","end":"2026-04-16T06:06:30.310627Z","steps":["trace[1106172780] 'process raft request' (duration: 271.896196ms)","trace[1106172780] 'compare' (duration: 166.260209ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:30.310666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:29.871683Z","time spent":"438.967415ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:06:30.310884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.253224ms","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-04-16T06:06:30.310905Z","caller":"traceutil/trace.go:171","msg":"trace[795070160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"330.311215ms","start":"2026-04-16T06:06:29.980586Z","end":"2026-04-16T06:06:30.310898Z","steps":["trace[795070160] 'agreement among raft nodes before linearized reading' (duration: 330.191762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:30.310924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:29.980565Z","time spent":"330.354096ms","remote":"127.0.0.1:37298","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-04-16T06:06:30.311018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.772565ms","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-04-16T06:06:30.311115Z","caller":"traceutil/trace.go:171","msg":"trace[305827077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"246.926869ms","start":"2026-04-16T06:06:30.06416Z","end":"2026-04-16T06:06:30.311087Z","steps":["trace[305827077] 'agreement among raft nodes before linearized reading' (duration: 246.608731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:45.976605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.325679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:06:45.976735Z","caller":"traceutil/trace.go:171","msg":"trace[572242131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:767; }","duration":"259.494443ms","start":"2026-04-16T06:06:45.717217Z","end":"2026-04-16T06:06:45.976712Z","steps":["trace[572242131] 'range keys from in-memory index tree' (duration: 259.052543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:57.087909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.82599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-16T06:07:57.088083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.073133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-16T06:07:57.088142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.901291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b1a1076c-1c81-43af-b03e-02002629acd2\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-16T06:07:57.088135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.76762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T06:07:57.088181Z","caller":"traceutil/trace.go:171","msg":"trace[610579113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1813; }","duration":"209.234308ms","start":"2026-04-16T06:07:56.878922Z","end":"2026-04-16T06:07:57.088156Z","steps":["trace[610579113] 'range keys from in-memory index tree' (duration: 208.875989ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.088196Z","caller":"traceutil/trace.go:171","msg":"trace[547714935] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1813; }","duration":"214.864312ms","start":"2026-04-16T06:07:56.873317Z","end":"2026-04-16T06:07:57.088181Z","steps":["trace[547714935] 'range keys from in-memory index tree' (duration: 214.560935ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.088196Z","caller":"traceutil/trace.go:171","msg":"trace[1614190743] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b1a1076c-1c81-43af-b03e-02002629acd2; range_end:; response_count:1; response_revision:1813; }","duration":"249.981653ms","start":"2026-04-16T06:07:56.838188Z","end":"2026-04-16T06:07:57.08817Z","steps":["trace[1614190743] 'range keys from in-memory index tree' (duration: 249.716296ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.088059Z","caller":"traceutil/trace.go:171","msg":"trace[1816789310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1813; }","duration":"212.058825ms","start":"2026-04-16T06:07:56.87597Z","end":"2026-04-16T06:07:57.088029Z","steps":["trace[1816789310] 'range keys from in-memory index tree' (duration: 211.585834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:57.087929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.048294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:07:57.08865Z","caller":"traceutil/trace.go:171","msg":"trace[2071238773] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1813; }","duration":"184.750282ms","start":"2026-04-16T06:07:56.903826Z","end":"2026-04-16T06:07:57.088576Z","steps":["trace[2071238773] 'count revisions from in-memory index tree' (duration: 183.949532ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.210459Z","caller":"traceutil/trace.go:171","msg":"trace[239222704] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"116.356584ms","start":"2026-04-16T06:07:57.094076Z","end":"2026-04-16T06:07:57.210432Z","steps":["trace[239222704] 'process raft request' (duration: 116.220841ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.210469Z","caller":"traceutil/trace.go:171","msg":"trace[1615771681] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"116.836307ms","start":"2026-04-16T06:07:57.093585Z","end":"2026-04-16T06:07:57.210421Z","steps":["trace[1615771681] 'process raft request' (duration: 96.91189ms)","trace[1615771681] 'compare' (duration: 19.656571ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:57.21072Z","caller":"traceutil/trace.go:171","msg":"trace[1288570931] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"112.539084ms","start":"2026-04-16T06:07:57.098168Z","end":"2026-04-16T06:07:57.210707Z","steps":["trace[1288570931] 'process raft request' (duration: 112.174455ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:57.210715Z","caller":"traceutil/trace.go:171","msg":"trace[719913589] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1883; }","duration":"116.921439ms","start":"2026-04-16T06:07:57.093755Z","end":"2026-04-16T06:07:57.210676Z","steps":["trace[719913589] 'read index received' (duration: 44.921566ms)","trace[719913589] 'applied index is now lower than readState.Index' (duration: 71.998473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:57.211112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.319288ms","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-04-16T06:07:57.211183Z","caller":"traceutil/trace.go:171","msg":"trace[1507478009] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1817; }","duration":"117.423301ms","start":"2026-04-16T06:07:57.093739Z","end":"2026-04-16T06:07:57.211162Z","steps":["trace[1507478009] 'agreement among raft nodes before linearized reading' (duration: 117.064822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:46.476885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.586613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:08:46.477196Z","caller":"traceutil/trace.go:171","msg":"trace[823179431] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"258.224608ms","start":"2026-04-16T06:08:46.218948Z","end":"2026-04-16T06:08:46.477172Z","steps":["trace[823179431] 'process raft request' (duration: 258.111495ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:46.477204Z","caller":"traceutil/trace.go:171","msg":"trace[2084769382] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"415.786129ms","start":"2026-04-16T06:08:46.06137Z","end":"2026-04-16T06:08:46.477156Z","steps":["trace[2084769382] 'process raft request' (duration: 139.462068ms)","trace[2084769382] 'compare' (duration: 275.107152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:46.477476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:46.061355Z","time spent":"415.988594ms","remote":"127.0.0.1:37298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:09.687925Z","caller":"traceutil/trace.go:171","msg":"trace[1560749085] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"122.894668ms","start":"2026-04-16T06:10:09.564995Z","end":"2026-04-16T06:10:09.68789Z","steps":["trace[1560749085] 'process raft request' (duration: 122.657692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:14:18.523786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.537903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:14:18.523862Z","caller":"traceutil/trace.go:171","msg":"trace[1165747289] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4833; }","duration":"132.665856ms","start":"2026-04-16T06:14:18.391177Z","end":"2026-04-16T06:14:18.523843Z","steps":["trace[1165747289] 'count revisions from in-memory index tree' (duration: 132.44283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:14:18.523994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.911291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lxqlf-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-04-16T06:14:18.524058Z","caller":"traceutil/trace.go:171","msg":"trace[836184090] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lxqlf-tls; range_end:; response_count:1; response_revision:4833; }","duration":"105.998943ms","start":"2026-04-16T06:14:18.418045Z","end":"2026-04-16T06:14:18.524044Z","steps":["trace[836184090] 'range keys from in-memory index tree' (duration: 105.774168ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:30.710539Z","caller":"traceutil/trace.go:171","msg":"trace[1976186085] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"110.319116ms","start":"2026-04-16T06:14:30.600178Z","end":"2026-04-16T06:14:30.710497Z","steps":["trace[1976186085] 'process raft request' (duration: 71.467205ms)","trace[1976186085] 'compare' (duration: 38.512393ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:14:31.127372Z","caller":"traceutil/trace.go:171","msg":"trace[833489583] linearizableReadLoop","detail":"{readStateIndex:5269; appliedIndex:5268; }","duration":"183.635444ms","start":"2026-04-16T06:14:30.94371Z","end":"2026-04-16T06:14:31.127346Z","steps":["trace[833489583] 'read index received' (duration: 128.038596ms)","trace[833489583] 'applied index is now lower than readState.Index' (duration: 55.595748ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:14:31.127554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.826288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-lxqlf\" ","response":"range_response_count:1 size:9901"} {"level":"info","ts":"2026-04-16T06:14:31.127548Z","caller":"traceutil/trace.go:171","msg":"trace[2025063928] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"210.909231ms","start":"2026-04-16T06:14:30.916612Z","end":"2026-04-16T06:14:31.127521Z","steps":["trace[2025063928] 'process raft request' (duration: 155.157759ms)","trace[2025063928] 'compare' (duration: 55.470275ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:14:31.1276Z","caller":"traceutil/trace.go:171","msg":"trace[2073597268] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-lxqlf; range_end:; response_count:1; response_revision:5078; }","duration":"183.91391ms","start":"2026-04-16T06:14:30.943673Z","end":"2026-04-16T06:14:31.127586Z","steps":["trace[2073597268] 'agreement among raft nodes before linearized reading' (duration: 183.759587ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:31.132081Z","caller":"traceutil/trace.go:171","msg":"trace[1141403289] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"188.354925ms","start":"2026-04-16T06:14:30.943712Z","end":"2026-04-16T06:14:31.132066Z","steps":["trace[1141403289] 'process raft request' (duration: 188.111019ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:31.132103Z","caller":"traceutil/trace.go:171","msg":"trace[1718562340] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"188.299073ms","start":"2026-04-16T06:14:30.943776Z","end":"2026-04-16T06:14:31.132075Z","steps":["trace[1718562340] 'process raft request' (duration: 188.206751ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:31.132318Z","caller":"traceutil/trace.go:171","msg":"trace[246246454] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"188.512469ms","start":"2026-04-16T06:14:30.943795Z","end":"2026-04-16T06:14:31.132307Z","steps":["trace[246246454] 'process raft request' (duration: 188.241802ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:31.132504Z","caller":"traceutil/trace.go:171","msg":"trace[2004154015] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"188.643492ms","start":"2026-04-16T06:14:30.943838Z","end":"2026-04-16T06:14:31.132482Z","steps":["trace[2004154015] 'process raft request' (duration: 188.398326ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:52.599527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857} {"level":"info","ts":"2026-04-16T06:15:52.666598Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"65.491615ms","hash":2133407747,"current-db-size-bytes":56786944,"current-db-size":"57 MB","current-db-size-in-use-bytes":33054720,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T06:15:52.66666Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2133407747,"revision":2857,"compact-revision":-1} {"level":"info","ts":"2026-04-16T06:20:13.878068Z","caller":"traceutil/trace.go:171","msg":"trace[1256270623] transaction","detail":"{read_only:false; response_revision:7917; number_of_response:1; }","duration":"160.490421ms","start":"2026-04-16T06:20:13.717557Z","end":"2026-04-16T06:20:13.878048Z","steps":["trace[1256270623] 'process raft request' (duration: 160.359838ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:20:25.671814Z","caller":"traceutil/trace.go:171","msg":"trace[1739435064] transaction","detail":"{read_only:false; response_revision:7981; number_of_response:1; }","duration":"237.812431ms","start":"2026-04-16T06:20:25.433961Z","end":"2026-04-16T06:20:25.671774Z","steps":["trace[1739435064] 'process raft request' (duration: 237.502864ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:20:52.605777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5953} {"level":"info","ts":"2026-04-16T06:20:52.687975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5953,"took":"80.426905ms","hash":3117261011,"current-db-size-bytes":56786944,"current-db-size":"57 MB","current-db-size-in-use-bytes":26099712,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-16T06:20:52.688028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3117261011,"revision":5953,"compact-revision":2857} {"level":"info","ts":"2026-04-16T06:20:53.899694Z","caller":"traceutil/trace.go:171","msg":"trace[1163934294] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"110.416129ms","start":"2026-04-16T06:20:53.789257Z","end":"2026-04-16T06:20:53.899674Z","steps":["trace[1163934294] 'process raft request' (duration: 110.275946ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:21:06.940515Z","caller":"traceutil/trace.go:171","msg":"trace[288191712] linearizableReadLoop","detail":"{readStateIndex:8591; appliedIndex:8590; }","duration":"117.071948ms","start":"2026-04-16T06:21:06.823415Z","end":"2026-04-16T06:21:06.940487Z","steps":["trace[288191712] 'read index received' (duration: 116.690819ms)","trace[288191712] 'applied index is now lower than readState.Index' (duration: 380.069µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:21:06.940577Z","caller":"traceutil/trace.go:171","msg":"trace[237297510] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"186.569452ms","start":"2026-04-16T06:21:06.753972Z","end":"2026-04-16T06:21:06.940541Z","steps":["trace[237297510] 'process raft request' (duration: 186.276846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:21:06.940778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.352404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-16T06:21:06.940875Z","caller":"traceutil/trace.go:171","msg":"trace[2072069802] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8298; }","duration":"117.504138ms","start":"2026-04-16T06:21:06.82335Z","end":"2026-04-16T06:21:06.940854Z","steps":["trace[2072069802] 'agreement among raft nodes before linearized reading' (duration: 117.287993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:21:06.941078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.825529ms","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":"warn","ts":"2026-04-16T06:21:06.941133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.391189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-16T06:21:06.941143Z","caller":"traceutil/trace.go:171","msg":"trace[632899910] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8298; }","duration":"113.941112ms","start":"2026-04-16T06:21:06.827188Z","end":"2026-04-16T06:21:06.941129Z","steps":["trace[632899910] 'agreement among raft nodes before linearized reading' (duration: 113.730967ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:21:06.941206Z","caller":"traceutil/trace.go:171","msg":"trace[1378145092] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8298; }","duration":"113.460241ms","start":"2026-04-16T06:21:06.827706Z","end":"2026-04-16T06:21:06.941166Z","steps":["trace[1378145092] 'agreement among raft nodes before linearized reading' (duration: 113.281657ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:21:07.045507Z","caller":"traceutil/trace.go:171","msg":"trace[675627931] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"100.272367ms","start":"2026-04-16T06:21:06.945205Z","end":"2026-04-16T06:21:07.045477Z","steps":["trace[675627931] 'process raft request' (duration: 99.361126ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:21:07.047501Z","caller":"traceutil/trace.go:171","msg":"trace[1956833541] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"102.258724ms","start":"2026-04-16T06:21:06.945222Z","end":"2026-04-16T06:21:07.04748Z","steps":["trace[1956833541] 'process raft request' (duration: 99.423636ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:21:07.842769Z","caller":"traceutil/trace.go:171","msg":"trace[264994088] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"127.785263ms","start":"2026-04-16T06:21:07.714962Z","end":"2026-04-16T06:21:07.842747Z","steps":["trace[264994088] 'process raft request' (duration: 127.614459ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:22:16.948067Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002436.wal"} {"level":"info","ts":"2026-04-16T06:23:42.838572Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e46287fb5aa4785","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T06:23:42.842981Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T06:23:42.843056Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T06:25:52.615746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8177} {"level":"info","ts":"2026-04-16T06:25:52.691429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8177,"took":"73.559761ms","hash":3041461128,"current-db-size-bytes":56786944,"current-db-size":"57 MB","current-db-size-in-use-bytes":24735744,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T06:25:52.691504Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3041461128,"revision":8177,"compact-revision":5953} {"level":"info","ts":"2026-04-16T06:30:52.622085Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10564} {"level":"info","ts":"2026-04-16T06:30:52.71151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10564,"took":"87.346288ms","hash":1436841866,"current-db-size-bytes":56786944,"current-db-size":"57 MB","current-db-size-in-use-bytes":19734528,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-16T06:30:52.711586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1436841866,"revision":10564,"compact-revision":8177}