{"level":"warn","ts":"2026-03-29T01:57:49.509451Z","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-29T01:57:49.509591Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-29T01:57:49.509727Z","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-29T01:57:49.509746Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-03-29T01:57:49.509771Z","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-29T01:57:49.510545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]}
{"level":"info","ts":"2026-03-29T01:57:49.510699Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-29T01:57:49.514782Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.691782ms"}
{"level":"info","ts":"2026-03-29T01:57:49.521612Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"}
{"level":"info","ts":"2026-03-29T01:57:49.521976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"}
{"level":"info","ts":"2026-03-29T01:57:49.52204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"}
{"level":"info","ts":"2026-03-29T01:57:49.522071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-29T01:57:49.522096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"}
{"level":"info","ts":"2026-03-29T01:57:49.52228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"warn","ts":"2026-03-29T01:57:49.528106Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-29T01:57:49.530441Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-29T01:57:49.531786Z","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-29T01:57:49.535817Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-29T01:57:49.536005Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-29T01:57:49.536221Z","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-29T01:57:49.536981Z","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-29T01:57:49.537018Z","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-29T01:57:49.538706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"}
{"level":"info","ts":"2026-03-29T01:57:49.540038Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]}
{"level":"info","ts":"2026-03-29T01:57:49.544052Z","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-29T01:57:49.544256Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-03-29T01:57:49.54433Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"}
{"level":"info","ts":"2026-03-29T01:57:49.54439Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-29T01:57:49.544472Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-29T01:57:50.523031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"}
{"level":"info","ts":"2026-03-29T01:57:50.523098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-29T01:57:50.523141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"}
{"level":"info","ts":"2026-03-29T01:57:50.523163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"}
{"level":"info","ts":"2026-03-29T01:57:50.523174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-03-29T01:57:50.52319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"}
{"level":"info","ts":"2026-03-29T01:57:50.52321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"}
{"level":"info","ts":"2026-03-29T01:57:50.524168Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-29T01:57:50.525108Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-29T01:57:50.525103Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-29T01:57:50.525265Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-29T01:57:50.525535Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-29T01:57:50.525575Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-29T01:57:50.526339Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-29T01:57:50.52657Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-29T01:57:50.526652Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-29T01:57:50.528767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"}
{"level":"info","ts":"2026-03-29T01:57:50.5293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-29T01:58:15.810573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.980709ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995350479700186621 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:459 > 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-29T01:58:15.810708Z","caller":"traceutil/trace.go:171","msg":"trace[1495112229] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"137.256119ms","start":"2026-03-29T01:58:15.673433Z","end":"2026-03-29T01:58:15.810689Z","steps":["trace[1495112229] 'process raft request'  (duration: 34.598905ms)","trace[1495112229] 'compare'  (duration: 101.806865ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T01:58:20.416378Z","caller":"traceutil/trace.go:171","msg":"trace[1632197270] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"108.726909ms","start":"2026-03-29T01:58:20.307608Z","end":"2026-03-29T01:58:20.416335Z","steps":["trace[1632197270] 'process raft request'  (duration: 108.30198ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:58:20.416681Z","caller":"traceutil/trace.go:171","msg":"trace[989397333] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"105.608098ms","start":"2026-03-29T01:58:20.311038Z","end":"2026-03-29T01:58:20.416646Z","steps":["trace[989397333] 'process raft request'  (duration: 105.299511ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:58:20.416799Z","caller":"traceutil/trace.go:171","msg":"trace[894075910] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"107.204915ms","start":"2026-03-29T01:58:20.309568Z","end":"2026-03-29T01:58:20.416773Z","steps":["trace[894075910] 'process raft request'  (duration: 106.691443ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:58:20.417034Z","caller":"traceutil/trace.go:171","msg":"trace[764714008] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"103.172793ms","start":"2026-03-29T01:58:20.31385Z","end":"2026-03-29T01:58:20.417023Z","steps":["trace[764714008] 'process raft request'  (duration: 102.55608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:58:20.417176Z","caller":"traceutil/trace.go:171","msg":"trace[232843127] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"100.006363ms","start":"2026-03-29T01:58:20.31694Z","end":"2026-03-29T01:58:20.416947Z","steps":["trace[232843127] 'process raft request'  (duration: 99.575233ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:58:26.627146Z","caller":"traceutil/trace.go:171","msg":"trace[319075587] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"188.607672ms","start":"2026-03-29T01:58:26.438514Z","end":"2026-03-29T01:58:26.627122Z","steps":["trace[319075587] 'read index received'  (duration: 187.790254ms)","trace[319075587] 'applied index is now lower than readState.Index'  (duration: 816.568µs)"],"step_count":2}
{"level":"info","ts":"2026-03-29T01:58:26.627286Z","caller":"traceutil/trace.go:171","msg":"trace[412583577] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"303.938593ms","start":"2026-03-29T01:58:26.323308Z","end":"2026-03-29T01:58:26.627246Z","steps":["trace[412583577] 'process raft request'  (duration: 303.271339ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T01:58:26.627345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.808346ms","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-03-29T01:58:26.627441Z","caller":"traceutil/trace.go:171","msg":"trace[872371476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"188.958499ms","start":"2026-03-29T01:58:26.438468Z","end":"2026-03-29T01:58:26.627427Z","steps":["trace[872371476] 'agreement among raft nodes before linearized reading'  (duration: 188.756715ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T01:58:26.627481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T01:58:26.323279Z","time spent":"304.101146ms","remote":"127.0.0.1:52000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:609 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036193 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-03-29T01:58:26.891321Z","caller":"traceutil/trace.go:171","msg":"trace[1101220012] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"206.937238ms","start":"2026-03-29T01:58:26.684349Z","end":"2026-03-29T01:58:26.891287Z","steps":["trace[1101220012] 'process raft request'  (duration: 188.711133ms)","trace[1101220012] 'compare'  (duration: 18.01844ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T01:58:27.446693Z","caller":"traceutil/trace.go:171","msg":"trace[1971811036] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"152.219923ms","start":"2026-03-29T01:58:27.294439Z","end":"2026-03-29T01:58:27.446659Z","steps":["trace[1971811036] 'process raft request'  (duration: 148.288277ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T01:58:41.783549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.707068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-29T01:58:41.783641Z","caller":"traceutil/trace.go:171","msg":"trace[841410939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"101.84525ms","start":"2026-03-29T01:58:41.681777Z","end":"2026-03-29T01:58:41.783622Z","steps":["trace[841410939] 'range keys from in-memory index tree'  (duration: 101.565494ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:59:59.871176Z","caller":"traceutil/trace.go:171","msg":"trace[1615948654] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"189.800301ms","start":"2026-03-29T01:59:59.68135Z","end":"2026-03-29T01:59:59.871151Z","steps":["trace[1615948654] 'read index received'  (duration: 189.626648ms)","trace[1615948654] 'applied index is now lower than readState.Index'  (duration: 172.533µs)"],"step_count":2}
{"level":"info","ts":"2026-03-29T01:59:59.871282Z","caller":"traceutil/trace.go:171","msg":"trace[1146185635] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"245.651896ms","start":"2026-03-29T01:59:59.625594Z","end":"2026-03-29T01:59:59.871246Z","steps":["trace[1146185635] 'process raft request'  (duration: 245.40449ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T01:59:59.871376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.998575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-29T01:59:59.871446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.766369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a12d5ac33e2f9e\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-03-29T01:59:59.871468Z","caller":"traceutil/trace.go:171","msg":"trace[150512766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"190.155369ms","start":"2026-03-29T01:59:59.681292Z","end":"2026-03-29T01:59:59.871448Z","steps":["trace[150512766] 'agreement among raft nodes before linearized reading'  (duration: 189.984425ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T01:59:59.871494Z","caller":"traceutil/trace.go:171","msg":"trace[416241177] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a12d5ac33e2f9e; range_end:; response_count:1; response_revision:1852; }","duration":"150.855511ms","start":"2026-03-29T01:59:59.720622Z","end":"2026-03-29T01:59:59.871478Z","steps":["trace[416241177] 'agreement among raft nodes before linearized reading'  (duration: 150.701718ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:00:00.427752Z","caller":"traceutil/trace.go:171","msg":"trace[1290551340] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1925; }","duration":"103.525042ms","start":"2026-03-29T02:00:00.324193Z","end":"2026-03-29T02:00:00.427718Z","steps":["trace[1290551340] 'read index received'  (duration: 102.285126ms)","trace[1290551340] 'applied index is now lower than readState.Index'  (duration: 1.237916ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:00:00.428014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.801678ms","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-29T02:00:00.428061Z","caller":"traceutil/trace.go:171","msg":"trace[576297322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1857; }","duration":"103.92705ms","start":"2026-03-29T02:00:00.324121Z","end":"2026-03-29T02:00:00.428048Z","steps":["trace[576297322] 'agreement among raft nodes before linearized reading'  (duration: 103.715806ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:00:00.428212Z","caller":"traceutil/trace.go:171","msg":"trace[1490728126] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"160.439099ms","start":"2026-03-29T02:00:00.267738Z","end":"2026-03-29T02:00:00.428177Z","steps":["trace[1490728126] 'process raft request'  (duration: 158.749743ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:00:43.588077Z","caller":"traceutil/trace.go:171","msg":"trace[1729807347] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2213; }","duration":"148.724589ms","start":"2026-03-29T02:00:43.439325Z","end":"2026-03-29T02:00:43.588049Z","steps":["trace[1729807347] 'read index received'  (duration: 7.545732ms)","trace[1729807347] 'applied index is now lower than readState.Index'  (duration: 141.177936ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:00:43.588227Z","caller":"traceutil/trace.go:171","msg":"trace[104197649] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"205.994226ms","start":"2026-03-29T02:00:43.382176Z","end":"2026-03-29T02:00:43.588171Z","steps":["trace[104197649] 'process raft request'  (duration: 190.33463ms)","trace[104197649] 'compare'  (duration: 15.402931ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:00:43.588428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.010404ms","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-03-29T02:00:43.588475Z","caller":"traceutil/trace.go:171","msg":"trace[33004578] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2138; }","duration":"149.166917ms","start":"2026-03-29T02:00:43.439296Z","end":"2026-03-29T02:00:43.588463Z","steps":["trace[33004578] 'agreement among raft nodes before linearized reading'  (duration: 148.858981ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:00:49.562119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.377332ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995350479700190139 > lease_revoke:<id:6bdb9d374fcb62e8>","response":"size:27"}
{"level":"info","ts":"2026-03-29T02:00:54.845566Z","caller":"traceutil/trace.go:171","msg":"trace[1226568487] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"180.864616ms","start":"2026-03-29T02:00:54.664657Z","end":"2026-03-29T02:00:54.845522Z","steps":["trace[1226568487] 'read index received'  (duration: 180.503938ms)","trace[1226568487] 'applied index is now lower than readState.Index'  (duration: 358.488µs)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:00:54.845658Z","caller":"traceutil/trace.go:171","msg":"trace[1877401244] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"217.683956ms","start":"2026-03-29T02:00:54.627937Z","end":"2026-03-29T02:00:54.845621Z","steps":["trace[1877401244] 'process raft request'  (duration: 217.280948ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:00:54.84604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.537998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-29T02:00:54.84612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.158159ms","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-03-29T02:00:54.845975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.186054ms","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-03-29T02:00:54.846202Z","caller":"traceutil/trace.go:171","msg":"trace[665244025] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2197; }","duration":"171.284472ms","start":"2026-03-29T02:00:54.674888Z","end":"2026-03-29T02:00:54.846173Z","steps":["trace[665244025] 'agreement among raft nodes before linearized reading'  (duration: 170.894874ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:00:54.846267Z","caller":"traceutil/trace.go:171","msg":"trace[237104802] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2197; }","duration":"181.632543ms","start":"2026-03-29T02:00:54.664603Z","end":"2026-03-29T02:00:54.846236Z","steps":["trace[237104802] 'agreement among raft nodes before linearized reading'  (duration: 181.109702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:00:54.846131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.479707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-29T02:00:54.846553Z","caller":"traceutil/trace.go:171","msg":"trace[1768714774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2197; }","duration":"165.950267ms","start":"2026-03-29T02:00:54.680582Z","end":"2026-03-29T02:00:54.846532Z","steps":["trace[1768714774] 'agreement among raft nodes before linearized reading'  (duration: 165.461247ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:00:54.846152Z","caller":"traceutil/trace.go:171","msg":"trace[1372165684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2197; }","duration":"150.726782ms","start":"2026-03-29T02:00:54.6954Z","end":"2026-03-29T02:00:54.846127Z","steps":["trace[1372165684] 'agreement among raft nodes before linearized reading'  (duration: 150.440746ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:02:12.122112Z","caller":"traceutil/trace.go:171","msg":"trace[1680053009] linearizableReadLoop","detail":"{readStateIndex:2763; appliedIndex:2762; }","duration":"124.715678ms","start":"2026-03-29T02:02:11.997374Z","end":"2026-03-29T02:02:12.122089Z","steps":["trace[1680053009] 'read index received'  (duration: 111.514566ms)","trace[1680053009] 'applied index is now lower than readState.Index'  (duration: 13.197892ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:02:12.122152Z","caller":"traceutil/trace.go:171","msg":"trace[710431383] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"144.263086ms","start":"2026-03-29T02:02:11.977848Z","end":"2026-03-29T02:02:12.122111Z","steps":["trace[710431383] 'process raft request'  (duration: 131.099304ms)","trace[710431383] 'compare'  (duration: 13.035299ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:02:12.122317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.919512ms","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-03-29T02:02:12.122358Z","caller":"traceutil/trace.go:171","msg":"trace[1174096024] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2666; }","duration":"125.006514ms","start":"2026-03-29T02:02:11.997341Z","end":"2026-03-29T02:02:12.122348Z","steps":["trace[1174096024] 'agreement among raft nodes before linearized reading'  (duration: 124.85185ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:02:12.326073Z","caller":"traceutil/trace.go:171","msg":"trace[1842525511] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"128.425317ms","start":"2026-03-29T02:02:12.197625Z","end":"2026-03-29T02:02:12.32605Z","steps":["trace[1842525511] 'process raft request'  (duration: 112.379343ms)","trace[1842525511] 'compare'  (duration: 15.940421ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:06:24.314638Z","caller":"traceutil/trace.go:171","msg":"trace[1178937008] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"133.620751ms","start":"2026-03-29T02:06:24.18099Z","end":"2026-03-29T02:06:24.314611Z","steps":["trace[1178937008] 'process raft request'  (duration: 133.466197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:06:24.50226Z","caller":"traceutil/trace.go:171","msg":"trace[1951457691] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"180.995827ms","start":"2026-03-29T02:06:24.321221Z","end":"2026-03-29T02:06:24.502217Z","steps":["trace[1951457691] 'process raft request'  (duration: 106.4907ms)","trace[1951457691] 'compare'  (duration: 74.371574ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:06:24.523558Z","caller":"traceutil/trace.go:171","msg":"trace[659737935] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"201.395147ms","start":"2026-03-29T02:06:24.322129Z","end":"2026-03-29T02:06:24.523524Z","steps":["trace[659737935] 'process raft request'  (duration: 201.06222ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:06:24.523877Z","caller":"traceutil/trace.go:171","msg":"trace[789246803] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"199.615199ms","start":"2026-03-29T02:06:24.324214Z","end":"2026-03-29T02:06:24.52383Z","steps":["trace[789246803] 'process raft request'  (duration: 199.18167ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:06:24.523897Z","caller":"traceutil/trace.go:171","msg":"trace[1692770568] linearizableReadLoop","detail":"{readStateIndex:5202; appliedIndex:5198; }","duration":"152.147211ms","start":"2026-03-29T02:06:24.371715Z","end":"2026-03-29T02:06:24.523862Z","steps":["trace[1692770568] 'read index received'  (duration: 56.0782ms)","trace[1692770568] 'applied index is now lower than readState.Index'  (duration: 96.067681ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:06:24.523977Z","caller":"traceutil/trace.go:171","msg":"trace[273701362] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"199.410754ms","start":"2026-03-29T02:06:24.324531Z","end":"2026-03-29T02:06:24.523942Z","steps":["trace[273701362] 'process raft request'  (duration: 199.163239ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:06:24.524178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.438486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:15520"}
{"level":"info","ts":"2026-03-29T02:06:24.524232Z","caller":"traceutil/trace.go:171","msg":"trace[1174292272] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5015; }","duration":"152.556469ms","start":"2026-03-29T02:06:24.371661Z","end":"2026-03-29T02:06:24.524218Z","steps":["trace[1174292272] 'agreement among raft nodes before linearized reading'  (duration: 152.334774ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:06:43.931284Z","caller":"traceutil/trace.go:171","msg":"trace[1809250767] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"254.099315ms","start":"2026-03-29T02:06:43.677122Z","end":"2026-03-29T02:06:43.931221Z","steps":["trace[1809250767] 'process raft request'  (duration: 253.962402ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:06:43.937002Z","caller":"traceutil/trace.go:171","msg":"trace[1669699067] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"256.089187ms","start":"2026-03-29T02:06:43.680897Z","end":"2026-03-29T02:06:43.936986Z","steps":["trace[1669699067] 'process raft request'  (duration: 256.036556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:06:44.152854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.560166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-29T02:06:44.152946Z","caller":"traceutil/trace.go:171","msg":"trace[962415267] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:5271; }","duration":"178.7108ms","start":"2026-03-29T02:06:43.974215Z","end":"2026-03-29T02:06:44.152926Z","steps":["trace[962415267] 'range keys from in-memory index tree'  (duration: 178.395033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:07:20.117323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.199453ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995350479700199069 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5602 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-29T02:07:20.117489Z","caller":"traceutil/trace.go:171","msg":"trace[1943192007] transaction","detail":"{read_only:false; response_revision:5703; number_of_response:1; }","duration":"408.470724ms","start":"2026-03-29T02:07:19.708988Z","end":"2026-03-29T02:07:20.117458Z","steps":["trace[1943192007] 'process raft request'  (duration: 36.021765ms)","trace[1943192007] 'compare'  (duration: 371.981269ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:07:20.117584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:07:19.708974Z","time spent":"408.563095ms","remote":"127.0.0.1:52168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5602 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-29T02:07:20.192524Z","caller":"traceutil/trace.go:171","msg":"trace[1480883928] linearizableReadLoop","detail":"{readStateIndex:5907; appliedIndex:5906; }","duration":"241.284615ms","start":"2026-03-29T02:07:19.951204Z","end":"2026-03-29T02:07:20.192488Z","steps":["trace[1480883928] 'read index received'  (duration: 241.114181ms)","trace[1480883928] 'applied index is now lower than readState.Index'  (duration: 169.054µs)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:07:20.192677Z","caller":"traceutil/trace.go:171","msg":"trace[1352980709] transaction","detail":"{read_only:false; response_revision:5704; number_of_response:1; }","duration":"475.507511ms","start":"2026-03-29T02:07:19.717104Z","end":"2026-03-29T02:07:20.192611Z","steps":["trace[1352980709] 'process raft request'  (duration: 475.208645ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:07:20.192787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.55978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-29T02:07:20.192835Z","caller":"traceutil/trace.go:171","msg":"trace[1620844246] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5704; }","duration":"241.666493ms","start":"2026-03-29T02:07:19.951156Z","end":"2026-03-29T02:07:20.192822Z","steps":["trace[1620844246] 'agreement among raft nodes before linearized reading'  (duration: 241.5418ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:07:20.192964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:07:19.717084Z","time spent":"475.691085ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12114,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/keystone-api-7f9655b69b-79s9s\" mod_revision:5677 > success:<request_put:<key:\"/registry/pods/openstack/keystone-api-7f9655b69b-79s9s\" value_size:12052 >> failure:<request_range:<key:\"/registry/pods/openstack/keystone-api-7f9655b69b-79s9s\" > >"}
{"level":"info","ts":"2026-03-29T02:07:20.314759Z","caller":"traceutil/trace.go:171","msg":"trace[2059208966] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"118.258222ms","start":"2026-03-29T02:07:20.19646Z","end":"2026-03-29T02:07:20.314718Z","steps":["trace[2059208966] 'process raft request'  (duration: 39.457558ms)","trace[2059208966] 'compare'  (duration: 78.63653ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:07:20.314877Z","caller":"traceutil/trace.go:171","msg":"trace[703497501] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"116.785462ms","start":"2026-03-29T02:07:20.198075Z","end":"2026-03-29T02:07:20.314861Z","steps":["trace[703497501] 'process raft request'  (duration: 116.659629ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:07:20.314832Z","caller":"traceutil/trace.go:171","msg":"trace[193737139] linearizableReadLoop","detail":"{readStateIndex:5908; appliedIndex:5907; }","duration":"118.224521ms","start":"2026-03-29T02:07:20.196577Z","end":"2026-03-29T02:07:20.314802Z","steps":["trace[193737139] 'read index received'  (duration: 39.351886ms)","trace[193737139] 'applied index is now lower than readState.Index'  (duration: 78.869025ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:07:20.315329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.720592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-credential-setup-764f4\" ","response":"range_response_count:1 size:7556"}
{"level":"info","ts":"2026-03-29T02:07:20.315318Z","caller":"traceutil/trace.go:171","msg":"trace[1077892479] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"116.527236ms","start":"2026-03-29T02:07:20.198758Z","end":"2026-03-29T02:07:20.315285Z","steps":["trace[1077892479] 'process raft request'  (duration: 116.038056ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:07:20.315403Z","caller":"traceutil/trace.go:171","msg":"trace[1252801080] range","detail":"{range_begin:/registry/pods/openstack/keystone-credential-setup-764f4; range_end:; response_count:1; response_revision:5707; }","duration":"118.827903ms","start":"2026-03-29T02:07:20.196557Z","end":"2026-03-29T02:07:20.315384Z","steps":["trace[1252801080] 'agreement among raft nodes before linearized reading'  (duration: 118.565848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:07:50.555823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2870}
{"level":"info","ts":"2026-03-29T02:07:50.620977Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2870,"took":"63.747408ms","hash":295573956,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":32788480,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-03-29T02:07:50.621101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":295573956,"revision":2870,"compact-revision":-1}
{"level":"info","ts":"2026-03-29T02:12:38.623169Z","caller":"traceutil/trace.go:171","msg":"trace[1615679851] linearizableReadLoop","detail":"{readStateIndex:8349; appliedIndex:8348; }","duration":"214.24367ms","start":"2026-03-29T02:12:38.408879Z","end":"2026-03-29T02:12:38.623122Z","steps":["trace[1615679851] 'read index received'  (duration: 214.023466ms)","trace[1615679851] 'applied index is now lower than readState.Index'  (duration: 219.244µs)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:12:38.623317Z","caller":"traceutil/trace.go:171","msg":"trace[1833566352] transaction","detail":"{read_only:false; response_revision:8070; number_of_response:1; }","duration":"226.15325ms","start":"2026-03-29T02:12:38.397152Z","end":"2026-03-29T02:12:38.623305Z","steps":["trace[1833566352] 'process raft request'  (duration: 225.808483ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:12:38.623646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.018819ms","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":"warn","ts":"2026-03-29T02:12:38.623745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.839042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-29T02:12:38.623762Z","caller":"traceutil/trace.go:171","msg":"trace[1342575723] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8070; }","duration":"118.149952ms","start":"2026-03-29T02:12:38.505578Z","end":"2026-03-29T02:12:38.623728Z","steps":["trace[1342575723] 'agreement among raft nodes before linearized reading'  (duration: 117.861076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:12:38.623805Z","caller":"traceutil/trace.go:171","msg":"trace[1468930104] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:8070; }","duration":"214.960365ms","start":"2026-03-29T02:12:38.408829Z","end":"2026-03-29T02:12:38.62379Z","steps":["trace[1468930104] 'agreement among raft nodes before linearized reading'  (duration: 214.840093ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:12:50.562147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5937}
{"level":"info","ts":"2026-03-29T02:12:50.641701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5937,"took":"76.731568ms","hash":2524991948,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":26333184,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-29T02:12:50.641761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2524991948,"revision":5937,"compact-revision":2870}
{"level":"warn","ts":"2026-03-29T02:12:54.146458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.658973ms","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-03-29T02:12:54.146559Z","caller":"traceutil/trace.go:171","msg":"trace[746644993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8155; }","duration":"100.827907ms","start":"2026-03-29T02:12:54.045706Z","end":"2026-03-29T02:12:54.146534Z","steps":["trace[746644993] 'range keys from in-memory index tree'  (duration: 100.352407ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:12:54.14655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.969647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-29T02:12:54.146631Z","caller":"traceutil/trace.go:171","msg":"trace[691978300] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:8155; }","duration":"153.114379ms","start":"2026-03-29T02:12:53.993496Z","end":"2026-03-29T02:12:54.14661Z","steps":["trace[691978300] 'range keys from in-memory index tree'  (duration: 152.749892ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:13:06.980423Z","caller":"traceutil/trace.go:171","msg":"trace[1399994601] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"138.649684ms","start":"2026-03-29T02:13:06.841714Z","end":"2026-03-29T02:13:06.980364Z","steps":["trace[1399994601] 'process raft request'  (duration: 138.378298ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:13:07.170342Z","caller":"traceutil/trace.go:171","msg":"trace[1429556116] linearizableReadLoop","detail":"{readStateIndex:8564; appliedIndex:8563; }","duration":"184.259717ms","start":"2026-03-29T02:13:06.986041Z","end":"2026-03-29T02:13:07.170301Z","steps":["trace[1429556116] 'read index received'  (duration: 170.825883ms)","trace[1429556116] 'applied index is now lower than readState.Index'  (duration: 13.432464ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:13:07.17043Z","caller":"traceutil/trace.go:171","msg":"trace[1722002037] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"184.457111ms","start":"2026-03-29T02:13:06.985937Z","end":"2026-03-29T02:13:07.170394Z","steps":["trace[1722002037] 'process raft request'  (duration: 170.922075ms)","trace[1722002037] 'compare'  (duration: 13.24213ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:13:07.170523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.449681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-29T02:13:07.170901Z","caller":"traceutil/trace.go:171","msg":"trace[470856715] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:8277; }","duration":"184.852639ms","start":"2026-03-29T02:13:06.985996Z","end":"2026-03-29T02:13:07.170848Z","steps":["trace[470856715] 'agreement among raft nodes before linearized reading'  (duration: 184.447771ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:13:20.216116Z","caller":"traceutil/trace.go:171","msg":"trace[325095098] transaction","detail":"{read_only:false; response_revision:8385; number_of_response:1; }","duration":"193.544843ms","start":"2026-03-29T02:13:20.022544Z","end":"2026-03-29T02:13:20.216088Z","steps":["trace[325095098] 'process raft request'  (duration: 193.340079ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-29T02:13:21.250407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.779489ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16995350479700206581 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8370 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-29T02:13:21.250721Z","caller":"traceutil/trace.go:171","msg":"trace[2064139111] linearizableReadLoop","detail":"{readStateIndex:8685; appliedIndex:8684; }","duration":"196.341031ms","start":"2026-03-29T02:13:21.054159Z","end":"2026-03-29T02:13:21.2505Z","steps":["trace[2064139111] 'read index received'  (duration: 28.328347ms)","trace[2064139111] 'applied index is now lower than readState.Index'  (duration: 168.011304ms)"],"step_count":2}
{"level":"info","ts":"2026-03-29T02:13:21.250769Z","caller":"traceutil/trace.go:171","msg":"trace[1470552606] transaction","detail":"{read_only:false; response_revision:8393; number_of_response:1; }","duration":"204.498563ms","start":"2026-03-29T02:13:21.046192Z","end":"2026-03-29T02:13:21.250691Z","steps":["trace[1470552606] 'process raft request'  (duration: 36.352596ms)","trace[1470552606] 'compare'  (duration: 167.676837ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-29T02:13:21.250972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.789181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4725"}
{"level":"info","ts":"2026-03-29T02:13:21.251062Z","caller":"traceutil/trace.go:171","msg":"trace[953309833] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:8393; }","duration":"196.919735ms","start":"2026-03-29T02:13:21.054121Z","end":"2026-03-29T02:13:21.25104Z","steps":["trace[953309833] 'agreement among raft nodes before linearized reading'  (duration: 196.67808ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:14:23.567602Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245f.wal"}
{"level":"info","ts":"2026-03-29T02:14:28.088544Z","caller":"traceutil/trace.go:171","msg":"trace[1859964150] transaction","detail":"{read_only:false; response_revision:9026; number_of_response:1; }","duration":"130.987554ms","start":"2026-03-29T02:14:27.957528Z","end":"2026-03-29T02:14:28.088516Z","steps":["trace[1859964150] 'process raft request'  (duration: 130.740999ms)"],"step_count":1}
{"level":"info","ts":"2026-03-29T02:15:45.119184Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"14f8f2dfdaccebdb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-29T02:15:45.124962Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-29T02:15:45.125061Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-29T02:17:50.575327Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8137}
{"level":"info","ts":"2026-03-29T02:17:50.63979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8137,"took":"62.275477ms","hash":3725344231,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":28979200,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-03-29T02:17:50.639848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3725344231,"revision":8137,"compact-revision":5937}
{"level":"info","ts":"2026-03-29T02:22:50.58187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10566}
{"level":"info","ts":"2026-03-29T02:22:50.674439Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10566,"took":"89.708996ms","hash":2021397656,"current-db-size-bytes":57176064,"current-db-size":"57 MB","current-db-size-in-use-bytes":20033536,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-03-29T02:22:50.674518Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2021397656,"revision":10566,"compact-revision":8137}