[ovirt-users] upload ISO from webui failed,"Paused by System"

Tuesday, 11 September 2018

Hi,
    I can't upload iso image from webui,always got "Paused by System"
system info:
    engine:4.2.6.4-1.el7
    vdsm:4.20.35-1.el7
    imageio-proxy:1.4.4-0.el7
    imageio-daemon:1.4.4-0.el7

operation:
    1、download and install ca to the browser
    2、select iso file to upload
    3、click test ，alert to installl ca
    4、install ca again（optional）
    5、upload
    6、wait and got "Paused by System"

log：
engine：
    2018-09-11 11:13:22,273+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-61) [02c871da-a599-4201-9dd5-92a468dee952] START,
HSMClearTaskVDSCommand(HostName = 21,
HSMTaskGuidBaseVDSCommandParameters:{hostId='68f27646-da12-480b-9887-42ada2911132',
taskId='90541bd1-65e7-4185-a051-3d8d9c1e3a5f'}), log id: 3ff168d7
2018-09-11 11:13:22,278+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-61) [02c871da-a599-4201-9dd5-92a468dee952] FINISH,
HSMClearTaskVDSCommand, log id: 3ff168d7
2018-09-11 11:13:22,278+08 INFO 
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-61) [02c871da-a599-4201-9dd5-92a468dee952] FINISH,
SPMClearTaskVDSCommand, log id: 43d30861
2018-09-11 11:13:22,280+08 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-61) [02c871da-a599-4201-9dd5-92a468dee952]
BaseAsyncTask::removeTaskFromDB: Removed task
'90541bd1-65e7-4185-a051-3d8d9c1e3a5f' from DataBase
2018-09-11 11:13:22,280+08 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-61) [02c871da-a599-4201-9dd5-92a468dee952]
CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks
object for entity '4ff92f68-8353-40ac-a7c5-f0efbd054841'
2018-09-11 11:13:26,098+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-8)
[352651c9-ddde-4e1e-b95c-05ad967ed0b1] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER
2018-09-11 11:13:28,836+08 INFO 
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Command 'AddDisk' id: '4b72410d-e5a0-4c43-b7db-a5324a32d012' child
commands '[4ff92f68-8353-40ac-a7c5-f0efbd054841]' executions were completed,
status 'SUCCEEDED'
2018-09-11 11:13:28,836+08 INFO 
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Command 'AddDisk' id: '4b72410d-e5a0-4c43-b7db-a5324a32d012' Updating
status to 'SUCCEEDED', The command end method logic will be executed by one of its
parent commands.
2018-09-11 11:13:28,862+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Successfully added Upload disk 'oVirt-toolsSetup-4.2-1.el7.centos.iso' (disk id:
'97179509-65eb-4b45-ad8e-ce112cfd016a', image id:
'6ca217cc-015e-4d00-872a-faf60a8954ac') for image transfer command
'4cdff02c-7fe4-4000-9c92-8ef613597d13'
2018-09-11 11:13:28,892+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
START, PrepareImageVDSCommand(HostName = 21,
PrepareImageVDSCommandParameters:{hostId='68f27646-da12-480b-9887-42ada2911132'}),
log id: 19407261
2018-09-11 11:13:28,901+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0,
message=Done]'}, log id: 19407261
2018-09-11 11:13:28,901+08 INFO 
[org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
START, SetVolumeLegalityVDSCommand(
SetVolumeLegalityVDSCommandParameters:{storagePoolId='ab65cc43-3c9e-4c02-ba75-ccd9fa8691b1',
ignoreFailoverLimit='false',
storageDomainId='ffc618b9-fd75-4ca2-ace4-15a1b7b58ecf',
imageGroupId='97179509-65eb-4b45-ad8e-ce112cfd016a',
imageId='6ca217cc-015e-4d00-872a-faf60a8954ac'}), log id: 5068b962
2018-09-11 11:13:28,914+08 INFO 
[org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
FINISH, SetVolumeLegalityVDSCommand, log id: 5068b962
2018-09-11 11:13:28,915+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
START, AddImageTicketVDSCommand(HostName = 21,
AddImageTicketVDSCommandParameters:{hostId='68f27646-da12-480b-9887-42ada2911132',
ticketId='3564a630-be37-407f-802d-ce38a01cc104', timeout='300',
operations='[write]', size='382971904',
url='file:///rhev/data-center/mnt/_data/ffc618b9-fd75-4ca2-ace4-15a1b7b58ecf/images/97179509-65eb-4b45-ad8e-ce112cfd016a/6ca217cc-015e-4d00-872a-faf60a8954ac',
filename='null', sparse='true'}), log id: 64950261
2018-09-11 11:13:28,920+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
FINISH, AddImageTicketVDSCommand, return: StatusOnlyReturn [status=Status [code=0,
message=Done]], log id: 64950261
2018-09-11 11:13:28,920+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Started transfer session with ticket id 3564a630-be37-407f-802d-ce38a01cc104, timeout 300
seconds
2018-09-11 11:13:28,920+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Adding image ticket to ovirt-imageio-proxy, id 3564a630-be37-407f-802d-ce38a01cc104
2018-09-11 11:13:28,934+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Updating image transfer 4cdff02c-7fe4-4000-9c92-8ef613597d13 (image
97179509-65eb-4b45-ad8e-ce112cfd016a) phase to Transferring
2018-09-11 11:13:28,935+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-55) [02c871da-a599-4201-9dd5-92a468dee952]
Returning from proceedCommandExecution after starting transfer session for image transfer
command '4cdff02c-7fe4-4000-9c92-8ef613597d13'
2018-09-11 11:13:29,948+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-56) [02c871da-a599-4201-9dd5-92a468dee952]
START, GetImageTicketVDSCommand(HostName = 21,
GetImageTicketVDSCommandParameters:{hostId='68f27646-da12-480b-9887-42ada2911132',
ticketId='3564a630-be37-407f-802d-ce38a01cc104', timeout='null'}), log id:
1b9af167
2018-09-11 11:13:29,952+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-56) [02c871da-a599-4201-9dd5-92a468dee952]
FINISH, GetImageTicketVDSCommand, return:
org.ovirt.engine.core.common.businessentities.storage.ImageTicketInformation@558504b3, log
id: 1b9af167
2018-09-11 11:13:30,111+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[c1647c4b-63fe-4ca7-b4a1-adb77c85e076] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER
2018-09-11 11:13:42,126+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[32ab474a-5bd4-4026-b653-67b2a6d776b9] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER
2018-09-11 11:13:44,039+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-44) [02c871da-a599-4201-9dd5-92a468dee952]
START, GetImageTicketVDSCommand(HostName = 21,
GetImageTicketVDSCommandParameters:{hostId='68f27646-da12-480b-9887-42ada2911132',
ticketId='3564a630-be37-407f-802d-ce38a01cc104', timeout='null'}), log id:
66ab6e50
2018-09-11 11:13:44,044+08 INFO 
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-44) [02c871da-a599-4201-9dd5-92a468dee952]
FINISH, GetImageTicketVDSCommand, return:
org.ovirt.engine.core.common.businessentities.storage.ImageTicketInformation@558504c1, log
id: 66ab6e50
2018-09-11 11:13:46,135+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[1e65c0eb-95b0-4152-9887-5fa9521bb0a9] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER

