I0208 21:36:33.350305       1 options.go:220] external host was not specified, using 162.253.55.49
I0208 21:36:33.351337       1 server.go:148] Version: v1.28.13
I0208 21:36:33.351352       1 server.go:150] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I0208 21:36:34.215769       1 shared_informer.go:311] Waiting for caches to sync for node_authorizer
I0208 21:36:34.230907       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.
I0208 21:36:34.230924       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.
I0208 21:36:34.232189       1 instance.go:298] Using reconciler: lease
I0208 21:36:34.289454       1 handler.go:275] Adding GroupVersion apiextensions.k8s.io v1 to ResourceManager
W0208 21:36:34.289468       1 genericapiserver.go:744] Skipping API apiextensions.k8s.io/v1beta1 because it has no resources.
I0208 21:36:34.621573       1 handler.go:275] Adding GroupVersion  v1 to ResourceManager
I0208 21:36:34.621875       1 instance.go:709] API group "internal.apiserver.k8s.io" is not enabled, skipping.
I0208 21:36:34.962273       1 instance.go:709] API group "resource.k8s.io" is not enabled, skipping.
I0208 21:36:34.986839       1 handler.go:275] Adding GroupVersion authentication.k8s.io v1 to ResourceManager
W0208 21:36:34.987016       1 genericapiserver.go:744] Skipping API authentication.k8s.io/v1beta1 because it has no resources.
W0208 21:36:34.987062       1 genericapiserver.go:744] Skipping API authentication.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:34.987721       1 handler.go:275] Adding GroupVersion authorization.k8s.io v1 to ResourceManager
W0208 21:36:34.987790       1 genericapiserver.go:744] Skipping API authorization.k8s.io/v1beta1 because it has no resources.
I0208 21:36:34.989055       1 handler.go:275] Adding GroupVersion autoscaling v2 to ResourceManager
I0208 21:36:34.990801       1 handler.go:275] Adding GroupVersion autoscaling v1 to ResourceManager
W0208 21:36:34.990828       1 genericapiserver.go:744] Skipping API autoscaling/v2beta1 because it has no resources.
W0208 21:36:34.990836       1 genericapiserver.go:744] Skipping API autoscaling/v2beta2 because it has no resources.
I0208 21:36:34.992777       1 handler.go:275] Adding GroupVersion batch v1 to ResourceManager
W0208 21:36:34.992795       1 genericapiserver.go:744] Skipping API batch/v1beta1 because it has no resources.
I0208 21:36:34.994072       1 handler.go:275] Adding GroupVersion certificates.k8s.io v1 to ResourceManager
W0208 21:36:34.994090       1 genericapiserver.go:744] Skipping API certificates.k8s.io/v1beta1 because it has no resources.
W0208 21:36:34.994096       1 genericapiserver.go:744] Skipping API certificates.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:34.994939       1 handler.go:275] Adding GroupVersion coordination.k8s.io v1 to ResourceManager
W0208 21:36:34.994956       1 genericapiserver.go:744] Skipping API coordination.k8s.io/v1beta1 because it has no resources.
W0208 21:36:34.995021       1 genericapiserver.go:744] Skipping API discovery.k8s.io/v1beta1 because it has no resources.
I0208 21:36:34.995820       1 handler.go:275] Adding GroupVersion discovery.k8s.io v1 to ResourceManager
I0208 21:36:34.997556       1 handler.go:275] Adding GroupVersion networking.k8s.io v1 to ResourceManager
W0208 21:36:34.997573       1 genericapiserver.go:744] Skipping API networking.k8s.io/v1beta1 because it has no resources.
W0208 21:36:34.997579       1 genericapiserver.go:744] Skipping API networking.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:34.998129       1 handler.go:275] Adding GroupVersion node.k8s.io v1 to ResourceManager
W0208 21:36:34.998146       1 genericapiserver.go:744] Skipping API node.k8s.io/v1beta1 because it has no resources.
W0208 21:36:34.998151       1 genericapiserver.go:744] Skipping API node.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:34.999127       1 handler.go:275] Adding GroupVersion policy v1 to ResourceManager
W0208 21:36:34.999145       1 genericapiserver.go:744] Skipping API policy/v1beta1 because it has no resources.
I0208 21:36:35.001237       1 handler.go:275] Adding GroupVersion rbac.authorization.k8s.io v1 to ResourceManager
W0208 21:36:35.001255       1 genericapiserver.go:744] Skipping API rbac.authorization.k8s.io/v1beta1 because it has no resources.
W0208 21:36:35.001261       1 genericapiserver.go:744] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:35.001778       1 handler.go:275] Adding GroupVersion scheduling.k8s.io v1 to ResourceManager
W0208 21:36:35.001798       1 genericapiserver.go:744] Skipping API scheduling.k8s.io/v1beta1 because it has no resources.
W0208 21:36:35.001804       1 genericapiserver.go:744] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:35.004516       1 handler.go:275] Adding GroupVersion storage.k8s.io v1 to ResourceManager
W0208 21:36:35.004536       1 genericapiserver.go:744] Skipping API storage.k8s.io/v1beta1 because it has no resources.
W0208 21:36:35.004542       1 genericapiserver.go:744] Skipping API storage.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:35.005982       1 handler.go:275] Adding GroupVersion flowcontrol.apiserver.k8s.io v1beta3 to ResourceManager
I0208 21:36:35.007426       1 handler.go:275] Adding GroupVersion flowcontrol.apiserver.k8s.io v1beta2 to ResourceManager
W0208 21:36:35.007444       1 genericapiserver.go:744] Skipping API flowcontrol.apiserver.k8s.io/v1beta1 because it has no resources.
W0208 21:36:35.007450       1 genericapiserver.go:744] Skipping API flowcontrol.apiserver.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:35.011918       1 handler.go:275] Adding GroupVersion apps v1 to ResourceManager
W0208 21:36:35.011939       1 genericapiserver.go:744] Skipping API apps/v1beta2 because it has no resources.
W0208 21:36:35.011946       1 genericapiserver.go:744] Skipping API apps/v1beta1 because it has no resources.
I0208 21:36:35.013227       1 handler.go:275] Adding GroupVersion admissionregistration.k8s.io v1 to ResourceManager
W0208 21:36:35.013243       1 genericapiserver.go:744] Skipping API admissionregistration.k8s.io/v1beta1 because it has no resources.
W0208 21:36:35.013249       1 genericapiserver.go:744] Skipping API admissionregistration.k8s.io/v1alpha1 because it has no resources.
I0208 21:36:35.013890       1 handler.go:275] Adding GroupVersion events.k8s.io v1 to ResourceManager
W0208 21:36:35.013907       1 genericapiserver.go:744] Skipping API events.k8s.io/v1beta1 because it has no resources.
I0208 21:36:35.047602       1 handler.go:275] Adding GroupVersion apiregistration.k8s.io v1 to ResourceManager
W0208 21:36:35.047699       1 genericapiserver.go:744] Skipping API apiregistration.k8s.io/v1beta1 because it has no resources.
I0208 21:36:35.537546       1 secure_serving.go:213] Serving securely on [::]:6443
I0208 21:36:35.538005       1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt"
I0208 21:36:35.538116       1 dynamic_serving_content.go:132] "Starting controller" name="serving-cert::/etc/kubernetes/pki/apiserver.crt::/etc/kubernetes/pki/apiserver.key"
I0208 21:36:35.538287       1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I0208 21:36:35.541204       1 customresource_discovery_controller.go:289] Starting DiscoveryController
I0208 21:36:35.541271       1 system_namespaces_controller.go:67] Starting system namespaces controller
I0208 21:36:35.541413       1 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller
I0208 21:36:35.541443       1 shared_informer.go:311] Waiting for caches to sync for cluster_authentication_trust_controller
I0208 21:36:35.541846       1 apf_controller.go:374] Starting API Priority and Fairness config controller
I0208 21:36:35.541926       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"
I0208 21:36:35.542045       1 controller.go:80] Starting OpenAPI V3 AggregationController
I0208 21:36:35.542106       1 apiservice_controller.go:97] Starting APIServiceRegistrationController
I0208 21:36:35.542123       1 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller
I0208 21:36:35.542183       1 handler_discovery.go:412] Starting ResourceDiscoveryManager
I0208 21:36:35.542422       1 gc_controller.go:78] Starting apiserver lease garbage collector
I0208 21:36:35.542572       1 aggregator.go:164] waiting for initial CRD sync...
I0208 21:36:35.542818       1 controller.go:116] Starting legacy_token_tracking_controller
I0208 21:36:35.542860       1 shared_informer.go:311] Waiting for caches to sync for configmaps
I0208 21:36:35.542927       1 controller.go:78] Starting OpenAPI AggregationController
I0208 21:36:35.543075       1 gc_controller.go:78] Starting apiserver lease garbage collector
I0208 21:36:35.543420       1 controller.go:134] Starting OpenAPI controller
I0208 21:36:35.543528       1 controller.go:85] Starting OpenAPI V3 controller
I0208 21:36:35.543580       1 naming_controller.go:291] Starting NamingConditionController
I0208 21:36:35.543648       1 establishing_controller.go:76] Starting EstablishingController
I0208 21:36:35.543706       1 nonstructuralschema_controller.go:192] Starting NonStructuralSchemaConditionController
I0208 21:36:35.543763       1 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController
I0208 21:36:35.543804       1 crd_finalizer.go:266] Starting CRDFinalizer
I0208 21:36:35.543888       1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
I0208 21:36:35.543970       1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt"
I0208 21:36:35.544441       1 available_controller.go:423] Starting AvailableConditionController
I0208 21:36:35.544454       1 cache.go:32] Waiting for caches to sync for AvailableConditionController controller
I0208 21:36:35.544537       1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
I0208 21:36:35.546736       1 crdregistration_controller.go:111] Starting crd-autoregister controller
I0208 21:36:35.546833       1 shared_informer.go:311] Waiting for caches to sync for crd-autoregister
I0208 21:36:35.618568       1 shared_informer.go:318] Caches are synced for node_authorizer
I0208 21:36:35.641908       1 apf_controller.go:379] Running API Priority and Fairness config worker
I0208 21:36:35.641950       1 apf_controller.go:382] Running API Priority and Fairness periodic rebalancing process
I0208 21:36:35.642045       1 shared_informer.go:318] Caches are synced for cluster_authentication_trust_controller
I0208 21:36:35.642214       1 cache.go:39] Caches are synced for APIServiceRegistrationController controller
I0208 21:36:35.642905       1 controller.go:624] quota admission added evaluator for: namespaces
I0208 21:36:35.643467       1 shared_informer.go:318] Caches are synced for configmaps
I0208 21:36:35.644489       1 cache.go:39] Caches are synced for AvailableConditionController controller
I0208 21:36:35.646887       1 shared_informer.go:318] Caches are synced for crd-autoregister
I0208 21:36:35.646980       1 aggregator.go:166] initial CRD sync complete...
I0208 21:36:35.647010       1 autoregister_controller.go:141] Starting autoregister controller
I0208 21:36:35.647027       1 cache.go:32] Waiting for caches to sync for autoregister controller
I0208 21:36:35.647042       1 cache.go:39] Caches are synced for autoregister controller
I0208 21:36:35.650665       1 controller.go:624] quota admission added evaluator for: leases.coordination.k8s.io
I0208 21:36:36.552972       1 storage_scheduling.go:95] created PriorityClass system-node-critical with value 2000001000
I0208 21:36:36.557061       1 storage_scheduling.go:95] created PriorityClass system-cluster-critical with value 2000000000
I0208 21:36:36.557079       1 storage_scheduling.go:111] all system priority classes are created successfully or already exist.
I0208 21:36:37.017207       1 controller.go:624] quota admission added evaluator for: roles.rbac.authorization.k8s.io
I0208 21:36:37.060564       1 controller.go:624] quota admission added evaluator for: rolebindings.rbac.authorization.k8s.io
I0208 21:36:37.156718       1 alloc.go:330] "allocated clusterIPs" service="default/kubernetes" clusterIPs={"IPv4":"10.96.0.1"}
W0208 21:36:37.162474       1 lease.go:263] Resetting endpoints for master service "kubernetes" to [162.253.55.49]
I0208 21:36:37.163350       1 controller.go:624] quota admission added evaluator for: endpoints
I0208 21:36:37.166964       1 controller.go:624] quota admission added evaluator for: endpointslices.discovery.k8s.io
I0208 21:36:37.825495       1 controller.go:624] quota admission added evaluator for: serviceaccounts
I0208 21:36:38.836531       1 controller.go:624] quota admission added evaluator for: deployments.apps
I0208 21:36:38.936507       1 alloc.go:330] "allocated clusterIPs" service="kube-system/kube-dns" clusterIPs={"IPv4":"10.96.0.10"}
I0208 21:36:39.132891       1 controller.go:624] quota admission added evaluator for: daemonsets.apps
I0208 21:36:43.206948       1 controller.go:624] quota admission added evaluator for: replicasets.apps
I0208 21:36:43.208116       1 controller.go:624] quota admission added evaluator for: controllerrevisions.apps
I0208 21:37:04.765617       1 trace.go:236] Trace[1107064124]: "Update" accept:application/json, */*,audit-id:55700047-71fe-452d-ab97-9a8e52ac41e8,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:PUT (08-Feb-2026 21:37:03.926) (total time: 838ms):
Trace[1107064124]: ["GuaranteedUpdate etcd3" audit-id:55700047-71fe-452d-ab97-9a8e52ac41e8,key:/leases/kube-system/plndr-svcs-lock,type:*coordination.Lease,resource:leases.coordination.k8s.io 838ms (21:37:03.926)
Trace[1107064124]:  ---"Txn call completed" 838ms (21:37:04.765)]
Trace[1107064124]: [838.925798ms] [838.925798ms] END
I0208 21:37:05.190562       1 trace.go:236] Trace[444867301]: "Get" accept:application/vnd.kubernetes.protobuf, */*,audit-id:21098af9-6ffe-4545-b78a-9e81c7f7b303,client:162.253.55.49,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 (08-Feb-2026 21:37:04.103) (total time: 1086ms):
Trace[444867301]: ---"About to write a response" 1086ms (21:37:05.190)
Trace[444867301]: [1.086792817s] [1.086792817s] END
I0208 21:37:05.190777       1 trace.go:236] Trace[32037956]: "Update" accept:application/json, */*,audit-id:3e70816b-0931-472a-bf8f-90deeb0b5472,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 (08-Feb-2026 21:37:03.927) (total time: 1263ms):
Trace[32037956]: ["GuaranteedUpdate etcd3" audit-id:3e70816b-0931-472a-bf8f-90deeb0b5472,key:/leases/kube-system/plndr-cp-lock,type:*coordination.Lease,resource:leases.coordination.k8s.io 1263ms (21:37:03.927)
Trace[32037956]:  ---"Txn call completed" 1262ms (21:37:05.190)]
Trace[32037956]: [1.263082704s] [1.263082704s] END
I0208 21:37:05.193958       1 trace.go:236] Trace[1813481172]: "Get" accept:application/json,audit-id:ac913762-3c31-49b5-86e4-f929b5a731ca,client:162.253.55.49,protocol:HTTP/1.1,resource:nodes,scope:resource,url:/api/v1/nodes/instance,user-agent:OpenAPI-Generator/35.0.0/python,verb:GET (08-Feb-2026 21:37:04.500) (total time: 693ms):
Trace[1813481172]: ---"About to write a response" 693ms (21:37:05.193)
Trace[1813481172]: [693.490696ms] [693.490696ms] END
I0208 21:37:12.694919       1 trace.go:236] Trace[1841836770]: "Get" accept:application/vnd.kubernetes.protobuf,application/json,audit-id:c9688e1f-6a0a-4b38-bb59-084013799536,client:162.253.55.49,protocol:HTTP/2.0,resource:pods,scope:resource,url:/api/v1/namespaces/kube-system/pods/cilium-rpj56,user-agent:kubelet/v1.28.13 (linux/amd64) kubernetes/024ab2a,verb:GET (08-Feb-2026 21:37:12.056) (total time: 638ms):
Trace[1841836770]: ---"About to write a response" 638ms (21:37:12.694)
Trace[1841836770]: [638.598815ms] [638.598815ms] END
I0208 21:37:15.271556       1 trace.go:236] Trace[1727584856]: "Get" accept:application/vnd.kubernetes.protobuf, */*,audit-id:2e9093ff-4e7b-4a3a-8904-3902b8326348,client:162.253.55.49,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 (08-Feb-2026 21:37:13.220) (total time: 2051ms):
Trace[1727584856]: ---"About to write a response" 2051ms (21:37:15.271)
Trace[1727584856]: [2.051259695s] [2.051259695s] END
I0208 21:37:15.271591       1 trace.go:236] Trace[514136578]: "Get" accept:application/vnd.kubernetes.protobuf, */*,audit-id:3415bb45-67db-442c-bc96-457a03c5a403,client:162.253.55.49,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 (08-Feb-2026 21:37:14.001) (total time: 1270ms):
Trace[514136578]: ---"About to write a response" 1270ms (21:37:15.271)
Trace[514136578]: [1.270482459s] [1.270482459s] END
I0208 21:37:15.272045       1 trace.go:236] Trace[408719064]: "Get" accept:application/json, */*,audit-id:deda2391-162a-469f-a934-282aeb9011cb,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:GET (08-Feb-2026 21:37:13.217) (total time: 2054ms):
Trace[408719064]: ---"About to write a response" 2053ms (21:37:15.271)
Trace[408719064]: [2.054037923s] [2.054037923s] END
I0208 21:37:17.244372       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:17.604696       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:17.616672       1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager
I0208 21:37:18.013184       1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager
I0208 21:37:18.232283       1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager
I0208 21:37:18.418656       1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager
I0208 21:37:18.824261       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:19.024590       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:19.550035       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:19.550111       1 handler.go:275] Adding GroupVersion cilium.io v2alpha1 to ResourceManager
I0208 21:37:20.744235       1 handler.go:275] Adding GroupVersion cilium.io v2 to ResourceManager
I0208 21:37:25.112020       1 controller.go:624] quota admission added evaluator for: ciliumendpoints.cilium.io
I0208 21:37:29.973504       1 trace.go:236] Trace[1848567615]: "Patch" accept:application/vnd.kubernetes.protobuf,application/json,audit-id:30f9347b-23de-4ee3-b43b-c34466121256,client:162.253.55.49,protocol:HTTP/2.0,resource:pods,scope:resource,url:/api/v1/namespaces/kube-system/pods/coredns-77cccfdc44-klhrn/status,user-agent:kubelet/v1.28.13 (linux/amd64) kubernetes/024ab2a,verb:PATCH (08-Feb-2026 21:37:29.366) (total time: 606ms):
Trace[1848567615]: ["GuaranteedUpdate etcd3" audit-id:30f9347b-23de-4ee3-b43b-c34466121256,key:/pods/kube-system/coredns-77cccfdc44-klhrn,type:*core.Pod,resource:pods 605ms (21:37:29.368)
Trace[1848567615]:  ---"Txn call completed" 600ms (21:37:29.972)]
Trace[1848567615]: ---"Object stored in database" 601ms (21:37:29.972)
Trace[1848567615]: [606.460307ms] [606.460307ms] END
I0208 21:38:54.991193       1 trace.go:236] Trace[291944008]: "Update" accept:application/json, */*,audit-id:39349c35-de9c-44be-8929-129f8ae9aabe,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 (08-Feb-2026 21:38:54.098) (total time: 892ms):
Trace[291944008]: ["GuaranteedUpdate etcd3" audit-id:39349c35-de9c-44be-8929-129f8ae9aabe,key:/leases/kube-system/plndr-cp-lock,type:*coordination.Lease,resource:leases.coordination.k8s.io 892ms (21:38:54.099)
Trace[291944008]:  ---"Txn call completed" 891ms (21:38:54.990)]
Trace[291944008]: [892.233133ms] [892.233133ms] END