{"level":"warn","ts":"2026-04-08T01:19:18.916699Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-08T01:19:18.916869Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.207: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.207:2380","--initial-cluster=instance=https://162.253.55.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.207:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-08T01:19:18.916994Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-08T01:19:18.917022Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.207:2380"]}
{"level":"info","ts":"2026-04-08T01:19:18.917061Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-08T01:19:18.918353Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"]}
{"level":"info","ts":"2026-04-08T01:19:18.9185Z","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.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.207:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-08T01:19:18.924246Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.336048ms"}
{"level":"info","ts":"2026-04-08T01:19:18.941643Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6f1fcbe50562a63a","cluster-id":"a9b9f04f4e8a9fba"}
{"level":"info","ts":"2026-04-08T01:19:18.942013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=()"}
{"level":"info","ts":"2026-04-08T01:19:18.942063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 0"}
{"level":"info","ts":"2026-04-08T01:19:18.942275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6f1fcbe50562a63a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-08T01:19:18.942489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 1"}
{"level":"info","ts":"2026-04-08T01:19:18.942693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"}
{"level":"warn","ts":"2026-04-08T01:19:18.952374Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-08T01:19:18.954999Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-08T01:19:18.957935Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-08T01:19:18.962693Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6f1fcbe50562a63a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-08T01:19:18.96309Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6f1fcbe50562a63a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-08T01:19:18.963085Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-08T01:19:18.963229Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-08T01:19:18.963259Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-08T01:19:18.964726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"}
{"level":"info","ts":"2026-04-08T01:19:18.965757Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","added-peer-id":"6f1fcbe50562a63a","added-peer-peer-urls":["https://162.253.55.207:2380"]}
{"level":"info","ts":"2026-04-08T01:19:18.967802Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-08T01:19:18.967929Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.207:2380"}
{"level":"info","ts":"2026-04-08T01:19:18.967985Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.207:2380"}
{"level":"info","ts":"2026-04-08T01:19:18.968121Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6f1fcbe50562a63a","initial-advertise-peer-urls":["https://162.253.55.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-08T01:19:18.968168Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-08T01:19:19.843374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a is starting a new election at term 1"}
{"level":"info","ts":"2026-04-08T01:19:19.843474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-08T01:19:19.84351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgPreVoteResp from 6f1fcbe50562a63a at term 1"}
{"level":"info","ts":"2026-04-08T01:19:19.843532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became candidate at term 2"}
{"level":"info","ts":"2026-04-08T01:19:19.843544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgVoteResp from 6f1fcbe50562a63a at term 2"}
{"level":"info","ts":"2026-04-08T01:19:19.843561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became leader at term 2"}
{"level":"info","ts":"2026-04-08T01:19:19.843577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6f1fcbe50562a63a elected leader 6f1fcbe50562a63a at term 2"}
{"level":"info","ts":"2026-04-08T01:19:19.846358Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6f1fcbe50562a63a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.207:2379]}","request-path":"/0/members/6f1fcbe50562a63a/attributes","cluster-id":"a9b9f04f4e8a9fba","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-08T01:19:19.846407Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T01:19:19.846426Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-08T01:19:19.846661Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-08T01:19:19.846734Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-08T01:19:19.846669Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T01:19:19.848075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-08T01:19:19.850696Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T01:19:19.85098Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T01:19:19.851084Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-08T01:19:19.852436Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.207:2379"}
{"level":"info","ts":"2026-04-08T01:19:39.600937Z","caller":"traceutil/trace.go:171","msg":"trace[165168820] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"235.733223ms","start":"2026-04-08T01:19:39.365162Z","end":"2026-04-08T01:19:39.600895Z","steps":["trace[165168820] 'process raft request'  (duration: 235.443396ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:19:39.993393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.965524ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11978059240425235116 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:406 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T01:19:39.993561Z","caller":"traceutil/trace.go:171","msg":"trace[1516342220] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:422; }","duration":"427.611893ms","start":"2026-04-08T01:19:39.565927Z","end":"2026-04-08T01:19:39.993539Z","steps":["trace[1516342220] 'read index received'  (duration: 34.697449ms)","trace[1516342220] 'applied index is now lower than readState.Index'  (duration: 392.912794ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:19:39.993646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.728375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T01:19:39.993604Z","caller":"traceutil/trace.go:171","msg":"trace[1397859313] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"628.060113ms","start":"2026-04-08T01:19:39.365502Z","end":"2026-04-08T01:19:39.993562Z","steps":["trace[1397859313] 'process raft request'  (duration: 439.112288ms)","trace[1397859313] 'compare'  (duration: 187.77922ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:19:39.993692Z","caller":"traceutil/trace.go:171","msg":"trace[40961596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:410; }","duration":"427.824317ms","start":"2026-04-08T01:19:39.565854Z","end":"2026-04-08T01:19:39.993678Z","steps":["trace[40961596] 'agreement among raft nodes before linearized reading'  (duration: 427.741505ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:19:39.993737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:19:39.565821Z","time spent":"427.906019ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-08T01:19:39.993827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:19:39.365471Z","time spent":"628.245138ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:406 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-08T01:19:51.371026Z","caller":"traceutil/trace.go:171","msg":"trace[224789351] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"150.401277ms","start":"2026-04-08T01:19:51.220594Z","end":"2026-04-08T01:19:51.370996Z","steps":["trace[224789351] 'process raft request'  (duration: 150.031199ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:19:51.371026Z","caller":"traceutil/trace.go:171","msg":"trace[1508593616] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"116.311273ms","start":"2026-04-08T01:19:51.254684Z","end":"2026-04-08T01:19:51.370995Z","steps":["trace[1508593616] 'process raft request'  (duration: 116.16871ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:19:57.535263Z","caller":"traceutil/trace.go:171","msg":"trace[316485340] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"151.197785ms","start":"2026-04-08T01:19:57.384036Z","end":"2026-04-08T01:19:57.535234Z","steps":["trace[316485340] 'process raft request'  (duration: 151.035832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:19:57.741409Z","caller":"traceutil/trace.go:171","msg":"trace[6120341] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"280.607219ms","start":"2026-04-08T01:19:57.46077Z","end":"2026-04-08T01:19:57.741377Z","steps":["trace[6120341] 'process raft request'  (duration: 279.79632ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:19:58.103242Z","caller":"traceutil/trace.go:171","msg":"trace[1212011764] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"296.156778ms","start":"2026-04-08T01:19:57.807043Z","end":"2026-04-08T01:19:58.1032Z","steps":["trace[1212011764] 'process raft request'  (duration: 262.684938ms)","trace[1212011764] 'compare'  (duration: 33.287215ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:19:58.257901Z","caller":"traceutil/trace.go:171","msg":"trace[1414784116] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"137.410178ms","start":"2026-04-08T01:19:58.120442Z","end":"2026-04-08T01:19:58.257852Z","steps":["trace[1414784116] 'process raft request'  (duration: 136.517578ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:19:58.258059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.182233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:19:58.258112Z","caller":"traceutil/trace.go:171","msg":"trace[1747598358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"127.264054ms","start":"2026-04-08T01:19:58.130833Z","end":"2026-04-08T01:19:58.258097Z","steps":["trace[1747598358] 'agreement among raft nodes before linearized reading'  (duration: 127.106761ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:19:58.257805Z","caller":"traceutil/trace.go:171","msg":"trace[537717534] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"126.918377ms","start":"2026-04-08T01:19:58.130849Z","end":"2026-04-08T01:19:58.257767Z","steps":["trace[537717534] 'read index received'  (duration: 126.021177ms)","trace[537717534] 'applied index is now lower than readState.Index'  (duration: 895.8µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:19:58.259629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.330384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-04-08T01:19:58.259685Z","caller":"traceutil/trace.go:171","msg":"trace[1543921794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"106.446796ms","start":"2026-04-08T01:19:58.153222Z","end":"2026-04-08T01:19:58.259669Z","steps":["trace[1543921794] 'agreement among raft nodes before linearized reading'  (duration: 106.1931ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:20:12.48344Z","caller":"traceutil/trace.go:171","msg":"trace[497851221] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:759; }","duration":"142.762252ms","start":"2026-04-08T01:20:12.340654Z","end":"2026-04-08T01:20:12.483416Z","steps":["trace[497851221] 'read index received'  (duration: 142.467835ms)","trace[497851221] 'applied index is now lower than readState.Index'  (duration: 293.307µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:20:12.483491Z","caller":"traceutil/trace.go:171","msg":"trace[1248191856] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"226.21435ms","start":"2026-04-08T01:20:12.25724Z","end":"2026-04-08T01:20:12.483455Z","steps":["trace[1248191856] 'process raft request'  (duration: 226.014715ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:20:12.483727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.052788ms","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-04-08T01:20:12.483824Z","caller":"traceutil/trace.go:171","msg":"trace[270419278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:737; }","duration":"143.166371ms","start":"2026-04-08T01:20:12.340638Z","end":"2026-04-08T01:20:12.483804Z","steps":["trace[270419278] 'agreement among raft nodes before linearized reading'  (duration: 142.900385ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:20:12.483842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.12932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-08T01:20:12.483952Z","caller":"traceutil/trace.go:171","msg":"trace[1815568247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:737; }","duration":"143.310453ms","start":"2026-04-08T01:20:12.34062Z","end":"2026-04-08T01:20:12.483931Z","steps":["trace[1815568247] 'agreement among raft nodes before linearized reading'  (duration: 142.996696ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:21:29.067633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.272427ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11978059240425237865 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1724 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T01:21:29.06781Z","caller":"traceutil/trace.go:171","msg":"trace[1599526993] linearizableReadLoop","detail":"{readStateIndex:1866; appliedIndex:1865; }","duration":"155.028185ms","start":"2026-04-08T01:21:28.912758Z","end":"2026-04-08T01:21:29.067787Z","steps":["trace[1599526993] 'read index received'  (duration: 72.942µs)","trace[1599526993] 'applied index is now lower than readState.Index'  (duration: 154.953473ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:21:29.067922Z","caller":"traceutil/trace.go:171","msg":"trace[154477070] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"211.683136ms","start":"2026-04-08T01:21:28.856198Z","end":"2026-04-08T01:21:29.067882Z","steps":["trace[154477070] 'process raft request'  (duration: 50.98318ms)","trace[154477070] 'compare'  (duration: 160.123974ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:21:29.068086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.325971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e42c7538-c04b-47f4-bb25-4206bf8a8270\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-08T01:21:29.068142Z","caller":"traceutil/trace.go:171","msg":"trace[1477300176] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e42c7538-c04b-47f4-bb25-4206bf8a8270; range_end:; response_count:1; response_revision:1798; }","duration":"155.437343ms","start":"2026-04-08T01:21:28.912689Z","end":"2026-04-08T01:21:29.068126Z","steps":["trace[1477300176] 'agreement among raft nodes before linearized reading'  (duration: 155.216528ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.201782Z","caller":"traceutil/trace.go:171","msg":"trace[866710686] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"124.968803ms","start":"2026-04-08T01:21:29.076784Z","end":"2026-04-08T01:21:29.201753Z","steps":["trace[866710686] 'process raft request'  (duration: 113.277583ms)","trace[866710686] 'compare'  (duration: 11.573367ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:21:29.271401Z","caller":"traceutil/trace.go:171","msg":"trace[389289542] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"194.531118ms","start":"2026-04-08T01:21:29.076851Z","end":"2026-04-08T01:21:29.271382Z","steps":["trace[389289542] 'process raft request'  (duration: 194.374435ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.271715Z","caller":"traceutil/trace.go:171","msg":"trace[416857261] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"193.068628ms","start":"2026-04-08T01:21:29.078619Z","end":"2026-04-08T01:21:29.271688Z","steps":["trace[416857261] 'process raft request'  (duration: 192.71538ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.271733Z","caller":"traceutil/trace.go:171","msg":"trace[2093469984] linearizableReadLoop","detail":"{readStateIndex:1870; appliedIndex:1866; }","duration":"165.0933ms","start":"2026-04-08T01:21:29.106609Z","end":"2026-04-08T01:21:29.271702Z","steps":["trace[2093469984] 'read index received'  (duration: 83.382373ms)","trace[2093469984] 'applied index is now lower than readState.Index'  (duration: 81.709567ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:21:29.271936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.308224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a43d0eec1f0613\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-04-08T01:21:29.271982Z","caller":"traceutil/trace.go:171","msg":"trace[610933059] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a43d0eec1f0613; range_end:; response_count:1; response_revision:1802; }","duration":"165.421317ms","start":"2026-04-08T01:21:29.106547Z","end":"2026-04-08T01:21:29.271969Z","steps":["trace[610933059] 'agreement among raft nodes before linearized reading'  (duration: 165.241733ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.271854Z","caller":"traceutil/trace.go:171","msg":"trace[115897425] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"191.904172ms","start":"2026-04-08T01:21:29.079862Z","end":"2026-04-08T01:21:29.271766Z","steps":["trace[115897425] 'process raft request'  (duration: 191.707078ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:21:29.272203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.90805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-04-08T01:21:29.272257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.727559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:569"}
{"level":"warn","ts":"2026-04-08T01:21:29.272249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.134716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:21:29.27229Z","caller":"traceutil/trace.go:171","msg":"trace[842180780] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1802; }","duration":"146.089474ms","start":"2026-04-08T01:21:29.126175Z","end":"2026-04-08T01:21:29.272265Z","steps":["trace[842180780] 'agreement among raft nodes before linearized reading'  (duration: 145.848139ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.272314Z","caller":"traceutil/trace.go:171","msg":"trace[2048339793] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1802; }","duration":"119.817401ms","start":"2026-04-08T01:21:29.152478Z","end":"2026-04-08T01:21:29.272295Z","steps":["trace[2048339793] 'agreement among raft nodes before linearized reading'  (duration: 119.637447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:29.272348Z","caller":"traceutil/trace.go:171","msg":"trace[1745995532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1802; }","duration":"140.251979ms","start":"2026-04-08T01:21:29.132062Z","end":"2026-04-08T01:21:29.272314Z","steps":["trace[1745995532] 'agreement among raft nodes before linearized reading'  (duration: 140.104346ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:42.504361Z","caller":"traceutil/trace.go:171","msg":"trace[1970585728] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"130.733726ms","start":"2026-04-08T01:21:42.373598Z","end":"2026-04-08T01:21:42.504332Z","steps":["trace[1970585728] 'read index received'  (duration: 130.48609ms)","trace[1970585728] 'applied index is now lower than readState.Index'  (duration: 246.236µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:21:42.504669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.055143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-08T01:21:42.504712Z","caller":"traceutil/trace.go:171","msg":"trace[1318892092] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"131.168855ms","start":"2026-04-08T01:21:42.373525Z","end":"2026-04-08T01:21:42.504694Z","steps":["trace[1318892092] 'agreement among raft nodes before linearized reading'  (duration: 130.956521ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:21:42.50512Z","caller":"traceutil/trace.go:171","msg":"trace[2114353512] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"152.732957ms","start":"2026-04-08T01:21:42.352375Z","end":"2026-04-08T01:21:42.505108Z","steps":["trace[2114353512] 'process raft request'  (duration: 151.787507ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:22:14.523821Z","caller":"traceutil/trace.go:171","msg":"trace[934768238] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"215.738632ms","start":"2026-04-08T01:22:14.308046Z","end":"2026-04-08T01:22:14.523784Z","steps":["trace[934768238] 'process raft request'  (duration: 215.453626ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:23:04.337742Z","caller":"traceutil/trace.go:171","msg":"trace[1906089886] linearizableReadLoop","detail":"{readStateIndex:2511; appliedIndex:2510; }","duration":"160.22307ms","start":"2026-04-08T01:23:04.177493Z","end":"2026-04-08T01:23:04.337716Z","steps":["trace[1906089886] 'read index received'  (duration: 115.239818ms)","trace[1906089886] 'applied index is now lower than readState.Index'  (duration: 44.982152ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:23:04.338064Z","caller":"traceutil/trace.go:171","msg":"trace[934695388] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"196.938685ms","start":"2026-04-08T01:23:04.141109Z","end":"2026-04-08T01:23:04.338048Z","steps":["trace[934695388] 'process raft request'  (duration: 151.682877ms)","trace[934695388] 'compare'  (duration: 44.84513ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:23:04.338552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.028907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"}
{"level":"info","ts":"2026-04-08T01:23:04.338617Z","caller":"traceutil/trace.go:171","msg":"trace[1152241234] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2422; }","duration":"161.15245ms","start":"2026-04-08T01:23:04.177447Z","end":"2026-04-08T01:23:04.3386Z","steps":["trace[1152241234] 'agreement among raft nodes before linearized reading'  (duration: 160.924905ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:23:37.582915Z","caller":"traceutil/trace.go:171","msg":"trace[95076484] transaction","detail":"{read_only:false; response_revision:2602; number_of_response:1; }","duration":"107.246945ms","start":"2026-04-08T01:23:37.475636Z","end":"2026-04-08T01:23:37.582882Z","steps":["trace[95076484] 'process raft request'  (duration: 107.045321ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:26:29.975487Z","caller":"traceutil/trace.go:171","msg":"trace[1527992684] transaction","detail":"{read_only:false; response_revision:3694; number_of_response:1; }","duration":"104.515467ms","start":"2026-04-08T01:26:29.870938Z","end":"2026-04-08T01:26:29.975454Z","steps":["trace[1527992684] 'process raft request'  (duration: 104.276072ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:27:52.605906Z","caller":"traceutil/trace.go:171","msg":"trace[510969667] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"122.795181ms","start":"2026-04-08T01:27:52.483079Z","end":"2026-04-08T01:27:52.605874Z","steps":["trace[510969667] 'process raft request'  (duration: 122.610277ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:27:52.650236Z","caller":"traceutil/trace.go:171","msg":"trace[1077701984] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"166.860202ms","start":"2026-04-08T01:27:52.48335Z","end":"2026-04-08T01:27:52.65021Z","steps":["trace[1077701984] 'process raft request'  (duration: 166.670478ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:28:04.984116Z","caller":"traceutil/trace.go:171","msg":"trace[1638144616] linearizableReadLoop","detail":"{readStateIndex:5256; appliedIndex:5255; }","duration":"314.151405ms","start":"2026-04-08T01:28:04.66993Z","end":"2026-04-08T01:28:04.984081Z","steps":["trace[1638144616] 'read index received'  (duration: 313.795258ms)","trace[1638144616] 'applied index is now lower than readState.Index'  (duration: 354.767µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:28:04.984159Z","caller":"traceutil/trace.go:171","msg":"trace[1342779272] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"496.328034ms","start":"2026-04-08T01:28:04.487793Z","end":"2026-04-08T01:28:04.984121Z","steps":["trace[1342779272] 'process raft request'  (duration: 496.045258ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:28:04.984467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.500063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-08T01:28:04.984565Z","caller":"traceutil/trace.go:171","msg":"trace[1703800334] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5068; }","duration":"314.633986ms","start":"2026-04-08T01:28:04.66991Z","end":"2026-04-08T01:28:04.984544Z","steps":["trace[1703800334] 'agreement among raft nodes before linearized reading'  (duration: 314.306789ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:28:04.984565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:28:04.487762Z","time spent":"496.61578ms","remote":"127.0.0.1:48058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":125192,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:5041 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:125155 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-04-08T01:28:04.984611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:28:04.669835Z","time spent":"314.765648ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-08T01:28:05.010857Z","caller":"traceutil/trace.go:171","msg":"trace[494601592] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"200.714243ms","start":"2026-04-08T01:28:04.810125Z","end":"2026-04-08T01:28:05.010839Z","steps":["trace[494601592] 'process raft request'  (duration: 200.613721ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:28:05.010851Z","caller":"traceutil/trace.go:171","msg":"trace[418394770] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"314.086054ms","start":"2026-04-08T01:28:04.696736Z","end":"2026-04-08T01:28:05.010822Z","steps":["trace[418394770] 'process raft request'  (duration: 313.815198ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:28:05.011097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:28:04.696697Z","time spent":"314.227477ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5029 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-08T01:28:05.011065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.79782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-04-08T01:28:05.011197Z","caller":"traceutil/trace.go:171","msg":"trace[862666086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5070; }","duration":"301.042826ms","start":"2026-04-08T01:28:04.71013Z","end":"2026-04-08T01:28:05.011173Z","steps":["trace[862666086] 'agreement among raft nodes before linearized reading'  (duration: 300.667208ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:28:05.01128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:28:04.710107Z","time spent":"301.162228ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-08T01:28:05.365949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.049271ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11978059240425246060 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached\" mod_revision:5044 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached\" value_size:626 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-08T01:28:05.366424Z","caller":"traceutil/trace.go:171","msg":"trace[34062595] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"203.672587ms","start":"2026-04-08T01:28:05.162717Z","end":"2026-04-08T01:28:05.366389Z","steps":["trace[34062595] 'process raft request'  (duration: 77.062455ms)","trace[34062595] 'compare'  (duration: 125.846506ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:28:05.366652Z","caller":"traceutil/trace.go:171","msg":"trace[1893815006] transaction","detail":"{read_only:false; response_revision:5083; number_of_response:1; }","duration":"107.662048ms","start":"2026-04-08T01:28:05.258966Z","end":"2026-04-08T01:28:05.366628Z","steps":["trace[1893815006] 'process raft request'  (duration: 107.603897ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:28:05.367083Z","caller":"traceutil/trace.go:171","msg":"trace[104063547] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"204.157738ms","start":"2026-04-08T01:28:05.1629Z","end":"2026-04-08T01:28:05.367058Z","steps":["trace[104063547] 'process raft request'  (duration: 203.172536ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:28:05.367066Z","caller":"traceutil/trace.go:171","msg":"trace[481506446] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"197.635629ms","start":"2026-04-08T01:28:05.169375Z","end":"2026-04-08T01:28:05.36701Z","steps":["trace[481506446] 'process raft request'  (duration: 197.078006ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:28:05.367148Z","caller":"traceutil/trace.go:171","msg":"trace[1290360318] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"204.191778ms","start":"2026-04-08T01:28:05.162936Z","end":"2026-04-08T01:28:05.367128Z","steps":["trace[1290360318] 'process raft request'  (duration: 203.461252ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:29:19.877938Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2826}
{"level":"info","ts":"2026-04-08T01:29:19.954208Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2826,"took":"73.116335ms","hash":2758254807,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":32751616,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-08T01:29:19.954291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2758254807,"revision":2826,"compact-revision":-1}
{"level":"info","ts":"2026-04-08T01:34:04.77546Z","caller":"traceutil/trace.go:171","msg":"trace[1386677438] linearizableReadLoop","detail":"{readStateIndex:8280; appliedIndex:8279; }","duration":"114.880692ms","start":"2026-04-08T01:34:04.660541Z","end":"2026-04-08T01:34:04.775422Z","steps":["trace[1386677438] 'read index received'  (duration: 114.575515ms)","trace[1386677438] 'applied index is now lower than readState.Index'  (duration: 303.707µs)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:34:04.775601Z","caller":"traceutil/trace.go:171","msg":"trace[44444831] transaction","detail":"{read_only:false; response_revision:8004; number_of_response:1; }","duration":"247.893849ms","start":"2026-04-08T01:34:04.527665Z","end":"2026-04-08T01:34:04.775559Z","steps":["trace[44444831] 'process raft request'  (duration: 247.455679ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:04.775699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.129547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:34:04.775797Z","caller":"traceutil/trace.go:171","msg":"trace[1352190756] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:8004; }","duration":"115.311601ms","start":"2026-04-08T01:34:04.660463Z","end":"2026-04-08T01:34:04.775775Z","steps":["trace[1352190756] 'agreement among raft nodes before linearized reading'  (duration: 115.110527ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:16.410004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.952207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:34:16.410107Z","caller":"traceutil/trace.go:171","msg":"trace[577248490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8064; }","duration":"277.11022ms","start":"2026-04-08T01:34:16.13297Z","end":"2026-04-08T01:34:16.41008Z","steps":["trace[577248490] 'range keys from in-memory index tree'  (duration: 276.832225ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:17.373424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.284716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-08T01:34:17.37349Z","caller":"traceutil/trace.go:171","msg":"trace[403026266] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8067; }","duration":"239.401848ms","start":"2026-04-08T01:34:17.134076Z","end":"2026-04-08T01:34:17.373478Z","steps":["trace[403026266] 'range keys from in-memory index tree'  (duration: 239.062171ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:17.373651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.25056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:34:17.373672Z","caller":"traceutil/trace.go:171","msg":"trace[5113710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8067; }","duration":"243.311322ms","start":"2026-04-08T01:34:17.130356Z","end":"2026-04-08T01:34:17.373667Z","steps":["trace[5113710] 'range keys from in-memory index tree'  (duration: 243.153208ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:17.373818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.027352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-08T01:34:17.374777Z","caller":"traceutil/trace.go:171","msg":"trace[306518524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8067; }","duration":"224.649775ms","start":"2026-04-08T01:34:17.149728Z","end":"2026-04-08T01:34:17.374378Z","steps":["trace[306518524] 'range keys from in-memory index tree'  (duration: 223.816407ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:17.919609Z","caller":"traceutil/trace.go:171","msg":"trace[126418954] linearizableReadLoop","detail":"{readStateIndex:8352; appliedIndex:8351; }","duration":"108.983306ms","start":"2026-04-08T01:34:17.810574Z","end":"2026-04-08T01:34:17.919557Z","steps":["trace[126418954] 'read index received'  (duration: 9.795599ms)","trace[126418954] 'applied index is now lower than readState.Index'  (duration: 99.185867ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:34:17.919621Z","caller":"traceutil/trace.go:171","msg":"trace[305779209] transaction","detail":"{read_only:false; response_revision:8074; number_of_response:1; }","duration":"203.044555ms","start":"2026-04-08T01:34:17.71653Z","end":"2026-04-08T01:34:17.919575Z","steps":["trace[305779209] 'process raft request'  (duration: 103.869638ms)","trace[305779209] 'compare'  (duration: 98.876891ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:34:17.919966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.344704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-td9hw\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-04-08T01:34:17.920038Z","caller":"traceutil/trace.go:171","msg":"trace[1952719424] range","detail":"{range_begin:/registry/pods/openstack/keepalived-td9hw; range_end:; response_count:1; response_revision:8074; }","duration":"109.495227ms","start":"2026-04-08T01:34:17.810524Z","end":"2026-04-08T01:34:17.920019Z","steps":["trace[1952719424] 'agreement among raft nodes before linearized reading'  (duration: 109.17462ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:19.885494Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5888}
{"level":"info","ts":"2026-04-08T01:34:19.968788Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5888,"took":"80.702355ms","hash":548510437,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":26218496,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-08T01:34:19.96886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":548510437,"revision":5888,"compact-revision":2826}
{"level":"warn","ts":"2026-04-08T01:34:44.344273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.905587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-04-08T01:34:44.344346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-td9hw\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-04-08T01:34:44.344383Z","caller":"traceutil/trace.go:171","msg":"trace[1578817102] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8266; }","duration":"254.088781ms","start":"2026-04-08T01:34:44.09027Z","end":"2026-04-08T01:34:44.344359Z","steps":["trace[1578817102] 'range keys from in-memory index tree'  (duration: 253.667752ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:44.344457Z","caller":"traceutil/trace.go:171","msg":"trace[447265469] range","detail":"{range_begin:/registry/pods/openstack/keepalived-td9hw; range_end:; response_count:1; response_revision:8266; }","duration":"235.385223ms","start":"2026-04-08T01:34:44.109025Z","end":"2026-04-08T01:34:44.34441Z","steps":["trace[447265469] 'range keys from in-memory index tree'  (duration: 235.072637ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:44.344569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.569445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-08T01:34:44.34468Z","caller":"traceutil/trace.go:171","msg":"trace[1223433149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8266; }","duration":"210.717569ms","start":"2026-04-08T01:34:44.133936Z","end":"2026-04-08T01:34:44.344654Z","steps":["trace[1223433149] 'range keys from in-memory index tree'  (duration: 210.494954ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:44.344709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.221138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-08T01:34:44.344829Z","caller":"traceutil/trace.go:171","msg":"trace[553120900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8266; }","duration":"114.379982ms","start":"2026-04-08T01:34:44.230416Z","end":"2026-04-08T01:34:44.344796Z","steps":["trace[553120900] 'range keys from in-memory index tree'  (duration: 113.988483ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:57.87533Z","caller":"traceutil/trace.go:171","msg":"trace[839088559] transaction","detail":"{read_only:false; response_revision:8378; number_of_response:1; }","duration":"214.711148ms","start":"2026-04-08T01:34:57.660577Z","end":"2026-04-08T01:34:57.875289Z","steps":["trace[839088559] 'process raft request'  (duration: 214.491604ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:58.03111Z","caller":"traceutil/trace.go:171","msg":"trace[1793096738] transaction","detail":"{read_only:false; response_revision:8379; number_of_response:1; }","duration":"370.249917ms","start":"2026-04-08T01:34:57.660817Z","end":"2026-04-08T01:34:58.031066Z","steps":["trace[1793096738] 'process raft request'  (duration: 369.93785ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:58.031252Z","caller":"traceutil/trace.go:171","msg":"trace[1663505916] transaction","detail":"{read_only:false; response_revision:8380; number_of_response:1; }","duration":"249.740823ms","start":"2026-04-08T01:34:57.781457Z","end":"2026-04-08T01:34:58.031198Z","steps":["trace[1663505916] 'process raft request'  (duration: 249.474157ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:58.031324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.105101ms","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-04-08T01:34:58.031373Z","caller":"traceutil/trace.go:171","msg":"trace[1076884766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8381; }","duration":"290.180273ms","start":"2026-04-08T01:34:57.741179Z","end":"2026-04-08T01:34:58.031359Z","steps":["trace[1076884766] 'agreement among raft nodes before linearized reading'  (duration: 289.99644ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:58.031314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:34:57.660794Z","time spent":"370.41471ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8356 > 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-04-08T01:34:58.031109Z","caller":"traceutil/trace.go:171","msg":"trace[1570164624] linearizableReadLoop","detail":"{readStateIndex:8671; appliedIndex:8669; }","duration":"289.871417ms","start":"2026-04-08T01:34:57.741217Z","end":"2026-04-08T01:34:58.031089Z","steps":["trace[1570164624] 'read index received'  (duration: 133.860298ms)","trace[1570164624] 'applied index is now lower than readState.Index'  (duration: 156.009889ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:34:58.031548Z","caller":"traceutil/trace.go:171","msg":"trace[2002009923] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"239.70302ms","start":"2026-04-08T01:34:57.791772Z","end":"2026-04-08T01:34:58.031475Z","steps":["trace[2002009923] 'process raft request'  (duration: 239.267071ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:58.032008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.910494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-08T01:34:58.032034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.00699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-bztqg\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-04-08T01:34:58.032078Z","caller":"traceutil/trace.go:171","msg":"trace[1351397468] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:8381; }","duration":"170.086078ms","start":"2026-04-08T01:34:57.861978Z","end":"2026-04-08T01:34:58.032064Z","steps":["trace[1351397468] 'agreement among raft nodes before linearized reading'  (duration: 169.883164ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:58.0321Z","caller":"traceutil/trace.go:171","msg":"trace[627324036] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-bztqg; range_end:; response_count:1; response_revision:8381; }","duration":"251.072921ms","start":"2026-04-08T01:34:57.781008Z","end":"2026-04-08T01:34:58.032081Z","steps":["trace[627324036] 'agreement among raft nodes before linearized reading'  (duration: 250.824026ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:34:58.032014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.996117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-04-08T01:34:58.032122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.260523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-04-08T01:34:58.032171Z","caller":"traceutil/trace.go:171","msg":"trace[74670563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8381; }","duration":"108.234173ms","start":"2026-04-08T01:34:57.923924Z","end":"2026-04-08T01:34:58.032158Z","steps":["trace[74670563] 'agreement among raft nodes before linearized reading'  (duration: 107.951407ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:58.032217Z","caller":"traceutil/trace.go:171","msg":"trace[1252098206] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8381; }","duration":"108.429167ms","start":"2026-04-08T01:34:57.92376Z","end":"2026-04-08T01:34:58.032189Z","steps":["trace[1252098206] 'agreement among raft nodes before linearized reading'  (duration: 108.08827ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:58.893001Z","caller":"traceutil/trace.go:171","msg":"trace[760851993] linearizableReadLoop","detail":"{readStateIndex:8679; appliedIndex:8678; }","duration":"222.439642ms","start":"2026-04-08T01:34:58.670525Z","end":"2026-04-08T01:34:58.892965Z","steps":["trace[760851993] 'read index received'  (duration: 193.927746ms)","trace[760851993] 'applied index is now lower than readState.Index'  (duration: 28.509586ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-08T01:34:58.893346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.802149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"}
{"level":"info","ts":"2026-04-08T01:34:58.893462Z","caller":"traceutil/trace.go:171","msg":"trace[126185426] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8386; }","duration":"222.955632ms","start":"2026-04-08T01:34:58.670466Z","end":"2026-04-08T01:34:58.893422Z","steps":["trace[126185426] 'agreement among raft nodes before linearized reading'  (duration: 222.599515ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:34:59.436584Z","caller":"traceutil/trace.go:171","msg":"trace[1963119857] transaction","detail":"{read_only:false; response_revision:8391; number_of_response:1; }","duration":"109.99899ms","start":"2026-04-08T01:34:59.326556Z","end":"2026-04-08T01:34:59.436555Z","steps":["trace[1963119857] 'process raft request'  (duration: 109.729344ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:35:59.287556Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244d.wal"}
{"level":"info","ts":"2026-04-08T01:36:07.092768Z","caller":"traceutil/trace.go:171","msg":"trace[227860534] transaction","detail":"{read_only:false; response_revision:9029; number_of_response:1; }","duration":"194.370503ms","start":"2026-04-08T01:36:06.898368Z","end":"2026-04-08T01:36:07.092738Z","steps":["trace[227860534] 'process raft request'  (duration: 194.148699ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:36:07.110346Z","caller":"traceutil/trace.go:171","msg":"trace[48533923] linearizableReadLoop","detail":"{readStateIndex:9341; appliedIndex:9339; }","duration":"129.330195ms","start":"2026-04-08T01:36:06.980986Z","end":"2026-04-08T01:36:07.110317Z","steps":["trace[48533923] 'read index received'  (duration: 111.620649ms)","trace[48533923] 'applied index is now lower than readState.Index'  (duration: 17.708536ms)"],"step_count":2}
{"level":"info","ts":"2026-04-08T01:36:07.110386Z","caller":"traceutil/trace.go:171","msg":"trace[485734548] transaction","detail":"{read_only:false; response_revision:9030; number_of_response:1; }","duration":"210.541547ms","start":"2026-04-08T01:36:06.89982Z","end":"2026-04-08T01:36:07.110361Z","steps":["trace[485734548] 'process raft request'  (duration: 210.265971ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-08T01:36:07.110586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.58068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-td9hw\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-04-08T01:36:07.110629Z","caller":"traceutil/trace.go:171","msg":"trace[683909765] range","detail":"{range_begin:/registry/pods/openstack/keepalived-td9hw; range_end:; response_count:1; response_revision:9030; }","duration":"129.676572ms","start":"2026-04-08T01:36:06.980942Z","end":"2026-04-08T01:36:07.110618Z","steps":["trace[683909765] 'agreement among raft nodes before linearized reading'  (duration: 129.484668ms)"],"step_count":1}
{"level":"info","ts":"2026-04-08T01:37:24.369527Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6f1fcbe50562a63a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-08T01:37:24.374195Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-08T01:37:24.374277Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-08T01:39:19.895422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8090}
{"level":"info","ts":"2026-04-08T01:39:19.966804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8090,"took":"68.314789ms","hash":1972353862,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":28762112,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-04-08T01:39:19.966897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1972353862,"revision":8090,"compact-revision":5888}
{"level":"info","ts":"2026-04-08T01:44:19.902226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10518}
{"level":"info","ts":"2026-04-08T01:44:19.979475Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10518,"took":"74.769951ms","hash":3319658323,"current-db-size-bytes":57618432,"current-db-size":"58 MB","current-db-size-in-use-bytes":19972096,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-08T01:44:19.979557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3319658323,"revision":10518,"compact-revision":8090}