root@Cloudstack-422-before:/home/ubuntu# cat /var/log/cloudstack/management/management-server.log |grep -i "logid:14964378"
2026-08-05 10:37:30,418 DEBUG [c.c.a.ApiServlet] (qtp380274260-3331:[ctx-6d9a580f]) (logid:14964378) ===START=== 192.168.55.207 -- POST addHost
2026-08-05 10:37:30,418 DEBUG [c.c.a.ApiServlet] (qtp380274260-3331:[ctx-6d9a580f]) (logid:14964378) Two factor authentication is already verified for the user 2, so skipping
2026-08-05 10:37:30,419 DEBUG [c.c.a.ApiServer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) CIDRs from which account 'Account [{"accountName":"admin","id":2,"uuid":"47dc9e4c-83f6-11f1-aed8-bc24112069f3"}]' is allowed to perform API calls: 0.0.0.0/0,::/0
2026-08-05 10:37:30,420 INFO [o.a.c.a.DynamicRoleBasedAPIAccessChecker] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Account [Account [{"accountName":"admin","id":2,"uuid":"47dc9e4c-83f6-11f1-aed8-bc24112069f3"}]] is Root Admin and there aren't any API key pair permissions involved, thus, all APIs are allowed.
2026-08-05 10:37:30,420 DEBUG [o.a.c.a.StaticRoleBasedAPIAccessChecker] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) RoleService is enabled. We will use it instead of StaticRoleBasedAPIAccessChecker.
2026-08-05 10:37:30,420 DEBUG [o.a.c.r.ApiRateLimitServiceImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) API rate limiting is disabled. We will not use ApiRateLimitService.
2026-08-05 10:37:30,423 WARN [c.c.a.d.ParamGenericValidationWorker] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Received unknown parameters for command addHost. Unknown parameters : clustertype
2026-08-05 10:37:30,424 INFO [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Trying to add a new host at http://192.168.55.162 in data center Zone {"id": "1", "name": "Test-zone", "uuid": "157cb8ca-1c40-4a1f-a737-8bddb1dcb2fd"}
2026-08-05 10:37:30,489 DEBUG [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) host 192.168.55.162 doesn't have 996dd2e7-ad95-49cc-a0be-2c9adc4dfb0b Hotfix
2026-08-05 10:37:30,493 DEBUG [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) host 192.168.55.162 doesn't have 0850b186-4d47-11e3-a720-001b2151a503 Hotfix
2026-08-05 10:37:30,496 WARN [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) defaulting to xenserver650 resource for product brand: XenServer with product version: 9.0.0
2026-08-05 10:37:30,496 INFO [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Found host xenserver-biuwcxrc ip=192.168.55.162 product version=9.0.0
2026-08-05 10:37:30,561 DEBUG [c.c.a.r.v.VirtualRoutingResource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) The router.aggregation.command.each.timeout in seconds is set to 600
2026-08-05 10:37:30,608 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Management network is on pif=b75e9a56-47ad-24df-5a8b-08cfe4ec9731
2026-08-05 10:37:30,611 DEBUG [c.c.h.x.r.XsLocalNetwork] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Found a network called Network0 on host=192.168.55.162; Network=258647b3-d97e-79f3-bb2f-7d80fc415ef1; pif=b75e9a56-47ad-24df-5a8b-08cfe4ec9731
2026-08-05 10:37:30,611 INFO [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) XenServer Version is 9.0.0 for host 192.168.55.162
2026-08-05 10:37:30,611 INFO [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Private Network is Network0 for host 192.168.55.162
2026-08-05 10:37:30,611 INFO [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Guest Network is Network0 for host 192.168.55.162
2026-08-05 10:37:30,611 INFO [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Public Network is Network0 for host 192.168.55.162
2026-08-05 10:37:30,616 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Total Ram: (6.38 GB) 6855096960 dom0 Ram: (1.41 GB) 1509949440
2026-08-05 10:37:31,029 ERROR [c.c.u.s.SshHelper] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) SSH execution of command xe sm-list | grep "resigning of duplicates" has an error status code in return. Result output:
2026-08-05 10:37:31,032 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) can't get patches information for hotFix: 996dd2e7-ad95-49cc-a0be-2c9adc4dfb0b
2026-08-05 10:37:31,035 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) can't get patches information for hotFix: 0850b186-4d47-11e3-a720-001b2151a503
2026-08-05 10:37:31,045 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Found 0 local storage of type [lvm] for host [d9b24050-1b48-451d-bcf9-fa59cd3aa8c4]
2026-08-05 10:37:31,049 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Scanning local SR: b17a3090-3e5a-4015-4bd9-2c3158a6fc2e
2026-08-05 10:37:31,240 DEBUG [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Found 1 local storage of type [ext] for host [d9b24050-1b48-451d-bcf9-fa59cd3aa8c4]
2026-08-05 10:37:31,252 INFO [c.c.h.x.r.XenServer650Resource] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) StartUp command created for local storage [b17a3090-3e5a-4015-4bd9-2c3158a6fc2e] of type [EXT] on host [d9b24050-1b48-451d-bcf9-fa59cd3aa8c4]
2026-08-05 10:37:31,258 DEBUG [c.c.a.t.Request] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Seq -1--1: Startup request from directly connected host: { Cmd , MgmtId: -1, via: -1, Ver: v1, Flags: 11, [{"cpuSockets":"1","cpus":"4","speed":"3186","memory":"6855096960","dom0MinMemory":"1509949440","poolSync":"false","supportsClonedVolumes":"false","caps":"xen-3.0-x86_64 , hvm-3.0-x86_32 , hvm-3.0-x86_32p , hvm-3.0-x86_64","pool":"0dd3367d-42f3-b18e-bdff-2fd3e0b1e6e6","hypervisorType":"XenServer","hostDetails":{"product_version":"9.0.0","com.cloud.network.Networks.RouterPrivateIpStrategy":"DcGlobal","product_version_text_short":"9","private.network.device":"Network0","product_brand":"XenServer"},"hostTags":["GPU"],"hypervisorVersion":"9.0.0","groupDetails":{"Group of Vendor 1234 Device 1111 GPUs":{}},"gpuDevices":[],"type":"Routing","dataCenter":"1","pod":"1","cluster":"8","guid":"d9b24050-1b48-451d-bcf9-fa59cd3aa8c4","name":"xenserver-biuwcxrc","version":"4.23.0.0","iqn":"iqn.2026-08.com.example:50ed7146","publicIpAddress":"192.168.55.162","publicNetmask":"255.255.255.0","publicMacAddress":"bc:24:11:94:6a:38","privateIpAddress":"192.168.55.162","privateMacAddress":"bc:24:11:94:6a:38","privateNetmask":"255.255.255.0","storageIpAddress":"192.168.55.162","storageNetmask":"255.255.255.0","storageMacAddress":"bc:24:11:94:6a:38","connectionTransferred":"false","wait":"0","bypassHostMaintenance":"false"},{"totalSize":"(0 bytes) 0","poolInfo":{"uuid":"b17a3090-3e5a-4015-4bd9-2c3158a6fc2e","host":"192.168.55.162","localPath":"EXT","hostPath":"EXT","poolType":"EXT","capacityBytes":"(37.58 GB) 40354775040","availableBytes":"(37.58 GB) 40354742272"},"resourceType":"STORAGE_POOL","hostDetails":{},"type":"Storage","dataCenter":"1","guid":"d9b24050-1b48-451d-bcf9-fa59cd3aa8c4","connectionTransferred":"false","wait":"0","bypassHostMaintenance":"false"}] }
2026-08-05 10:37:31,259 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Trying to find Host by guid d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,260 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Trying to find Host by guid prefix d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,260 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Could not find Host by guid d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,260 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Trying to find Host by guid d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,260 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Trying to find Host by guid prefix d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,261 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Could not find Host by guid d9b24050-1b48-451d-bcf9-fa59cd3aa8c4
2026-08-05 10:37:31,262 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Dispatching resource state event CREATE_HOST_VO_FOR_DIRECT_CONNECT to CiscoVnmcElement
2026-08-05 10:37:31,262 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Dispatching resource state event CREATE_HOST_VO_FOR_DIRECT_CONNECT to NetscalerElement
2026-08-05 10:37:31,262 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Dispatching resource state event CREATE_HOST_VO_FOR_DIRECT_CONNECT to HypervServerDiscoverer
2026-08-05 10:37:31,262 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Dispatching resource state event CREATE_HOST_VO_FOR_DIRECT_CONNECT to BaremetalPxeManagerImpl
2026-08-05 10:37:31,262 DEBUG [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Dispatching resource state event CREATE_HOST_VO_FOR_DIRECT_CONNECT to XcpServerDiscoverer
2026-08-05 10:37:31,262 INFO [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Host: xenserver-biuwcxrc connected with hypervisor type: XenServer. Checking CIDR...
2026-08-05 10:37:31,301 DEBUG [c.c.h.d.HostDaoImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Resource state update: [id = 17; name = xenserver-biuwcxrc; old state = Creating; event = InternalCreated; new state = Enabled]
2026-08-05 10:37:31,301 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) [Resource state = Enabled, Agent event = , Host = AgentConnected]
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Create ClusteredDirectAgentAttache for Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}.
2026-08-05 10:37:31,312 INFO [c.c.a.m.ClusteredDirectAgentAttache] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) StartupAnswer received [id: 17, uuid: 257e16c5-08f4-4088-8a2b-60a4f69abd9a, name: xenserver-biuwcxrc, interval: 60]
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: XcpServerDiscoverer
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: HypervServerDiscoverer
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: ExternalServerDiscoverer
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: TungstenElement
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: NsxElement
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: NetrisElement
2026-08-05 10:37:31,312 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: StoragePoolMonitor
2026-08-05 10:37:31,312 DEBUG [o.a.c.s.d.p.AdaptivePrimaryHostListener] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) hostAdded called
2026-08-05 10:37:31,312 DEBUG [o.a.c.s.d.p.AdaptivePrimaryHostListener] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) hostAdded called
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: VmwareManagerImpl
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: SecurityGroupListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: DeploymentPlanningManagerImpl
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: SecondaryStorageListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: ClusteredVirtualMachineManagerImpl
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: NetworkOrchestrator
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: BehindOnPingListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: SetHostParamsListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: SshKeysDistriMonitor
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: VpcVirtualNetworkApplianceManagerImpl
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: UploadListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: DirectNetworkStatsListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: StorageCapacityListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: ComputeCapacityListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: SshKeysDistriMonitor
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: VirtualNetworkApplianceManagerImpl
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: DownloadListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: ConsoleProxyListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: LocalStoragePoolListener
2026-08-05 10:37:31,316 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: KvmServerDiscoverer
2026-08-05 10:37:31,317 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: LxcServerDiscoverer
2026-08-05 10:37:31,317 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending host added to listener: CustomServerDiscoverer
2026-08-05 10:37:31,317 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Connect to listener: XcpServerDiscoverer, for rebalance: false
2026-08-05 10:37:31,317 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) process connection to issue: {"connectionTransferred":false,"id":null,"msHostList":null,"type":"Routing"} for host: 17, forRebalance: false
2026-08-05 10:37:31,317 WARN [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) defaulting to xenserver650 resource for product brand: XenServer with product version: 9.0.0
2026-08-05 10:37:31,317 DEBUG [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Setting up host 17
2026-08-05 10:37:31,318 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Wait time setting on com.cloud.agent.api.SetupCommand is 1800 seconds
2026-08-05 10:37:31,318 DEBUG [c.c.a.m.ClusteredDirectAgentAttache] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Seq 17-5484821396183842817: Routed from 206863092181491
2026-08-05 10:37:31,318 DEBUG [c.c.a.t.Request] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Seq 17-5484821396183842817: Sending { Cmd , MgmtId: 206863092181491, via: 17(xenserver-biuwcxrc), Ver: v1, Flags: 100111, [{"com.cloud.agent.api.SetupCommand":{"env":{},"multipath":"false","needSetup":"true","wait":"0","bypassHostMaintenance":"false"}}] }
2026-08-05 10:37:31,318 DEBUG [c.c.a.t.Request] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Seq 17-5484821396183842817: Executing: { Cmd , MgmtId: 206863092181491, via: 17(xenserver-biuwcxrc), Ver: v1, Flags: 100111, [{"com.cloud.agent.api.SetupCommand":{"env":{},"multipath":"false","needSetup":"true","wait":"0","bypassHostMaintenance":"false"}}] }
2026-08-05 10:37:31,474 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: rm -f /opt/xensource/sm/hostvmstats.py /opt/xensource/bin/copy_vhd_to_secondarystorage.sh /opt/xensource/bin/copy_vhd_from_secondarystorage.sh /opt/xensource/bin/create_privatetemplate_from_snapshot.sh /opt/xensource/bin/vhd-util /opt/cloud/bin/copy_vhd_to_secondarystorage.sh /opt/cloud/bin/copy_vhd_from_secondarystorage.sh /opt/cloud/bin/create_privatetemplate_from_snapshot.sh /opt/cloud/bin/vhd-util
2026-08-05 10:37:32,830 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -p /opt/cloud/bin /var/log/cloud /opt/xensource/packages/resources/
2026-08-05 10:37:33,927 DEBUG [c.c.u.s.Script] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Looking for scripts/vm/hypervisor/xenserver/xenserver65/patch in the classpath
2026-08-05 10:37:33,928 DEBUG [c.c.u.s.Script] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) System resource: file:/usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/patch
2026-08-05 10:37:33,928 DEBUG [c.c.u.s.Script] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Absolute path = /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/patch
2026-08-05 10:37:33,928 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../xenheartbeat.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:33,928 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:35,063 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../network/ovs-pvlan-dhcp-host.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:35,063 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:36,151 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../ovs-vif-flows.py to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:37:36,151 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:37:37,338 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../upgrade_snapshot.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:37,338 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:38,530 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../launch_hb.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:38,530 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:39,613 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../setup_iscsi.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:39,613 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:40,802 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloud-plugin-storage to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:37:40,802 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:37:41,889 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../../network/domr//router_proxy.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:41,889 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:43,071 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloudlog to /etc/logrotate.d on 192.168.55.162 with permission 0644
2026-08-05 10:37:43,071 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/logrotate.d
2026-08-05 10:37:44,156 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloudstack_plugins.conf to /etc/xensource on 192.168.55.162 with permission 0644
2026-08-05 10:37:44,156 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xensource
2026-08-05 10:37:45,242 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../systemvm/id_rsa.cloud to /root/.ssh on 192.168.55.162 with permission 0600
2026-08-05 10:37:45,242 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /root/.ssh
2026-08-05 10:37:46,325 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../swiftxenserver to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:37:46,326 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:37:47,417 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../vmopsSnapshot to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:37:47,417 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:37:48,501 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../../../vms/cloud-scripts.tgz to /opt/xensource/packages/resources/ on 192.168.55.162 with permission 0644
2026-08-05 10:37:48,501 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/xensource/packages/resources/
2026-08-05 10:37:49,598 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../pingtest.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:49,598 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:50,681 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../ovs-get-dhcp-iface.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:50,681 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:51,774 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../setupxenserver.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:51,774 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:52,866 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloud-prepare-upgrade.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:52,866 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:53,997 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../swift to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:53,997 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:55,132 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../make_migratable.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:55,132 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:56,219 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../xen-ovs-vif-flows.rules to /etc/udev/rules.d on 192.168.55.162 with permission 0644
2026-08-05 10:37:56,219 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/udev/rules.d
2026-08-05 10:37:57,306 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../logrotate to /etc/cron.hourly on 192.168.55.162 with permission 0755
2026-08-05 10:37:57,306 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/cron.hourly
2026-08-05 10:37:58,396 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../network/ovs-pvlan-vm.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:58,396 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:37:59,487 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../network/ovs-pvlan-cleanup.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:37:59,487 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:00,678 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloud-setup-bonding.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:00,678 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:01,866 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloudstack_pluginlib.py to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:01,866 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:03,056 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../add_to_vcpus_params_live.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:03,056 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:04,147 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../vmops to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:04,147 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:05,244 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../vmopspremium to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:05,244 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:06,438 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../cloud-clean-vlan.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:06,438 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:07,635 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../ovstunnel to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:07,635 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:08,722 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../kill_copy_process.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:08,722 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:09,814 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../setup_heartbeat_sr.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:09,814 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:10,905 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../ovs-get-bridge.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:10,905 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:12,091 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../../../vms/agent.zip to /opt/xensource/packages/resources/ on 192.168.55.162 with permission 0644
2026-08-05 10:38:12,091 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/xensource/packages/resources/
2026-08-05 10:38:14,543 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../network_info.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:14,543 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:15,633 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../check_heartbeat.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:15,633 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:16,725 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../update_host_passwd.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:16,725 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:17,916 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../../../../../vms/patch-sysvms.sh to /opt/xensource/packages/resources/ on 192.168.55.162 with permission 0644
2026-08-05 10:38:17,917 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/xensource/packages/resources/
2026-08-05 10:38:19,011 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../s3xenserver to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:19,011 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:20,098 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../ovs-pvlan to /etc/xapi.d/plugins on 192.168.55.162 with permission 0755
2026-08-05 10:38:20,099 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /etc/xapi.d/plugins
2026-08-05 10:38:21,193 DEBUG [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Copying /usr/share/cloudstack-common/scripts/vm/hypervisor/xenserver/xenserver65/../setup_heartbeat_file.sh to /opt/cloud/bin on 192.168.55.162 with permission 0755
2026-08-05 10:38:21,193 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: mkdir -m 700 -p /opt/cloud/bin
2026-08-05 10:38:22,438 DEBUG [c.c.u.s.SSHCmdHelper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Executing cmd: rm -f /opt/xensource/sm/hostvmstats.py /opt/xensource/bin/copy_vhd_to_secondarystorage.sh /opt/xensource/bin/copy_vhd_from_secondarystorage.sh /opt/xensource/bin/create_privatetemplate_from_snapshot.sh /opt/xensource/bin/vhd-util /opt/cloud/bin/copy_vhd_to_secondarystorage.sh /opt/cloud/bin/copy_vhd_from_secondarystorage.sh /opt/cloud/bin/create_privatetemplate_from_snapshot.sh /opt/cloud/bin/vhd-util
2026-08-05 10:38:23,535 INFO [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Host 192.168.55.162 OpaqueRef:03f9a940-16c7-b80e-85e5-d3663e5c88b7: Host 192.168.55.162 is already setup.
2026-08-05 10:38:23,567 WARN [c.c.h.x.r.XenServer650Resource] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) callHostPlugin failed for cmd: setIptables with args due to There was a failure communicating with the plug-in.
2026-08-05 10:38:23,567 WARN [c.c.h.x.r.w.x.CitrixSetupCommandWrapper] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Unable to setup com.cloud.utils.exception.CloudRuntimeException: callHostPlugin failed for cmd: setIptables with args due to There was a failure communicating with the plug-in.
2026-08-05 10:38:23,568 DEBUG [c.c.a.m.D.Task] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Seq 17-5484821396183842817: Response Received:
2026-08-05 10:38:23,568 DEBUG [c.c.a.t.Request] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Seq 17-5484821396183842817: Processing: { Ans: , MgmtId: 206863092181491, via: 17(xenserver-biuwcxrc), Ver: v1, Flags: 110, [{"com.cloud.agent.api.SetupAnswer":{"_reconnect":"true","result":"false","details":"callHostPlugin failed for cmd: setIptables with args due to There was a failure communicating with the plug-in.","wait":"0","bypassHostMaintenance":"false"}}] }
2026-08-05 10:38:23,568 DEBUG [c.c.a.m.ClusteredDirectAgentAttache] (DirectAgent-191:[ctx-d0d665ae]) (logid:14964378) Seq 17-5484821396183842817: No more commands found
2026-08-05 10:38:23,568 DEBUG [c.c.a.t.Request] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Seq 17-5484821396183842817: Received: { Ans: , MgmtId: 206863092181491, via: 17(xenserver-biuwcxrc), Ver: v1, Flags: 110, { SetupAnswer } }
2026-08-05 10:38:23,568 WARN [c.c.h.x.d.XcpServerDiscoverer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Unable to setup agent 17 due to callHostPlugin failed for cmd: setIptables with args due to There was a failure communicating with the plug-in.
2026-08-05 10:38:23,568 INFO [c.c.u.e.CSExceptionErrorCode] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Could not find exception: com.cloud.exception.ConnectionException in error code list for exceptions
2026-08-05 10:38:23,568 WARN [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Monitor XcpServerDiscoverer says there is an error in the connect process for 17 due to Reinitialize agent after setup.
2026-08-05 10:38:23,569 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Acquired lock on host Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}, to process agent disconnection
2026-08-05 10:38:23,569 INFO [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Host AgentAttache {"_id":17,"_name":"xenserver-biuwcxrc","_uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"} is disconnecting with event AgentDisconnected
2026-08-05 10:38:23,569 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) The next status of agent Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"} is Alert, current status is Connecting
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Deregistering link for AgentAttache {"_id":17,"_name":"xenserver-biuwcxrc","_uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"} with state Alert
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Remove Agent : AgentAttache {"_id":17,"_name":"xenserver-biuwcxrc","_uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredDirectAgentAttache] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Processing disconnect [id: 17, uuid: 257e16c5-08f4-4088-8a2b-60a4f69abd9a, name: xenserver-biuwcxrc]
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.xenserver.discoverer.XcpServerDiscoverer
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.hyperv.discoverer.HypervServerDiscoverer
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: org.apache.cloudstack.hypervisor.external.discoverer.ExternalServerDiscoverer
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: org.apache.cloudstack.network.tungsten.service.TungstenElement
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: org.apache.cloudstack.service.NsxElement
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: org.apache.cloudstack.service.NetrisElement
2026-08-05 10:38:23,570 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.storage.listener.StoragePoolMonitor
2026-08-05 10:38:23,570 DEBUG [c.c.s.l.StoragePoolMonitor] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Starting disconnect for Agent [id: 17, uuid: 257e16c5-08f4-4088-8a2b-60a4f69abd9a, name: xenserver-biuwcxrc]
2026-08-05 10:38:23,570 DEBUG [c.c.s.l.StoragePoolMonitor] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Looking for connected Storage Pools for Host [id: 17, uuid: 257e16c5-08f4-4088-8a2b-60a4f69abd9a, name: xenserver-biuwcxrc]
2026-08-05 10:38:23,571 DEBUG [c.c.s.l.StoragePoolMonitor] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Found 0 pools to disconnect for host: Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.vmware.manager.VmwareManagerImpl
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.security.SecurityGroupListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.deploy.DeploymentPlanningManagerImpl
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.storage.secondary.SecondaryStorageListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.vm.ClusteredVirtualMachineManagerImpl
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: org.apache.cloudstack.engine.orchestration.NetworkOrchestrator
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.agent.manager.AgentManagerImpl$BehindOnPingListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.agent.manager.AgentManagerImpl$SetHostParamsListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.SshKeysDistriMonitor
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.router.VpcVirtualNetworkApplianceManagerImpl
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.storage.upload.UploadListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.NetworkUsageManagerImpl$DirectNetworkStatsListener
2026-08-05 10:38:23,571 DEBUG [c.c.n.NetworkUsageManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Disconnected called on [id: 17, uuid: 257e16c5-08f4-4088-8a2b-60a4f69abd9a, name: xenserver-biuwcxrc] with status Alert
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.capacity.StorageCapacityListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.capacity.ComputeCapacityListener
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.SshKeysDistriMonitor
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.network.router.VirtualNetworkApplianceManagerImpl
2026-08-05 10:38:23,571 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.storage.download.DownloadListener
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.consoleproxy.ConsoleProxyListener
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.storage.LocalStoragePoolListener
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.kvm.discoverer.KvmServerDiscoverer
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.kvm.discoverer.LxcServerDiscoverer
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Sending Disconnect to listener: com.cloud.hypervisor.discoverer.CustomServerDiscoverer
2026-08-05 10:38:23,572 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) [Resource state = Enabled, Agent event = , Host = AgentDisconnected]
2026-08-05 10:38:23,593 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Notifying other nodes of to disconnect
2026-08-05 10:38:23,593 WARN [c.c.r.ResourceManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Unable to connect due to com.cloud.exception.ConnectionException: Reinitialize agent after setup.
2026-08-05 10:38:23,593 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) [Resource state = Enabled, Agent event = , Host = AgentDisconnected]
2026-08-05 10:38:23,594 DEBUG [c.c.a.m.ClusteredAgentManagerImpl] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) Cannot transit agent status with event AgentDisconnected for host Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}, management server id is 206863092181491
2026-08-05 10:38:23,594 ERROR [c.c.a.ApiServer] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) unhandled exception executing api command: [Ljava.lang.String;@6a6df8da com.cloud.utils.exception.CloudRuntimeException: Cannot transit agent status with event AgentDisconnected for host Host {"id":17,"name":"xenserver-biuwcxrc","type":"Routing","uuid":"257e16c5-08f4-4088-8a2b-60a4f69abd9a"}, management server id is 206863092181491, Unable to transition to a new state from Creating via AgentDisconnected
2026-08-05 10:38:23,594 DEBUG [c.c.a.ApiServlet] (qtp380274260-3331:[ctx-6d9a580f, ctx-b106b52a]) (logid:14964378) ===END=== 192.168.55.207 -- POST addHost
The required feature described as a wish
As an admin operation i want support for the xenserver 9 release
https://docs.xenserver.com/en-us/xenserver/9/whats-new.html
Currently when i add xenserver 9 as a hypervisor it fails
Python version is 3.11.3 on xenserver 9
Exception on Management server log
Xenserver logs