I0217 06:35:35.818599 1 options.go:220] external host was not specified, using 199.204.45.89 I0217 06:35:35.819404 1 server.go:148] Version: v1.28.13 I0217 06:35:35.819480 1 server.go:150] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0217 06:35:36.330603 1 shared_informer.go:311] Waiting for caches to sync for node_authorizer I0217 06:35:36.349820 1 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,RuntimeClass,DefaultIngressClass,MutatingAdmissionWebhook. I0217 06:35:36.349830 1 plugins.go:161] Loaded 13 validating admission controller(s) successfully in the following order: LimitRanger,ServiceAccount,PodSecurity,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,ClusterTrustBundleAttest,CertificateSubjectRestriction,ValidatingAdmissionPolicy,ValidatingAdmissionWebhook,ResourceQuota. I0217 06:35:36.350041 1 instance.go:298] Using reconciler: lease I0217 06:35:36.421723 1 handler.go:275] Adding GroupVersion apiextensions.k8s.io v1 to ResourceManager W0217 06:35:36.421737 1 genericapiserver.go:744] Skipping API apiextensions.k8s.io/v1beta1 because it has no resources. I0217 06:35:36.898712 1 handler.go:275] Adding GroupVersion v1 to ResourceManager I0217 06:35:36.899158 1 instance.go:709] API group "internal.apiserver.k8s.io" is not enabled, skipping. I0217 06:35:37.395521 1 instance.go:709] API group "resource.k8s.io" is not enabled, skipping. I0217 06:35:37.418765 1 handler.go:275] Adding GroupVersion authentication.k8s.io v1 to ResourceManager W0217 06:35:37.418788 1 genericapiserver.go:744] Skipping API authentication.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.418794 1 genericapiserver.go:744] Skipping API authentication.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.419342 1 handler.go:275] Adding GroupVersion authorization.k8s.io v1 to ResourceManager W0217 06:35:37.419351 1 genericapiserver.go:744] Skipping API authorization.k8s.io/v1beta1 because it has no resources. I0217 06:35:37.420446 1 handler.go:275] Adding GroupVersion autoscaling v2 to ResourceManager I0217 06:35:37.421453 1 handler.go:275] Adding GroupVersion autoscaling v1 to ResourceManager W0217 06:35:37.421463 1 genericapiserver.go:744] Skipping API autoscaling/v2beta1 because it has no resources. W0217 06:35:37.421467 1 genericapiserver.go:744] Skipping API autoscaling/v2beta2 because it has no resources. I0217 06:35:37.423385 1 handler.go:275] Adding GroupVersion batch v1 to ResourceManager W0217 06:35:37.423397 1 genericapiserver.go:744] Skipping API batch/v1beta1 because it has no resources. I0217 06:35:37.424527 1 handler.go:275] Adding GroupVersion certificates.k8s.io v1 to ResourceManager W0217 06:35:37.424537 1 genericapiserver.go:744] Skipping API certificates.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.424541 1 genericapiserver.go:744] Skipping API certificates.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.425095 1 handler.go:275] Adding GroupVersion coordination.k8s.io v1 to ResourceManager W0217 06:35:37.425106 1 genericapiserver.go:744] Skipping API coordination.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.425151 1 genericapiserver.go:744] Skipping API discovery.k8s.io/v1beta1 because it has no resources. I0217 06:35:37.425862 1 handler.go:275] Adding GroupVersion discovery.k8s.io v1 to ResourceManager I0217 06:35:37.427839 1 handler.go:275] Adding GroupVersion networking.k8s.io v1 to ResourceManager W0217 06:35:37.427850 1 genericapiserver.go:744] Skipping API networking.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.427859 1 genericapiserver.go:744] Skipping API networking.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.428286 1 handler.go:275] Adding GroupVersion node.k8s.io v1 to ResourceManager W0217 06:35:37.428299 1 genericapiserver.go:744] Skipping API node.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.428303 1 genericapiserver.go:744] Skipping API node.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.429298 1 handler.go:275] Adding GroupVersion policy v1 to ResourceManager W0217 06:35:37.429310 1 genericapiserver.go:744] Skipping API policy/v1beta1 because it has no resources. I0217 06:35:37.431416 1 handler.go:275] Adding GroupVersion rbac.authorization.k8s.io v1 to ResourceManager W0217 06:35:37.431428 1 genericapiserver.go:744] Skipping API rbac.authorization.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.431432 1 genericapiserver.go:744] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.432992 1 handler.go:275] Adding GroupVersion scheduling.k8s.io v1 to ResourceManager W0217 06:35:37.433008 1 genericapiserver.go:744] Skipping API scheduling.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.433011 1 genericapiserver.go:744] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.436459 1 handler.go:275] Adding GroupVersion storage.k8s.io v1 to ResourceManager W0217 06:35:37.436471 1 genericapiserver.go:744] Skipping API storage.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.436518 1 genericapiserver.go:744] Skipping API storage.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.437573 1 handler.go:275] Adding GroupVersion flowcontrol.apiserver.k8s.io v1beta3 to ResourceManager I0217 06:35:37.438400 1 handler.go:275] Adding GroupVersion flowcontrol.apiserver.k8s.io v1beta2 to ResourceManager W0217 06:35:37.438411 1 genericapiserver.go:744] Skipping API flowcontrol.apiserver.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.438415 1 genericapiserver.go:744] Skipping API flowcontrol.apiserver.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.446440 1 handler.go:275] Adding GroupVersion apps v1 to ResourceManager W0217 06:35:37.446454 1 genericapiserver.go:744] Skipping API apps/v1beta2 because it has no resources. W0217 06:35:37.446457 1 genericapiserver.go:744] Skipping API apps/v1beta1 because it has no resources. I0217 06:35:37.447135 1 handler.go:275] Adding GroupVersion admissionregistration.k8s.io v1 to ResourceManager W0217 06:35:37.447147 1 genericapiserver.go:744] Skipping API admissionregistration.k8s.io/v1beta1 because it has no resources. W0217 06:35:37.447151 1 genericapiserver.go:744] Skipping API admissionregistration.k8s.io/v1alpha1 because it has no resources. I0217 06:35:37.447563 1 handler.go:275] Adding GroupVersion events.k8s.io v1 to ResourceManager W0217 06:35:37.447573 1 genericapiserver.go:744] Skipping API events.k8s.io/v1beta1 because it has no resources. I0217 06:35:37.475477 1 handler.go:275] Adding GroupVersion apiregistration.k8s.io v1 to ResourceManager W0217 06:35:37.475489 1 genericapiserver.go:744] Skipping API apiregistration.k8s.io/v1beta1 because it has no resources. I0217 06:35:38.153341 1 secure_serving.go:213] Serving securely on [::]:6443 I0217 06:35:38.153564 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0217 06:35:38.153671 1 dynamic_serving_content.go:132] "Starting controller" name="serving-cert::/etc/kubernetes/pki/apiserver.crt::/etc/kubernetes/pki/apiserver.key" I0217 06:35:38.153759 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0217 06:35:38.153854 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0217 06:35:38.154118 1 handler_discovery.go:412] Starting ResourceDiscoveryManager I0217 06:35:38.154394 1 gc_controller.go:78] Starting apiserver lease garbage collector I0217 06:35:38.154424 1 dynamic_serving_content.go:132] "Starting controller" name="aggregator-proxy-cert::/etc/kubernetes/pki/front-proxy-client.crt::/etc/kubernetes/pki/front-proxy-client.key" I0217 06:35:38.154510 1 apiservice_controller.go:97] Starting APIServiceRegistrationController I0217 06:35:38.154520 1 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller I0217 06:35:38.154575 1 available_controller.go:423] Starting AvailableConditionController I0217 06:35:38.154588 1 cache.go:32] Waiting for caches to sync for AvailableConditionController controller I0217 06:35:38.154650 1 apf_controller.go:374] Starting API Priority and Fairness config controller I0217 06:35:38.154892 1 controller.go:116] Starting legacy_token_tracking_controller I0217 06:35:38.154904 1 shared_informer.go:311] Waiting for caches to sync for configmaps I0217 06:35:38.155319 1 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller I0217 06:35:38.155333 1 shared_informer.go:311] Waiting for caches to sync for cluster_authentication_trust_controller I0217 06:35:38.156697 1 aggregator.go:164] waiting for initial CRD sync... I0217 06:35:38.157126 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0217 06:35:38.159436 1 controller.go:78] Starting OpenAPI AggregationController I0217 06:35:38.160061 1 system_namespaces_controller.go:67] Starting system namespaces controller I0217 06:35:38.160202 1 controller.go:80] Starting OpenAPI V3 AggregationController I0217 06:35:38.160432 1 customresource_discovery_controller.go:289] Starting DiscoveryController I0217 06:35:38.160616 1 gc_controller.go:78] Starting apiserver lease garbage collector I0217 06:35:38.194230 1 crdregistration_controller.go:111] Starting crd-autoregister controller I0217 06:35:38.194350 1 shared_informer.go:311] Waiting for caches to sync for crd-autoregister I0217 06:35:38.157144 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0217 06:35:38.194600 1 controller.go:134] Starting OpenAPI controller I0217 06:35:38.194670 1 controller.go:85] Starting OpenAPI V3 controller I0217 06:35:38.194738 1 naming_controller.go:291] Starting NamingConditionController I0217 06:35:38.194789 1 establishing_controller.go:76] Starting EstablishingController I0217 06:35:38.194843 1 nonstructuralschema_controller.go:192] Starting NonStructuralSchemaConditionController I0217 06:35:38.194890 1 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController I0217 06:35:38.194944 1 crd_finalizer.go:266] Starting CRDFinalizer I0217 06:35:38.255718 1 shared_informer.go:318] Caches are synced for cluster_authentication_trust_controller I0217 06:35:38.257292 1 cache.go:39] Caches are synced for APIServiceRegistrationController controller I0217 06:35:38.257311 1 cache.go:39] Caches are synced for AvailableConditionController controller I0217 06:35:38.257324 1 apf_controller.go:379] Running API Priority and Fairness config worker I0217 06:35:38.257331 1 apf_controller.go:382] Running API Priority and Fairness periodic rebalancing process I0217 06:35:38.257388 1 shared_informer.go:318] Caches are synced for configmaps I0217 06:35:38.262840 1 controller.go:624] quota admission added evaluator for: namespaces I0217 06:35:38.295577 1 shared_informer.go:318] Caches are synced for crd-autoregister I0217 06:35:38.295658 1 aggregator.go:166] initial CRD sync complete... I0217 06:35:38.295667 1 autoregister_controller.go:141] Starting autoregister controller I0217 06:35:38.295673 1 cache.go:32] Waiting for caches to sync for autoregister controller I0217 06:35:38.295696 1 cache.go:39] Caches are synced for autoregister controller I0217 06:35:38.298948 1 controller.go:624] quota admission added evaluator for: leases.coordination.k8s.io I0217 06:35:38.330689 1 shared_informer.go:318] Caches are synced for node_authorizer I0217 06:35:39.162525 1 storage_scheduling.go:95] created PriorityClass system-node-critical with value 2000001000 I0217 06:35:39.167361 1 storage_scheduling.go:95] created PriorityClass system-cluster-critical with value 2000000000 I0217 06:35:39.168259 1 storage_scheduling.go:111] all system priority classes are created successfully or already exist. I0217 06:35:39.617392 1 controller.go:624] quota admission added evaluator for: roles.rbac.authorization.k8s.io I0217 06:35:39.655291 1 controller.go:624] quota admission added evaluator for: rolebindings.rbac.authorization.k8s.io I0217 06:35:39.773795 1 alloc.go:330] "allocated clusterIPs" service="default/kubernetes" clusterIPs={"IPv4":"10.96.0.1"} W0217 06:35:39.780281 1 lease.go:263] Resetting endpoints for master service "kubernetes" to [199.204.45.89] I0217 06:35:39.781469 1 controller.go:624] quota admission added evaluator for: endpoints I0217 06:35:39.784866 1 controller.go:624] quota admission added evaluator for: endpointslices.discovery.k8s.io I0217 06:35:41.329426 1 controller.go:624] quota admission added evaluator for: serviceaccounts I0217 06:35:41.378936 1 controller.go:624] quota admission added evaluator for: deployments.apps I0217 06:35:41.422423 1 alloc.go:330] "allocated clusterIPs" service="kube-system/kube-dns" clusterIPs={"IPv4":"10.96.0.10"} I0217 06:35:41.619185 1 controller.go:624] quota admission added evaluator for: daemonsets.apps I0217 06:35:46.167495 1 controller.go:624] quota admission added evaluator for: controllerrevisions.apps I0217 06:35:46.215438 1 controller.go:624] quota admission added evaluator for: replicasets.apps I0217 06:36:17.967023 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:18.441492 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:18.599689 1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager I0217 06:36:18.834763 1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager I0217 06:36:19.010822 1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager I0217 06:36:19.207229 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:19.411628 1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager I0217 06:36:19.621021 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:19.846294 1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager I0217 06:36:20.356311 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:20.666146 1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager I0217 06:36:26.020650 1 controller.go:624] quota admission added evaluator for: ciliumendpoints.cilium.io I0217 06:37:13.593824 1 alloc.go:330] "allocated clusterIPs" service="kube-system/ceph-csi-rbd-provisioner-http-metrics" clusterIPs={"IPv4":"10.107.39.174"} I0217 06:37:13.604043 1 alloc.go:330] "allocated clusterIPs" service="kube-system/ceph-csi-rbd-nodeplugin-http-metrics" clusterIPs={"IPv4":"10.106.137.149"} I0217 06:39:16.324388 1 trace.go:236] Trace[190201223]: "Update" accept:application/json, */*,audit-id:9adaed68-a231-4081-b7ec-f97cce21f7b1,client:127.0.0.1,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/plndr-cp-lock,user-agent:kube-vip/v0.0.0 (linux/amd64) kubernetes/$Format,verb:PUT (17-Feb-2026 06:39:12.953) (total time: 3367ms): Trace[190201223]: ["GuaranteedUpdate etcd3" audit-id:9adaed68-a231-4081-b7ec-f97cce21f7b1,key:/leases/kube-system/plndr-cp-lock,type:*coordination.Lease,resource:leases.coordination.k8s.io 3367ms (06:39:12.953) Trace[190201223]: ---"Txn call completed" 3366ms (06:39:16.320)] Trace[190201223]: [3.367513776s] [3.367513776s] END I0217 06:39:16.325003 1 trace.go:236] Trace[1551545422]: "Update" accept:application/vnd.kubernetes.protobuf, */*,audit-id:a3744d1a-425d-400d-b10d-5959a8a4c09f,client:::1,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/apiserver-f3tcohoifagyom4bbi4wgeu7te,user-agent:kube-apiserver/v1.28.13 (linux/amd64) kubernetes/024ab2a,verb:PUT (17-Feb-2026 06:39:14.071) (total time: 2251ms): Trace[1551545422]: ["GuaranteedUpdate etcd3" audit-id:a3744d1a-425d-400d-b10d-5959a8a4c09f,key:/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te,type:*coordination.Lease,resource:leases.coordination.k8s.io 2251ms (06:39:14.071) Trace[1551545422]: ---"Txn call completed" 2249ms (06:39:16.322)] Trace[1551545422]: [2.251708274s] [2.251708274s] END I0217 06:39:16.366645 1 trace.go:236] Trace[811379175]: "Get" accept:application/vnd.kubernetes.protobuf, */*,audit-id:f00b61ad-33eb-4006-a867-8440d75bfaf6,client:199.204.45.89,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/kube-controller-manager,user-agent:kube-controller-manager/v1.28.13 (linux/amd64) kubernetes/024ab2a/leader-election,verb:GET (17-Feb-2026 06:39:13.871) (total time: 2495ms): Trace[811379175]: ---"About to write a response" 2495ms (06:39:16.366) Trace[811379175]: [2.495388461s] [2.495388461s] END I0217 06:39:16.367276 1 trace.go:236] Trace[1862752710]: "Get" accept:application/vnd.kubernetes.protobuf, */*,audit-id:c41b38b4-9805-441d-a8a1-e5ebe47fb888,client:199.204.45.89,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/kube-scheduler,user-agent:kube-scheduler/v1.28.13 (linux/amd64) kubernetes/024ab2a/leader-election,verb:GET (17-Feb-2026 06:39:14.616) (total time: 1750ms): Trace[1862752710]: ---"About to write a response" 1750ms (06:39:16.367) Trace[1862752710]: [1.750876393s] [1.750876393s] END I0217 06:39:16.367406 1 trace.go:236] Trace[1563119935]: "Get" accept:application/json, */*,audit-id:b9233ece-6509-4cac-8b52-bd94a45b29cd,client:199.204.45.89,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/cilium-operator-resource-lock,user-agent:cilium-operator-generic/v0.0.0 (linux/amd64) kubernetes/$Format/leader-election,verb:GET (17-Feb-2026 06:39:13.988) (total time: 2378ms): Trace[1563119935]: ---"About to write a response" 2378ms (06:39:16.367) Trace[1563119935]: [2.378791798s] [2.378791798s] END I0217 06:39:16.367789 1 trace.go:236] Trace[236849159]: "Get" accept:application/json, */*,audit-id:496cb211-b57d-43e1-a26e-01d3665453e5,client:172.24.0.177,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/external-snapshotter-leader-rbd-csi-ceph-com,user-agent:csi-snapshotter/v0.0.0 (linux/amd64) kubernetes/$Format,verb:GET (17-Feb-2026 06:39:15.397) (total time: 970ms): Trace[236849159]: ---"About to write a response" 970ms (06:39:16.367) Trace[236849159]: [970.328104ms] [970.328104ms] END I0217 06:39:16.368128 1 trace.go:236] Trace[84039939]: "Get" accept:application/json, */*,audit-id:97db0791-92f3-4d16-82dd-9046abdb12df,client:172.24.0.177,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/rbd.csi.ceph.com-kube-system,user-agent:cephcsi/v0.0.0 (linux/amd64) kubernetes/$Format/leader-election,verb:GET (17-Feb-2026 06:39:13.348) (total time: 3019ms): Trace[84039939]: ---"About to write a response" 3019ms (06:39:16.368) Trace[84039939]: [3.019264786s] [3.019264786s] END I0217 06:39:16.368415 1 trace.go:236] Trace[1733777370]: "Get" accept:application/json, */*,audit-id:7ee6518a-afca-46c4-9c55-bafbc85858d8,client:172.24.0.177,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/external-resizer-rbd-csi-ceph-com,user-agent:csi-resizer/v0.0.0 (linux/amd64) kubernetes/$Format,verb:GET (17-Feb-2026 06:39:13.299) (total time: 3068ms): Trace[1733777370]: ---"About to write a response" 3068ms (06:39:16.368) Trace[1733777370]: [3.06839746s] [3.06839746s] END I0217 06:39:16.369566 1 trace.go:236] Trace[897259819]: "Get" accept:application/json, */*,audit-id:4b7d3bd6-ac3a-4f1a-83b4-8364088a6d56,client:127.0.0.1,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-system/leases/plndr-svcs-lock,user-agent:kube-vip/v0.0.0 (linux/amd64) kubernetes/$Format,verb:GET (17-Feb-2026 06:39:15.845) (total time: 524ms): Trace[897259819]: ---"About to write a response" 524ms (06:39:16.369) Trace[897259819]: [524.071919ms] [524.071919ms] END I0217 06:39:16.370541 1 trace.go:236] Trace[1954288291]: "Update" accept:application/vnd.kubernetes.protobuf,application/json,audit-id:f5a40da7-d40a-4799-8090-6b2ece5b0054,client:199.204.45.89,protocol:HTTP/2.0,resource:leases,scope:resource,url:/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/instance,user-agent:kubelet/v1.28.13 (linux/amd64) kubernetes/024ab2a,verb:PUT (17-Feb-2026 06:39:15.838) (total time: 532ms): Trace[1954288291]: ["GuaranteedUpdate etcd3" audit-id:f5a40da7-d40a-4799-8090-6b2ece5b0054,key:/leases/kube-node-lease/instance,type:*coordination.Lease,resource:leases.coordination.k8s.io 532ms (06:39:15.838) Trace[1954288291]: ---"Txn call completed" 530ms (06:39:16.370)] Trace[1954288291]: [532.317232ms] [532.317232ms] END