{"level":"warn","ts":"2026-03-09T01:38:49.878006Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-09T01:38:49.878103Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-03-09T01:38:49.878194Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-09T01:38:49.878206Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-09T01:38:49.87823Z","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-03-09T01:38:49.878805Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-03-09T01:38:49.878875Z","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://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-03-09T01:38:49.884215Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.098193ms"}
{"level":"info","ts":"2026-03-09T01:38:49.891712Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-03-09T01:38:49.891919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-03-09T01:38:49.89197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-03-09T01:38:49.891995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-09T01:38:49.892027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-03-09T01:38:49.892095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-03-09T01:38:49.898868Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-09T01:38:49.900741Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-09T01:38:49.902335Z","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-03-09T01:38:49.90493Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-09T01:38:49.90538Z","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-03-09T01:38:49.905466Z","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-03-09T01:38:49.905483Z","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-03-09T01:38:49.90626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-03-09T01:38:49.907347Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-09T01:38:49.90826Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-09T01:38:49.912334Z","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-03-09T01:38:49.912443Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-09T01:38:49.912497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-09T01:38:49.91267Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-09T01:38:49.912739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-09T01:38:50.393011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-03-09T01:38:50.3931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-09T01:38:50.393151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-03-09T01:38:50.393174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-03-09T01:38:50.393185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-09T01:38:50.393203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-03-09T01:38:50.393218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-09T01:38:50.394178Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:38:50.395015Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T01:38:50.395019Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-09T01:38:50.395135Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T01:38:50.395478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:38:50.39547Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-09T01:38:50.395688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-09T01:38:50.395632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:38:50.395996Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:38:50.398879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-09T01:38:50.399382Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-03-09T01:39:28.349497Z","caller":"traceutil/trace.go:171","msg":"trace[809005555] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"100.774252ms","start":"2026-03-09T01:39:28.248687Z","end":"2026-03-09T01:39:28.349461Z","steps":["trace[809005555] 'read index received'  (duration: 100.562278ms)","trace[809005555] 'applied index is now lower than readState.Index'  (duration: 210.524µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:39:28.349674Z","caller":"traceutil/trace.go:171","msg":"trace[1357318243] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"134.699876ms","start":"2026-03-09T01:39:28.214924Z","end":"2026-03-09T01:39:28.349623Z","steps":["trace[1357318243] 'process raft request'  (duration: 134.310099ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:39:28.34979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.052367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:39:28.349985Z","caller":"traceutil/trace.go:171","msg":"trace[815808455] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:514; }","duration":"101.351433ms","start":"2026-03-09T01:39:28.248609Z","end":"2026-03-09T01:39:28.349961Z","steps":["trace[815808455] 'agreement among raft nodes before linearized reading'  (duration: 101.059227ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:39:29.062759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.510048ms","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-03-09T01:39:29.06289Z","caller":"traceutil/trace.go:171","msg":"trace[1860088395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"464.717092ms","start":"2026-03-09T01:39:28.598145Z","end":"2026-03-09T01:39:29.062862Z","steps":["trace[1860088395] 'range keys from in-memory index tree'  (duration: 464.336474ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:39:29.06295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:39:28.598116Z","time spent":"464.822734ms","remote":"127.0.0.1:33426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-09T01:39:30.388795Z","caller":"traceutil/trace.go:171","msg":"trace[1451828369] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"103.069267ms","start":"2026-03-09T01:39:30.2857Z","end":"2026-03-09T01:39:30.388769Z","steps":["trace[1451828369] 'process raft request'  (duration: 102.763421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:40:48.363725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.55066ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529670204469421 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1509 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:40:48.36388Z","caller":"traceutil/trace.go:171","msg":"trace[1832610096] linearizableReadLoop","detail":"{readStateIndex:1639; appliedIndex:1638; }","duration":"155.734177ms","start":"2026-03-09T01:40:48.208127Z","end":"2026-03-09T01:40:48.363861Z","steps":["trace[1832610096] 'read index received'  (duration: 54.181µs)","trace[1832610096] 'applied index is now lower than readState.Index'  (duration: 155.675936ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:40:48.364135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.015852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-03-09T01:40:48.364216Z","caller":"traceutil/trace.go:171","msg":"trace[1976780864] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1579; }","duration":"156.109564ms","start":"2026-03-09T01:40:48.208054Z","end":"2026-03-09T01:40:48.364164Z","steps":["trace[1976780864] 'agreement among raft nodes before linearized reading'  (duration: 155.91336ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:48.363946Z","caller":"traceutil/trace.go:171","msg":"trace[360510960] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"263.227725ms","start":"2026-03-09T01:40:48.100659Z","end":"2026-03-09T01:40:48.363887Z","steps":["trace[360510960] 'process raft request'  (duration: 25.633914ms)","trace[360510960] 'compare'  (duration: 236.248683ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:41:34.085533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.236842ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529670204470105 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1851 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:41:34.08574Z","caller":"traceutil/trace.go:171","msg":"trace[1472531692] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"221.804003ms","start":"2026-03-09T01:41:33.863906Z","end":"2026-03-09T01:41:34.08571Z","steps":["trace[1472531692] 'process raft request'  (duration: 117.226414ms)","trace[1472531692] 'compare'  (duration: 104.062959ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:39.219438Z","caller":"traceutil/trace.go:171","msg":"trace[878992073] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"128.810714ms","start":"2026-03-09T01:41:39.090602Z","end":"2026-03-09T01:41:39.219413Z","steps":["trace[878992073] 'read index received'  (duration: 128.525358ms)","trace[878992073] 'applied index is now lower than readState.Index'  (duration: 284.316µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:39.219533Z","caller":"traceutil/trace.go:171","msg":"trace[1468527003] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"148.520843ms","start":"2026-03-09T01:41:39.070974Z","end":"2026-03-09T01:41:39.219495Z","steps":["trace[1468527003] 'process raft request'  (duration: 148.240638ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:39.219775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.14438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-09T01:41:39.219892Z","caller":"traceutil/trace.go:171","msg":"trace[1709154480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1885; }","duration":"129.315124ms","start":"2026-03-09T01:41:39.09055Z","end":"2026-03-09T01:41:39.219865Z","steps":["trace[1709154480] 'agreement among raft nodes before linearized reading'  (duration: 128.986207ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:42:28.216044Z","caller":"traceutil/trace.go:171","msg":"trace[4060571] transaction","detail":"{read_only:false; response_revision:2297; number_of_response:1; }","duration":"148.486273ms","start":"2026-03-09T01:42:28.06752Z","end":"2026-03-09T01:42:28.216006Z","steps":["trace[4060571] 'process raft request'  (duration: 148.263309ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:42:28.223119Z","caller":"traceutil/trace.go:171","msg":"trace[1532895260] transaction","detail":"{read_only:false; response_revision:2298; number_of_response:1; }","duration":"126.948025ms","start":"2026-03-09T01:42:28.096146Z","end":"2026-03-09T01:42:28.223094Z","steps":["trace[1532895260] 'process raft request'  (duration: 126.837203ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:43:01.799479Z","caller":"traceutil/trace.go:171","msg":"trace[1391086344] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"144.222442ms","start":"2026-03-09T01:43:01.655227Z","end":"2026-03-09T01:43:01.799449Z","steps":["trace[1391086344] 'process raft request'  (duration: 144.015908ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:43:01.811064Z","caller":"traceutil/trace.go:171","msg":"trace[552260474] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"149.434707ms","start":"2026-03-09T01:43:01.661609Z","end":"2026-03-09T01:43:01.811044Z","steps":["trace[552260474] 'process raft request'  (duration: 148.910956ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:45:39.128094Z","caller":"traceutil/trace.go:171","msg":"trace[1289915139] transaction","detail":"{read_only:false; response_revision:3433; number_of_response:1; }","duration":"126.779937ms","start":"2026-03-09T01:45:39.001267Z","end":"2026-03-09T01:45:39.128046Z","steps":["trace[1289915139] 'process raft request'  (duration: 126.404729ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:12.024186Z","caller":"traceutil/trace.go:171","msg":"trace[1159632057] linearizableReadLoop","detail":"{readStateIndex:4627; appliedIndex:4626; }","duration":"136.810213ms","start":"2026-03-09T01:47:11.887343Z","end":"2026-03-09T01:47:12.024153Z","steps":["trace[1159632057] 'read index received'  (duration: 106.533628ms)","trace[1159632057] 'applied index is now lower than readState.Index'  (duration: 30.274975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:47:12.024229Z","caller":"traceutil/trace.go:171","msg":"trace[2121447310] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"139.921304ms","start":"2026-03-09T01:47:11.884259Z","end":"2026-03-09T01:47:12.02418Z","steps":["trace[2121447310] 'process raft request'  (duration: 109.561938ms)","trace[2121447310] 'compare'  (duration: 30.174703ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:47:12.024583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.212001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62875"}
{"level":"info","ts":"2026-03-09T01:47:12.024634Z","caller":"traceutil/trace.go:171","msg":"trace[1624075126] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4452; }","duration":"137.341883ms","start":"2026-03-09T01:47:11.887277Z","end":"2026-03-09T01:47:12.024619Z","steps":["trace[1624075126] 'agreement among raft nodes before linearized reading'  (duration: 137.023277ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:12.051986Z","caller":"traceutil/trace.go:171","msg":"trace[897380951] transaction","detail":"{read_only:false; response_revision:4453; number_of_response:1; }","duration":"164.360703ms","start":"2026-03-09T01:47:11.887599Z","end":"2026-03-09T01:47:12.05196Z","steps":["trace[897380951] 'process raft request'  (duration: 163.963114ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:17.871496Z","caller":"traceutil/trace.go:171","msg":"trace[1227628309] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"148.362683ms","start":"2026-03-09T01:47:17.723104Z","end":"2026-03-09T01:47:17.871466Z","steps":["trace[1227628309] 'process raft request'  (duration: 148.069228ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:17.908149Z","caller":"traceutil/trace.go:171","msg":"trace[380868638] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"184.868702ms","start":"2026-03-09T01:47:17.723253Z","end":"2026-03-09T01:47:17.908121Z","steps":["trace[380868638] 'process raft request'  (duration: 184.550616ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:17.908189Z","caller":"traceutil/trace.go:171","msg":"trace[286707999] linearizableReadLoop","detail":"{readStateIndex:4830; appliedIndex:4827; }","duration":"135.026306ms","start":"2026-03-09T01:47:17.773132Z","end":"2026-03-09T01:47:17.908159Z","steps":["trace[286707999] 'read index received'  (duration: 98.004457ms)","trace[286707999] 'applied index is now lower than readState.Index'  (duration: 37.019789ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:47:17.908256Z","caller":"traceutil/trace.go:171","msg":"trace[109882299] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"184.27846ms","start":"2026-03-09T01:47:17.723933Z","end":"2026-03-09T01:47:17.908211Z","steps":["trace[109882299] 'process raft request'  (duration: 184.089826ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:17.908329Z","caller":"traceutil/trace.go:171","msg":"trace[1469647878] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"134.353933ms","start":"2026-03-09T01:47:17.773914Z","end":"2026-03-09T01:47:17.908268Z","steps":["trace[1469647878] 'process raft request'  (duration: 134.167739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:47:17.908707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.541977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7b6bb4c57c-m6lrb\" ","response":"range_response_count:1 size:11256"}
{"level":"info","ts":"2026-03-09T01:47:17.908769Z","caller":"traceutil/trace.go:171","msg":"trace[1215974445] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7b6bb4c57c-m6lrb; range_end:; response_count:1; response_revision:4650; }","duration":"135.654988ms","start":"2026-03-09T01:47:17.773094Z","end":"2026-03-09T01:47:17.908749Z","steps":["trace[1215974445] 'agreement among raft nodes before linearized reading'  (duration: 135.2437ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:47:18.286433Z","caller":"traceutil/trace.go:171","msg":"trace[977003331] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"170.942084ms","start":"2026-03-09T01:47:18.11544Z","end":"2026-03-09T01:47:18.286382Z","steps":["trace[977003331] 'process raft request'  (duration: 115.978486ms)","trace[977003331] 'compare'  (duration: 54.740014ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:47:47.252889Z","caller":"traceutil/trace.go:171","msg":"trace[32724952] transaction","detail":"{read_only:false; response_revision:5161; number_of_response:1; }","duration":"104.058628ms","start":"2026-03-09T01:47:47.148787Z","end":"2026-03-09T01:47:47.252846Z","steps":["trace[32724952] 'process raft request'  (duration: 103.621229ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:48:43.025437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.083368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529670204479413 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5550 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:48:43.025703Z","caller":"traceutil/trace.go:171","msg":"trace[1481429557] transaction","detail":"{read_only:false; response_revision:5561; number_of_response:1; }","duration":"134.316413ms","start":"2026-03-09T01:48:42.891351Z","end":"2026-03-09T01:48:43.025668Z","steps":["trace[1481429557] 'process raft request'  (duration: 19.889148ms)","trace[1481429557] 'compare'  (duration: 113.923095ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:48:50.427323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2726}
{"level":"info","ts":"2026-03-09T01:48:50.476876Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2726,"took":"48.307784ms","hash":1085922268,"current-db-size-bytes":40534016,"current-db-size":"40 MB","current-db-size-in-use-bytes":30244864,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-03-09T01:48:50.476944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1085922268,"revision":2726,"compact-revision":-1}
{"level":"info","ts":"2026-03-09T01:53:34.825995Z","caller":"traceutil/trace.go:171","msg":"trace[2009088253] linearizableReadLoop","detail":"{readStateIndex:7904; appliedIndex:7903; }","duration":"192.746094ms","start":"2026-03-09T01:53:34.633208Z","end":"2026-03-09T01:53:34.825954Z","steps":["trace[2009088253] 'read index received'  (duration: 192.410568ms)","trace[2009088253] 'applied index is now lower than readState.Index'  (duration: 333.946µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:53:34.8261Z","caller":"traceutil/trace.go:171","msg":"trace[216116604] transaction","detail":"{read_only:false; response_revision:7625; number_of_response:1; }","duration":"219.014478ms","start":"2026-03-09T01:53:34.607029Z","end":"2026-03-09T01:53:34.826044Z","steps":["trace[216116604] 'process raft request'  (duration: 218.678021ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:53:34.82623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.000109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:53:34.82636Z","caller":"traceutil/trace.go:171","msg":"trace[538178787] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:7625; }","duration":"193.177952ms","start":"2026-03-09T01:53:34.633136Z","end":"2026-03-09T01:53:34.826314Z","steps":["trace[538178787] 'agreement among raft nodes before linearized reading'  (duration: 192.986178ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:53:34.987532Z","caller":"traceutil/trace.go:171","msg":"trace[1738767514] transaction","detail":"{read_only:false; response_revision:7626; number_of_response:1; }","duration":"156.4152ms","start":"2026-03-09T01:53:34.831096Z","end":"2026-03-09T01:53:34.987511Z","steps":["trace[1738767514] 'process raft request'  (duration: 140.451771ms)","trace[1738767514] 'compare'  (duration: 15.882217ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:53:47.402085Z","caller":"traceutil/trace.go:171","msg":"trace[797181808] transaction","detail":"{read_only:false; response_revision:7682; number_of_response:1; }","duration":"211.450266ms","start":"2026-03-09T01:53:47.190595Z","end":"2026-03-09T01:53:47.402045Z","steps":["trace[797181808] 'process raft request'  (duration: 144.603243ms)","trace[797181808] 'compare'  (duration: 66.360443ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:53:50.434278Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5622}
{"level":"info","ts":"2026-03-09T01:53:50.523151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5622,"took":"86.437144ms","hash":3792453431,"current-db-size-bytes":43040768,"current-db-size":"43 MB","current-db-size-in-use-bytes":23343104,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-09T01:53:50.523249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3792453431,"revision":5622,"compact-revision":2726}
{"level":"warn","ts":"2026-03-09T01:54:14.114197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.504436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-03-09T01:54:14.114312Z","caller":"traceutil/trace.go:171","msg":"trace[1047511431] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7868; }","duration":"101.687848ms","start":"2026-03-09T01:54:14.012602Z","end":"2026-03-09T01:54:14.11429Z","steps":["trace[1047511431] 'range keys from in-memory index tree'  (duration: 101.303822ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:14.214167Z","caller":"traceutil/trace.go:171","msg":"trace[973366309] transaction","detail":"{read_only:false; response_revision:7869; number_of_response:1; }","duration":"158.384758ms","start":"2026-03-09T01:54:14.055759Z","end":"2026-03-09T01:54:14.214144Z","steps":["trace[973366309] 'process raft request'  (duration: 158.131453ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:54:14.247906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.321359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-03-09T01:54:14.248067Z","caller":"traceutil/trace.go:171","msg":"trace[198950420] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7869; }","duration":"129.537803ms","start":"2026-03-09T01:54:14.118497Z","end":"2026-03-09T01:54:14.248035Z","steps":["trace[198950420] 'agreement among raft nodes before linearized reading'  (duration: 95.693898ms)","trace[198950420] 'range keys from in-memory index tree'  (duration: 33.515258ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:54:26.132122Z","caller":"traceutil/trace.go:171","msg":"trace[332303179] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7967; }","duration":"138.894241ms","start":"2026-03-09T01:54:25.9932Z","end":"2026-03-09T01:54:26.132094Z","steps":["trace[332303179] 'process raft request'  (duration: 138.756188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:26.721166Z","caller":"traceutil/trace.go:171","msg":"trace[707454069] transaction","detail":"{read_only:false; response_revision:7971; number_of_response:1; }","duration":"142.687236ms","start":"2026-03-09T01:54:26.578447Z","end":"2026-03-09T01:54:26.721135Z","steps":["trace[707454069] 'process raft request'  (duration: 142.36188ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:27.814238Z","caller":"traceutil/trace.go:171","msg":"trace[679615648] transaction","detail":"{read_only:false; response_revision:7977; number_of_response:1; }","duration":"227.759702ms","start":"2026-03-09T01:54:27.58643Z","end":"2026-03-09T01:54:27.814189Z","steps":["trace[679615648] 'process raft request'  (duration: 227.17025ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:27.86595Z","caller":"traceutil/trace.go:171","msg":"trace[196253607] linearizableReadLoop","detail":"{readStateIndex:8275; appliedIndex:8272; }","duration":"215.352685ms","start":"2026-03-09T01:54:27.650571Z","end":"2026-03-09T01:54:27.865924Z","steps":["trace[196253607] 'read index received'  (duration: 163.428119ms)","trace[196253607] 'applied index is now lower than readState.Index'  (duration: 51.923286ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:54:27.866049Z","caller":"traceutil/trace.go:171","msg":"trace[1914212422] transaction","detail":"{read_only:false; response_revision:7979; number_of_response:1; }","duration":"269.432544ms","start":"2026-03-09T01:54:27.596589Z","end":"2026-03-09T01:54:27.866021Z","steps":["trace[1914212422] 'process raft request'  (duration: 269.260701ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:27.866063Z","caller":"traceutil/trace.go:171","msg":"trace[94968763] transaction","detail":"{read_only:false; response_revision:7978; number_of_response:1; }","duration":"269.984255ms","start":"2026-03-09T01:54:27.596025Z","end":"2026-03-09T01:54:27.866009Z","steps":["trace[94968763] 'process raft request'  (duration: 269.695708ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:54:27.866169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.556739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:54:27.866219Z","caller":"traceutil/trace.go:171","msg":"trace[296523515] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:7979; }","duration":"215.689762ms","start":"2026-03-09T01:54:27.650517Z","end":"2026-03-09T01:54:27.866207Z","steps":["trace[296523515] 'agreement among raft nodes before linearized reading'  (duration: 215.556839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:54:27.866264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.742997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-09T01:54:27.86629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.369321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-09T01:54:27.866323Z","caller":"traceutil/trace.go:171","msg":"trace[1181608410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7979; }","duration":"117.423612ms","start":"2026-03-09T01:54:27.748892Z","end":"2026-03-09T01:54:27.866315Z","steps":["trace[1181608410] 'agreement among raft nodes before linearized reading'  (duration: 117.33878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:54:27.866322Z","caller":"traceutil/trace.go:171","msg":"trace[790753137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7979; }","duration":"150.822619ms","start":"2026-03-09T01:54:27.715484Z","end":"2026-03-09T01:54:27.866307Z","steps":["trace[790753137] 'agreement among raft nodes before linearized reading'  (duration: 150.608025ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:57:52.498352Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-09T01:57:52.505302Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-09T01:57:52.505449Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-09T01:58:50.44206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7705}
{"level":"info","ts":"2026-03-09T01:58:50.511356Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7705,"took":"66.459934ms","hash":3221852621,"current-db-size-bytes":43040768,"current-db-size":"43 MB","current-db-size-in-use-bytes":26488832,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-09T01:58:50.511435Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3221852621,"revision":7705,"compact-revision":5622}
{"level":"info","ts":"2026-03-09T02:03:50.449051Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9979}
{"level":"info","ts":"2026-03-09T02:03:50.526437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9979,"took":"74.486278ms","hash":3961913827,"current-db-size-bytes":43040768,"current-db-size":"43 MB","current-db-size-in-use-bytes":17010688,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-09T02:03:50.526587Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3961913827,"revision":9979,"compact-revision":7705}