2018-09-11 11:13:48,327+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[4ad6f0ea-2ae5-4067-b1c2-c0503b2e3676] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER
2018-09-11 11:13:48,328+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater] (default task-6)
[4ad6f0ea-2ae5-4067-b1c2-c0503b2e3676] Updating image transfer
4cdff02c-7fe4-4000-9c92-8ef613597d13 (image 97179509-65eb-4b45-ad8e-ce112cfd016a) phase to
Paused by System (message: 'Sent 0MB')
2018-09-11 11:13:48,335+08 ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-6)
[4ad6f0ea-2ae5-4067-b1c2-c0503b2e3676] EVENT_ID: UPLOAD_IMAGE_NETWORK_ERROR(1,062), Unable
to upload image to disk 97179509-65eb-4b45-ad8e-ce112cfd016a due to a network error. Make
sure ovirt-imageio-proxy service is installed and configured, and ovirt-engine's
certificate is registered as a valid CA in the browser. The certificate can be fetched
from
https://<engine_url>/ovirt-engine/services/pki-resource?resource=ca-certificate&format=X509-PEM-CA
2018-09-11 11:13:50,220+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[2a9835b2-a08d-4efd-9fa0-208d14dd4bdc] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER
2018-09-11 11:13:54,080+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-60) [02c871da-a599-4201-9dd5-92a468dee952]
Transfer was paused by system. Upload disk 'oVirt-toolsSetup-4.2-1.el7.centos.iso'
(disk id: '97179509-65eb-4b45-ad8e-ce112cfd016a', image id:
'6ca217cc-015e-4d00-872a-faf60a8954ac')
2018-09-11 11:13:54,196+08 INFO 
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-6)
[3742a3f4-4352-46c4-8480-0035e8d7a5fb] Running command: TransferImageStatusCommand
internal: false. Entities affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type:
SystemAction group CREATE_DISK with role type USER

imageio-proxy：

(Thread-4  ) INFO 2018-09-11 11:12:32,476 auth:201:auth2:(delete_ticket) Deleting ticket
u'9a8117e4-2ba0-40c3-ae3d-aadc43b7857d'
(Thread-5  ) INFO 2018-09-11 11:13:28,929 auth:187:auth2:(add_signed_ticket) Adding new
ticket: <Ticket id=u'3564a630-be37-407f-802d-ce38a01cc104',
url=u'https://172.22.224.21:54322' timeout=35999.070008039474 at
0x7fa30cdd6b50>

imageio-daemon：

2018-09-11 11:13:28,402 INFO    (Thread-12) [tickets] [local] ADD ticket={u'uuid':
u'3564a630-be37-407f-802d-ce38a01cc104', u'ops': [u'write'],
u'url':
u'file:///rhev/data-center/mnt/_data/ffc618b9-fd75-4ca2-ace4-15a1b7b58ecf/images/97179509-65eb-4b45-ad8e-ce112cfd016a/6ca217cc-015e-4d00-872a-faf60a8954ac',
u'sparse': True, u'timeout': 300, u'size': 382971904}

I‘ve been stucked for days and need to get help！

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

[ovirt-users] upload ISO from webui failed,"Paused by System"