{"level":"warn","ts":"2026-04-20T05:44:34.279134Z","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-20T05:44:34.279236Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155: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-20T05:44:34.27935Z","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-20T05:44:34.27937Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-20T05:44:34.279405Z","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-20T05:44:34.280301Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-04-20T05:44:34.280403Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155: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-20T05:44:34.284411Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.705394ms"} {"level":"info","ts":"2026-04-20T05:44:34.28968Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-04-20T05:44:34.289751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:44:34.289777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-04-20T05:44:34.289794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:44:34.289809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-04-20T05:44:34.289848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-04-20T05:44:34.295061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:44:34.296314Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:44:34.297301Z","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-20T05:44:34.299243Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:44:34.303833Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:44:34.304093Z","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-20T05:44:34.304176Z","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-20T05:44:34.304195Z","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-20T05:44:34.305957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-04-20T05:44:34.306117Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-20T05:44:34.308831Z","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-20T05:44:34.309055Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:44:34.309089Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:44:34.309246Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-20T05:44:34.309265Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-20T05:44:34.490603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:44:34.490646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:44:34.490692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-04-20T05:44:34.490714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:44:34.490727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-20T05:44:34.490742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-04-20T05:44:34.490759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-20T05:44:34.49169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:44:34.491875Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:44:34.491994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:44:34.492069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:44:34.492512Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:44:34.492616Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:44:34.492641Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:44:34.494514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-04-20T05:44:34.494605Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:44:34.494709Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:44:34.49474Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:45:10.70975Z","caller":"traceutil/trace.go:171","msg":"trace[527834376] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"118.583144ms","start":"2026-04-20T05:45:10.591144Z","end":"2026-04-20T05:45:10.709728Z","steps":["trace[527834376] 'process raft request' (duration: 118.272444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:11.098409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.965371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:45:11.098853Z","caller":"traceutil/trace.go:171","msg":"trace[1567157662] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"384.949649ms","start":"2026-04-20T05:45:10.71387Z","end":"2026-04-20T05:45:11.09882Z","steps":["trace[1567157662] 'process raft request' (duration: 120.8434ms)","trace[1567157662] 'compare' (duration: 262.793146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:45:11.099059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:45:10.713851Z","time spent":"385.098855ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:45:11.099578Z","caller":"traceutil/trace.go:171","msg":"trace[597670524] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"234.483773ms","start":"2026-04-20T05:45:10.865073Z","end":"2026-04-20T05:45:11.099557Z","steps":["trace[597670524] 'read index received' (duration: 194.299811ms)","trace[597670524] 'applied index is now lower than readState.Index' (duration: 40.182762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:45:11.099756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.6927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sdd94\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T05:45:11.099812Z","caller":"traceutil/trace.go:171","msg":"trace[759222776] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sdd94; range_end:; response_count:1; response_revision:617; }","duration":"234.802623ms","start":"2026-04-20T05:45:10.864996Z","end":"2026-04-20T05:45:11.099799Z","steps":["trace[759222776] 'agreement among raft nodes before linearized reading' (duration: 234.656678ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:11.099597Z","caller":"traceutil/trace.go:171","msg":"trace[580269233] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"263.073075ms","start":"2026-04-20T05:45:10.836505Z","end":"2026-04-20T05:45:11.099578Z","steps":["trace[580269233] 'process raft request' (duration: 262.358941ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:11.606039Z","caller":"traceutil/trace.go:171","msg":"trace[1342304505] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"445.509571ms","start":"2026-04-20T05:45:11.160488Z","end":"2026-04-20T05:45:11.605998Z","steps":["trace[1342304505] 'process raft request' (duration: 442.445548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:11.606237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:45:11.160457Z","time spent":"445.689887ms","remote":"127.0.0.1:53820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T05:45:26.292006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.336142ms","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-04-20T05:45:26.292114Z","caller":"traceutil/trace.go:171","msg":"trace[1916751556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:776; }","duration":"142.515579ms","start":"2026-04-20T05:45:26.149578Z","end":"2026-04-20T05:45:26.292094Z","steps":["trace[1916751556] 'range keys from in-memory index tree' (duration: 142.133306ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:39.952813Z","caller":"traceutil/trace.go:171","msg":"trace[1084636306] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1906; }","duration":"214.851405ms","start":"2026-04-20T05:46:39.737925Z","end":"2026-04-20T05:46:39.952777Z","steps":["trace[1084636306] 'read index received' (duration: 214.569889ms)","trace[1084636306] 'applied index is now lower than readState.Index' (duration: 279.846µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:46:39.952897Z","caller":"traceutil/trace.go:171","msg":"trace[575277355] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"292.006428ms","start":"2026-04-20T05:46:39.660841Z","end":"2026-04-20T05:46:39.952847Z","steps":["trace[575277355] 'process raft request' (duration: 291.653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:46:39.953123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.179373ms","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":"warn","ts":"2026-04-20T05:46:39.953207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.435404ms","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":"info","ts":"2026-04-20T05:46:39.953222Z","caller":"traceutil/trace.go:171","msg":"trace[1483692681] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1836; }","duration":"215.354446ms","start":"2026-04-20T05:46:39.737845Z","end":"2026-04-20T05:46:39.953199Z","steps":["trace[1483692681] 'agreement among raft nodes before linearized reading' (duration: 215.023259ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:39.953263Z","caller":"traceutil/trace.go:171","msg":"trace[1087177071] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1836; }","duration":"152.570806ms","start":"2026-04-20T05:46:39.800674Z","end":"2026-04-20T05:46:39.953245Z","steps":["trace[1087177071] 'agreement among raft nodes before linearized reading' (duration: 152.346802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:46:39.953437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.262873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:46:39.953524Z","caller":"traceutil/trace.go:171","msg":"trace[1129166912] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1836; }","duration":"137.484948ms","start":"2026-04-20T05:46:39.816022Z","end":"2026-04-20T05:46:39.953507Z","steps":["trace[1129166912] 'agreement among raft nodes before linearized reading' (duration: 137.066719ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:47:09.608363Z","caller":"traceutil/trace.go:171","msg":"trace[888547008] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"138.597981ms","start":"2026-04-20T05:47:09.469738Z","end":"2026-04-20T05:47:09.608336Z","steps":["trace[888547008] 'process raft request' (duration: 138.382806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:47:15.670888Z","caller":"traceutil/trace.go:171","msg":"trace[149998851] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"120.403674ms","start":"2026-04-20T05:47:15.550453Z","end":"2026-04-20T05:47:15.670857Z","steps":["trace[149998851] 'process raft request' (duration: 120.216109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:47:15.985842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.599329ms","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-04-20T05:47:15.986542Z","caller":"traceutil/trace.go:171","msg":"trace[470028693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2088; }","duration":"215.292016ms","start":"2026-04-20T05:47:15.771189Z","end":"2026-04-20T05:47:15.986481Z","steps":["trace[470028693] 'range keys from in-memory index tree' (duration: 214.428464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:47:15.986042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.679186ms","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-20T05:47:15.986723Z","caller":"traceutil/trace.go:171","msg":"trace[331567013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2088; }","duration":"216.297922ms","start":"2026-04-20T05:47:15.7703Z","end":"2026-04-20T05:47:15.986598Z","steps":["trace[331567013] 'range keys from in-memory index tree' (duration: 215.279725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:48:51.281314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.697092ms","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-04-20T05:48:51.2814Z","caller":"traceutil/trace.go:171","msg":"trace[67465249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2712; }","duration":"178.804895ms","start":"2026-04-20T05:48:51.102578Z","end":"2026-04-20T05:48:51.281383Z","steps":["trace[67465249] 'range keys from in-memory index tree' (duration: 178.542908ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:48:51.514974Z","caller":"traceutil/trace.go:171","msg":"trace[957860308] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"188.24079ms","start":"2026-04-20T05:48:51.326704Z","end":"2026-04-20T05:48:51.514945Z","steps":["trace[957860308] 'process raft request' (duration: 120.157656ms)","trace[957860308] 'compare' (duration: 67.748884ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:41.228513Z","caller":"traceutil/trace.go:171","msg":"trace[195158527] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"110.511356ms","start":"2026-04-20T05:52:41.117954Z","end":"2026-04-20T05:52:41.228465Z","steps":["trace[195158527] 'process raft request' (duration: 105.674167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:52.746318Z","caller":"traceutil/trace.go:171","msg":"trace[121197220] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"341.527582ms","start":"2026-04-20T05:52:52.404772Z","end":"2026-04-20T05:52:52.7463Z","steps":["trace[121197220] 'process raft request' (duration: 341.374128ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:52.746353Z","caller":"traceutil/trace.go:171","msg":"trace[1759967945] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5023; }","duration":"202.83107ms","start":"2026-04-20T05:52:52.543477Z","end":"2026-04-20T05:52:52.746308Z","steps":["trace[1759967945] 'read index received' (duration: 202.82028ms)","trace[1759967945] 'applied index is now lower than readState.Index' (duration: 8.93µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:52.746445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:52.40472Z","time spent":"341.658945ms","remote":"127.0.0.1:53752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:52:52.746746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.14669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T05:52:52.746792Z","caller":"traceutil/trace.go:171","msg":"trace[1896416909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4841; }","duration":"203.343445ms","start":"2026-04-20T05:52:52.543436Z","end":"2026-04-20T05:52:52.74678Z","steps":["trace[1896416909] 'agreement among raft nodes before linearized reading' (duration: 203.031437ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:34.805447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2941} {"level":"info","ts":"2026-04-20T05:54:34.897659Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2941,"took":"90.970328ms","hash":3500832003,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":29544448,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-20T05:54:34.897719Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3500832003,"revision":2941,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:59:34.810509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5655} {"level":"info","ts":"2026-04-20T05:59:34.886051Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5655,"took":"74.243629ms","hash":664982428,"current-db-size-bytes":54439936,"current-db-size":"54 MB","current-db-size-in-use-bytes":18153472,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T05:59:34.88611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":664982428,"revision":5655,"compact-revision":2941}