{"level":"warn","ts":"2026-10-09T02:11:17.101842Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:11:17.101939Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.10: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.10:2380","--initial-cluster=instance=https://162.253.55.10:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.10:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.10: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-10-09T02:11:17.102013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:11:17.102027Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.10:2380"]} {"level":"info","ts":"2026-10-09T02:11:17.102048Z","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-10-09T02:11:17.102814Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"]} {"level":"info","ts":"2026-10-09T02:11:17.102911Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.10:2380"],"listen-peer-urls":["https://162.253.55.10:2380"],"advertise-client-urls":["https://162.253.55.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.10: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-10-09T02:11:17.108023Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.864938ms"} {"level":"info","ts":"2026-10-09T02:11:17.122733Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"373d5d49ce4adaff","cluster-id":"467836e907a15d60"} {"level":"info","ts":"2026-10-09T02:11:17.122822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:11:17.122852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became follower at term 0"} {"level":"info","ts":"2026-10-09T02:11:17.122866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 373d5d49ce4adaff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:11:17.122876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became follower at term 1"} {"level":"info","ts":"2026-10-09T02:11:17.122923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=(3980440217240394495)"} {"level":"warn","ts":"2026-10-09T02:11:17.130409Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:11:17.131786Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:11:17.133131Z","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-10-09T02:11:17.137869Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"373d5d49ce4adaff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:11:17.138403Z","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-10-09T02:11:17.138484Z","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-10-09T02:11:17.138495Z","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-10-09T02:11:17.13852Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"373d5d49ce4adaff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:11:17.139461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=(3980440217240394495)"} {"level":"info","ts":"2026-10-09T02:11:17.139827Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"467836e907a15d60","local-member-id":"373d5d49ce4adaff","added-peer-id":"373d5d49ce4adaff","added-peer-peer-urls":["https://162.253.55.10:2380"]} {"level":"info","ts":"2026-10-09T02:11:17.141612Z","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-10-09T02:11:17.141729Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.10:2380"} {"level":"info","ts":"2026-10-09T02:11:17.141769Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.10:2380"} {"level":"info","ts":"2026-10-09T02:11:17.14189Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"373d5d49ce4adaff","initial-advertise-peer-urls":["https://162.253.55.10:2380"],"listen-peer-urls":["https://162.253.55.10:2380"],"advertise-client-urls":["https://162.253.55.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:11:17.141925Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:11:17.824165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:11:17.824283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:11:17.824341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff received MsgPreVoteResp from 373d5d49ce4adaff at term 1"} {"level":"info","ts":"2026-10-09T02:11:17.824374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:11:17.8244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff received MsgVoteResp from 373d5d49ce4adaff at term 2"} {"level":"info","ts":"2026-10-09T02:11:17.824422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became leader at term 2"} {"level":"info","ts":"2026-10-09T02:11:17.824448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 373d5d49ce4adaff elected leader 373d5d49ce4adaff at term 2"} {"level":"info","ts":"2026-10-09T02:11:17.82691Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:11:17.827917Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"373d5d49ce4adaff","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.10:2379]}","request-path":"/0/members/373d5d49ce4adaff/attributes","cluster-id":"467836e907a15d60","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:11:17.828004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:11:17.828074Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:11:17.82817Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:11:17.828214Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:11:17.828697Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"467836e907a15d60","local-member-id":"373d5d49ce4adaff","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:11:17.8288Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:11:17.828818Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:11:17.829768Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.10:2379"} {"level":"info","ts":"2026-10-09T02:11:17.830643Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T02:12:02.065304Z","caller":"traceutil/trace.go:171","msg":"trace[1455935762] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"150.218821ms","start":"2026-10-09T02:12:01.91504Z","end":"2026-10-09T02:12:02.065259Z","steps":["trace[1455935762] 'process raft request' (duration: 132.943493ms)","trace[1455935762] 'compare' (duration: 16.97765ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:12:02.071513Z","caller":"traceutil/trace.go:171","msg":"trace[518314469] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"154.492785ms","start":"2026-10-09T02:12:01.916996Z","end":"2026-10-09T02:12:02.071489Z","steps":["trace[518314469] 'process raft request' (duration: 154.140745ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:02.071689Z","caller":"traceutil/trace.go:171","msg":"trace[471113117] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:557; }","duration":"141.904871ms","start":"2026-10-09T02:12:01.929774Z","end":"2026-10-09T02:12:02.071679Z","steps":["trace[471113117] 'read index received' (duration: 118.251489ms)","trace[471113117] 'applied index is now lower than readState.Index' (duration: 23.652482ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:12:02.071842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.045675ms","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-10-09T02:12:02.071931Z","caller":"traceutil/trace.go:171","msg":"trace[177518084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"142.173949ms","start":"2026-10-09T02:12:01.929741Z","end":"2026-10-09T02:12:02.071915Z","steps":["trace[177518084] 'agreement among raft nodes before linearized reading' (duration: 141.976003ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:02.072309Z","caller":"traceutil/trace.go:171","msg":"trace[1557005009] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"107.464888ms","start":"2026-10-09T02:12:01.964833Z","end":"2026-10-09T02:12:02.072298Z","steps":["trace[1557005009] 'process raft request' (duration: 106.577692ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:06.804089Z","caller":"traceutil/trace.go:171","msg":"trace[1507419124] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"137.728355ms","start":"2026-10-09T02:12:06.666334Z","end":"2026-10-09T02:12:06.804062Z","steps":["trace[1507419124] 'process raft request' (duration: 136.367145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:12:08.41047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.236055ms","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-10-09T02:12:08.410571Z","caller":"traceutil/trace.go:171","msg":"trace[1049595164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"161.38557ms","start":"2026-10-09T02:12:08.249164Z","end":"2026-10-09T02:12:08.41055Z","steps":["trace[1049595164] 'range keys from in-memory index tree' (duration: 160.974237ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:08.477304Z","caller":"traceutil/trace.go:171","msg":"trace[544213244] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"178.627607ms","start":"2026-10-09T02:12:08.29865Z","end":"2026-10-09T02:12:08.477278Z","steps":["trace[544213244] 'process raft request' (duration: 177.135794ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:08.980462Z","caller":"traceutil/trace.go:171","msg":"trace[1336375533] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"424.982561ms","start":"2026-10-09T02:12:08.555447Z","end":"2026-10-09T02:12:08.980429Z","steps":["trace[1336375533] 'process raft request' (duration: 424.854477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:12:08.980911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:12:08.555357Z","time spent":"425.169575ms","remote":"127.0.0.1:38414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:12:23.32949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.463607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-09T02:12:23.329589Z","caller":"traceutil/trace.go:171","msg":"trace[1161257688] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:771; }","duration":"110.627602ms","start":"2026-10-09T02:12:23.218932Z","end":"2026-10-09T02:12:23.329559Z","steps":["trace[1161257688] 'count revisions from in-memory index tree' (duration: 110.243071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:12:23.32967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.307664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-482s2\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-09T02:12:23.329762Z","caller":"traceutil/trace.go:171","msg":"trace[1819535750] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-482s2; range_end:; response_count:1; response_revision:771; }","duration":"147.407386ms","start":"2026-10-09T02:12:23.182338Z","end":"2026-10-09T02:12:23.329745Z","steps":["trace[1819535750] 'range keys from in-memory index tree' (duration: 147.086257ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:12:53.789763Z","caller":"traceutil/trace.go:171","msg":"trace[1058700684] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"192.879918ms","start":"2026-10-09T02:12:53.596855Z","end":"2026-10-09T02:12:53.789734Z","steps":["trace[1058700684] 'process raft request' (duration: 192.713026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:13:41.698596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.364076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-09T02:13:41.698682Z","caller":"traceutil/trace.go:171","msg":"trace[1155761841] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1840; }","duration":"277.493219ms","start":"2026-10-09T02:13:41.421166Z","end":"2026-10-09T02:13:41.69866Z","steps":["trace[1155761841] 'range keys from in-memory index tree' (duration: 277.208073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:13:41.69875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.538762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d8c94a6-c5b8-4817-9968-0457cfcf46f5\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-09T02:13:41.698795Z","caller":"traceutil/trace.go:171","msg":"trace[1144494499] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d8c94a6-c5b8-4817-9968-0457cfcf46f5; range_end:; response_count:1; response_revision:1840; }","duration":"326.606634ms","start":"2026-10-09T02:13:41.37217Z","end":"2026-10-09T02:13:41.698777Z","steps":["trace[1144494499] 'range keys from in-memory index tree' (duration: 326.38384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:13:41.69866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.462618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d8c94a6-c5b8-4817-9968-0457cfcf46f5\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-10-09T02:13:41.698829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:13:41.37215Z","time spent":"326.671615ms","remote":"127.0.0.1:38112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d8c94a6-c5b8-4817-9968-0457cfcf46f5\" "} {"level":"info","ts":"2026-10-09T02:13:41.698848Z","caller":"traceutil/trace.go:171","msg":"trace[1413859084] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d8c94a6-c5b8-4817-9968-0457cfcf46f5; range_end:; response_count:1; response_revision:1840; }","duration":"130.719423ms","start":"2026-10-09T02:13:41.568106Z","end":"2026-10-09T02:13:41.698826Z","steps":["trace[1413859084] 'range keys from in-memory index tree' (duration: 130.352206ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:14:10.57604Z","caller":"traceutil/trace.go:171","msg":"trace[1111428540] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2137; }","duration":"203.57011ms","start":"2026-10-09T02:14:10.372424Z","end":"2026-10-09T02:14:10.575994Z","steps":["trace[1111428540] 'read index received' (duration: 203.428107ms)","trace[1111428540] 'applied index is now lower than readState.Index' (duration: 140.853µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:14:10.576132Z","caller":"traceutil/trace.go:171","msg":"trace[2125024682] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"255.299393ms","start":"2026-10-09T02:14:10.320802Z","end":"2026-10-09T02:14:10.576102Z","steps":["trace[2125024682] 'process raft request' (duration: 255.063148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:14:10.57624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.797095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-10-09T02:14:10.576278Z","caller":"traceutil/trace.go:171","msg":"trace[531691391] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2056; }","duration":"203.890897ms","start":"2026-10-09T02:14:10.372377Z","end":"2026-10-09T02:14:10.576268Z","steps":["trace[531691391] 'agreement among raft nodes before linearized reading' (duration: 203.726914ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:15:51.381679Z","caller":"traceutil/trace.go:171","msg":"trace[69246860] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"147.900884ms","start":"2026-10-09T02:15:51.233744Z","end":"2026-10-09T02:15:51.381644Z","steps":["trace[69246860] 'process raft request' (duration: 124.732651ms)","trace[69246860] 'compare' (duration: 22.442825ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:15:51.534121Z","caller":"traceutil/trace.go:171","msg":"trace[708773088] transaction","detail":"{read_only:false; response_revision:2707; number_of_response:1; }","duration":"114.292663ms","start":"2026-10-09T02:15:51.419798Z","end":"2026-10-09T02:15:51.534091Z","steps":["trace[708773088] 'process raft request' (duration: 62.791361ms)","trace[708773088] 'compare' (duration: 51.366399ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:16.611462Z","caller":"traceutil/trace.go:171","msg":"trace[1125260225] linearizableReadLoop","detail":"{readStateIndex:4808; appliedIndex:4807; }","duration":"109.161389ms","start":"2026-10-09T02:20:16.502277Z","end":"2026-10-09T02:20:16.611438Z","steps":["trace[1125260225] 'read index received' (duration: 109.071586ms)","trace[1125260225] 'applied index is now lower than readState.Index' (duration: 88.873µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:20:16.611691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.402666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-09T02:20:16.611729Z","caller":"traceutil/trace.go:171","msg":"trace[2011869091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4625; }","duration":"109.477658ms","start":"2026-10-09T02:20:16.502242Z","end":"2026-10-09T02:20:16.61172Z","steps":["trace[2011869091] 'agreement among raft nodes before linearized reading' (duration: 109.295473ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:16.611832Z","caller":"traceutil/trace.go:171","msg":"trace[992213698] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"113.740784ms","start":"2026-10-09T02:20:16.49807Z","end":"2026-10-09T02:20:16.611811Z","steps":["trace[992213698] 'process raft request' (duration: 113.198699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:20.006447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.056763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362732"} {"level":"info","ts":"2026-10-09T02:20:20.006499Z","caller":"traceutil/trace.go:171","msg":"trace[620394316] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4731; }","duration":"107.147466ms","start":"2026-10-09T02:20:19.89934Z","end":"2026-10-09T02:20:20.006488Z","steps":["trace[620394316] 'range keys from in-memory index tree' (duration: 106.486878ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:27.745563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.271359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-09T02:20:27.745627Z","caller":"traceutil/trace.go:171","msg":"trace[421043259] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4921; }","duration":"134.379122ms","start":"2026-10-09T02:20:27.611233Z","end":"2026-10-09T02:20:27.745612Z","steps":["trace[421043259] 'range keys from in-memory index tree' (duration: 134.062593ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:40.751515Z","caller":"traceutil/trace.go:171","msg":"trace[1746517391] linearizableReadLoop","detail":"{readStateIndex:5277; appliedIndex:5276; }","duration":"120.919358ms","start":"2026-10-09T02:20:40.630568Z","end":"2026-10-09T02:20:40.751487Z","steps":["trace[1746517391] 'read index received' (duration: 120.860346ms)","trace[1746517391] 'applied index is now lower than readState.Index' (duration: 57.622µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:40.751658Z","caller":"traceutil/trace.go:171","msg":"trace[1091900812] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"185.508095ms","start":"2026-10-09T02:20:40.566111Z","end":"2026-10-09T02:20:40.751619Z","steps":["trace[1091900812] 'process raft request' (duration: 185.220397ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:40.751778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.189165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-10-09T02:20:40.751821Z","caller":"traceutil/trace.go:171","msg":"trace[1691079182] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5080; }","duration":"121.278847ms","start":"2026-10-09T02:20:40.630528Z","end":"2026-10-09T02:20:40.751807Z","steps":["trace[1691079182] 'agreement among raft nodes before linearized reading' (duration: 121.086182ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:40.983793Z","caller":"traceutil/trace.go:171","msg":"trace[529040328] linearizableReadLoop","detail":"{readStateIndex:5278; appliedIndex:5277; }","duration":"232.175732ms","start":"2026-10-09T02:20:40.751586Z","end":"2026-10-09T02:20:40.983762Z","steps":["trace[529040328] 'read index received' (duration: 232.143641ms)","trace[529040328] 'applied index is now lower than readState.Index' (duration: 30.751µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:20:40.983934Z","caller":"traceutil/trace.go:171","msg":"trace[403003800] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"264.089905ms","start":"2026-10-09T02:20:40.719824Z","end":"2026-10-09T02:20:40.983914Z","steps":["trace[403003800] 'process raft request' (duration: 263.753656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:40.984142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.288565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-09T02:20:40.984215Z","caller":"traceutil/trace.go:171","msg":"trace[1747260973] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5081; }","duration":"334.400288ms","start":"2026-10-09T02:20:40.649795Z","end":"2026-10-09T02:20:40.984196Z","steps":["trace[1747260973] 'agreement among raft nodes before linearized reading' (duration: 334.208112ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:40.984253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:20:40.649779Z","time spent":"334.46602ms","remote":"127.0.0.1:38096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-10-09T02:20:41.001111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.73813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-09T02:20:41.001195Z","caller":"traceutil/trace.go:171","msg":"trace[1914301292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5082; }","duration":"242.850824ms","start":"2026-10-09T02:20:40.758321Z","end":"2026-10-09T02:20:41.001171Z","steps":["trace[1914301292] 'agreement among raft nodes before linearized reading' (duration: 242.642618ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:41.001516Z","caller":"traceutil/trace.go:171","msg":"trace[116312660] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"238.170505ms","start":"2026-10-09T02:20:40.763325Z","end":"2026-10-09T02:20:41.001495Z","steps":["trace[116312660] 'process raft request' (duration: 237.428035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:20:41.001743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.904949ms","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-10-09T02:20:41.001797Z","caller":"traceutil/trace.go:171","msg":"trace[755844776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5082; }","duration":"177.005592ms","start":"2026-10-09T02:20:40.824778Z","end":"2026-10-09T02:20:41.001783Z","steps":["trace[755844776] 'agreement among raft nodes before linearized reading' (duration: 176.867618ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:21:17.23804Z","caller":"traceutil/trace.go:171","msg":"trace[692796908] linearizableReadLoop","detail":"{readStateIndex:5629; appliedIndex:5628; }","duration":"135.031894ms","start":"2026-10-09T02:21:17.102984Z","end":"2026-10-09T02:21:17.238016Z","steps":["trace[692796908] 'read index received' (duration: 134.848829ms)","trace[692796908] 'applied index is now lower than readState.Index' (duration: 181.945µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:21:17.238188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.180028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:21:17.238221Z","caller":"traceutil/trace.go:171","msg":"trace[1815817284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5423; }","duration":"135.26202ms","start":"2026-10-09T02:21:17.102947Z","end":"2026-10-09T02:21:17.238209Z","steps":["trace[1815817284] 'agreement among raft nodes before linearized reading' (duration: 135.163837ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:21:17.238183Z","caller":"traceutil/trace.go:171","msg":"trace[2123477916] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"155.873856ms","start":"2026-10-09T02:21:17.082271Z","end":"2026-10-09T02:21:17.238144Z","steps":["trace[2123477916] 'process raft request' (duration: 155.574138ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:21:17.248234Z","caller":"traceutil/trace.go:171","msg":"trace[759737109] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"122.094699ms","start":"2026-10-09T02:21:17.126083Z","end":"2026-10-09T02:21:17.248178Z","steps":["trace[759737109] 'process raft request' (duration: 121.947995ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:21:17.91015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2849} {"level":"info","ts":"2026-10-09T02:21:17.993859Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2849,"took":"82.04452ms","hash":3278582174,"current-db-size-bytes":53854208,"current-db-size":"54 MB","current-db-size-in-use-bytes":29003776,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-09T02:21:17.993945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3278582174,"revision":2849,"compact-revision":-1} {"level":"info","ts":"2026-10-09T02:26:17.915396Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5431} {"level":"info","ts":"2026-10-09T02:26:17.999607Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5431,"took":"82.858122ms","hash":2759576711,"current-db-size-bytes":53854208,"current-db-size":"54 MB","current-db-size-in-use-bytes":18722816,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-09T02:26:17.999678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2759576711,"revision":5431,"compact-revision":2849}