Ovirt - disk upload nem megy

itt egy hosszabb log:


Command(HostName = node01.hft.rosenberger.local, GetDeviceListVDSCommandParameters:{runAsync='true', hostId='5ecab10c-e920-4d49-b992-c2bb00217fbd', storageType='ISCSI', checkStatus='false', lunIds='null'}), log id: 2ad25816
2017-05-10 11:36:23,359+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetDeviceListVDSCommand] (default task-10) [12f1c6a1-41f1-4867-8d65-8e825368b52a] FINISH, GetDeviceListVDSCommand, return: [], log id: 2ad25816
2017-05-10 11:36:44,665+02 INFO [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler4) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] Not removing session 'YP6RSx6RLus+cChVMb4LzdgwcTNKYM990Irauc+1LsSw0JrB3qhwwexRfZjYaPRe28jSdsHpUyRmnDc2LXm2sQ==', session has running commands for user 'admin@internal-authz'.
2017-05-10 11:36:50,717+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-1) [853e1fe3-0ec4-490e-8760-52252b919a03] Running command: TransferDiskImageCommand internal: false. Entities affected : ID: a7d01eb8-d54a-4ab2-bd71-0e07724c7be0 Type: StorageAction group CREATE_DISK with role type USER
2017-05-10 11:36:50,717+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-1) [853e1fe3-0ec4-490e-8760-52252b919a03] Creating ImageTransfer entity for command '438daa28-a3b1-4c9c-996f-50baf54183a2'
2017-05-10 11:36:50,720+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-1) [853e1fe3-0ec4-490e-8760-52252b919a03] Creating disk image
2017-05-10 11:36:50,747+02 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-1) [] EVENT_ID: TRANSFER_IMAGE_INITIATED(1,031), Correlation ID: 853e1fe3-0ec4-490e-8760-52252b919a03, Call Stack: null, Custom Event ID: -1, Message: Image Upload with disk HUN400-25V_Disk1 was initiated by admin@internal-authz.
2017-05-10 11:36:50,766+02 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (pool-5-thread-7) [6d4deb8] Running command: AddDiskCommand internal: true. Entities affected : ID: a7d01eb8-d54a-4ab2-bd71-0e07724c7be0 Type: StorageAction group CREATE_DISK with role type USER
2017-05-10 11:36:50,798+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (pool-5-thread-7) [32f8ad4d] Running command: AddImageFromScratchCommand internal: true. Entities affected : ID: a7d01eb8-d54a-4ab2-bd71-0e07724c7be0 Type: Storage
2017-05-10 11:36:50,831+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (pool-5-thread-7) [32f8ad4d] START, CreateImageVDSCommand( CreateImageVDSCommandParameters:{runAsync='true', storagePoolId='00000001-0001-0001-0001-000000000311', ignoreFailoverLimit='false', storageDomainId='a7d01eb8-d54a-4ab2-bd71-0e07724c7be0', imageGroupId='bbc68bfe-c3f7-49fa-a6e4-b275c505de1d', imageSizeInBytes='21474836480', volumeFormat='COW', newImageId='628fd365-ad91-4bee-89f8-326f425be92d', newImageDescription='{"DiskAlias":"HUN400-25V_Disk1","DiskDescription":""}', imageInitialSizeInBytes='0'}), log id: 4b2909e6
2017-05-10 11:36:50,832+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (pool-5-thread-7) [32f8ad4d] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
2017-05-10 11:36:51,496+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler4) [853e1fe3-0ec4-490e-8760-52252b919a03] Waiting for disk to be added for image transfer command '438daa28-a3b1-4c9c-996f-50baf54183a2'
2017-05-10 11:36:52,780+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (pool-5-thread-7) [32f8ad4d] FINISH, CreateImageVDSCommand, return: 628fd365-ad91-4bee-89f8-326f425be92d, log id: 4b2909e6
2017-05-10 11:36:52,781+02 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (pool-5-thread-7) [32f8ad4d] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9'
2017-05-10 11:36:52,781+02 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (pool-5-thread-7) [32f8ad4d] CommandMultiAsyncTasks::attachTask: Attaching task '3179373b-5fda-4b19-9f69-ff588f00ea58' to command 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9'.
2017-05-10 11:36:52,805+02 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (pool-5-thread-7) [32f8ad4d] Adding task '3179373b-5fda-4b19-9f69-ff588f00ea58' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet..
2017-05-10 11:36:52,816+02 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (pool-5-thread-7) [32f8ad4d] BaseAsyncTask::startPollingTask: Starting to poll task '3179373b-5fda-4b19-9f69-ff588f00ea58'.
2017-05-10 11:36:52,853+02 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-5-thread-7) [32f8ad4d] EVENT_ID: ADD_DISK_INTERNAL(2,036), Correlation ID: 6d4deb8, Call Stack: null, Custom Event ID: -1, Message: Add-Disk operation of 'HUN400-25V_Disk1' was initiated by the system.
2017-05-10 11:36:53,504+02 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (DefaultQuartzScheduler4) [32f8ad4d] Command 'AddDisk' (id: 'f4c38af9-97a4-4637-8c00-7a7bfe22b5ca') waiting on child command id: 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9' type:'AddImageFromScratch' to complete
2017-05-10 11:36:53,507+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler4) [853e1fe3-0ec4-490e-8760-52252b919a03] Waiting for disk to be added for image transfer command '438daa28-a3b1-4c9c-996f-50baf54183a2'
2017-05-10 11:36:54,770+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-10) [309f0594-96a5-4f86-a2b0-a1e00ac10dbc] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:36:57,005+02 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler6) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now
2017-05-10 11:36:57,348+02 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler6) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] SPMAsyncTask::PollTask: Polling task '3179373b-5fda-4b19-9f69-ff588f00ea58' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'success'.
2017-05-10 11:36:57,348+02 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler6) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] BaseAsyncTask::onTaskEndSuccess: Task '3179373b-5fda-4b19-9f69-ff588f00ea58' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended successfully.
2017-05-10 11:36:57,349+02 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler6) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] CommandAsyncTask::endActionIfNecessary: All tasks of command 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9' has ended -> executing 'endAction'
2017-05-10 11:36:57,349+02 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler6) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9'): calling endAction '.
2017-05-10 11:36:57,349+02 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-39) [df4a4af4-8c4b-43bf-8ae2-2ce70897fbf7] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'AddImageFromScratch',
2017-05-10 11:36:57,517+02 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (DefaultQuartzScheduler1) [32f8ad4d] Command 'AddDisk' id: 'f4c38af9-97a4-4637-8c00-7a7bfe22b5ca' child commands '[f093ef1d-2046-46bd-8dd1-e83b2ddc11d9]' executions were completed, status 'SUCCEEDED'
2017-05-10 11:36:57,518+02 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (DefaultQuartzScheduler1) [32f8ad4d] Command 'AddDisk' id: 'f4c38af9-97a4-4637-8c00-7a7bfe22b5ca' Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands.
2017-05-10 11:36:57,562+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Successfully added Upload disk 'HUN400-25V_Disk1' (id 'bbc68bfe-c3f7-49fa-a6e4-b275c505de1d') for image transfer command '438daa28-a3b1-4c9c-996f-50baf54183a2'
2017-05-10 11:36:57,608+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] START, PrepareImageVDSCommand(HostName = node01.hft.rosenberger.local, PrepareImageVDSCommandParameters:{runAsync='true', hostId='5ecab10c-e920-4d49-b992-c2bb00217fbd'}), log id: 41ce7a39
2017-05-10 11:36:57,627+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-39) [32f8ad4d] FINISH, HSMClearTaskVDSCommand, log id: 70232eb2
2017-05-10 11:36:57,627+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-39) [32f8ad4d] FINISH, SPMClearTaskVDSCommand, log id: 26a0bc06
2017-05-10 11:36:57,632+02 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-39) [32f8ad4d] BaseAsyncTask::removeTaskFromDB: Removed task '3179373b-5fda-4b19-9f69-ff588f00ea58' from DataBase
2017-05-10 11:36:57,632+02 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-39) [32f8ad4d] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 'f093ef1d-2046-46bd-8dd1-e83b2ddc11d9'
2017-05-10 11:36:58,654+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id: 41ce7a39
2017-05-10 11:36:58,655+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] START, SetVolumeLegalityVDSCommand( SetVolumeLegalityVDSCommandParameters:{runAsync='true', storagePoolId='00000001-0001-0001-0001-000000000311', ignoreFailoverLimit='false', storageDomainId='a7d01eb8-d54a-4ab2-bd71-0e07724c7be0', imageGroupId='bbc68bfe-c3f7-49fa-a6e4-b275c505de1d', imageId='628fd365-ad91-4bee-89f8-326f425be92d'}), log id: 7f9920d4
2017-05-10 11:36:58,774+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-7) [cbc56005-f689-4abd-85dc-8ceef88ed956] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:36:59,714+02 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] FINISH, SetVolumeLegalityVDSCommand, log id: 7f9920d4
2017-05-10 11:36:59,715+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] START, AddImageTicketVDSCommand(HostName = node01.hft.rosenberger.local, AddImageTicketVDSCommandParameters:{runAsync='true', hostId='5ecab10c-e920-4d49-b992-c2bb00217fbd', ticketId='9ed861f6-b7d4-4fee-9cdf-c9268bb0e6cd', timeout='300', operations='[write]', size='9533915136', url='file:///rhev/data-center/00000001-0001-0001-0001-000000000311/a7d01eb8-d54a-4ab2-bd71-0e07724c7be0/images/bbc68bfe-c3f7-49fa-a6e4-b275c505de1d/628fd365-ad91-4bee-89f8-326f425be92d'}), log id: b4a5fbf
2017-05-10 11:36:59,748+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] FINISH, AddImageTicketVDSCommand, return: StatusOnlyReturn [status=Status [code=0, message=Done]], log id: b4a5fbf
2017-05-10 11:36:59,748+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Started transfer session with ticket id 9ed861f6-b7d4-4fee-9cdf-c9268bb0e6cd, timeout 300 seconds
2017-05-10 11:36:59,756+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Updating image upload 438daa28-a3b1-4c9c-996f-50baf54183a2 (image bbc68bfe-c3f7-49fa-a6e4-b275c505de1d) phase to Transferring (message: 'Initiating new upload')
2017-05-10 11:36:59,758+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Returning from proceedCommandExecution after starting transfer session for image transfer command '438daa28-a3b1-4c9c-996f-50baf54183a2'
2017-05-10 11:37:02,778+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-14) [715db9be-49bf-439f-a82a-153957bc3873] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:37:08,764+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-13) [93583f2d-1517-49fd-877c-e28716e5397b] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:37:11,905+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-18) [63a7859c-3b80-47f4-9dc6-b75cceef0231] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:37:13,808+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-17) [07371038-41b4-4b60-b3e7-09910b642fdb] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:37:13,809+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater] (default task-17) [07371038-41b4-4b60-b3e7-09910b642fdb] Updating image upload 438daa28-a3b1-4c9c-996f-50baf54183a2 (image bbc68bfe-c3f7-49fa-a6e4-b275c505de1d) phase to Paused by System (message: 'Sent 0MB')
2017-05-10 11:37:13,819+02 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-17) [07371038-41b4-4b60-b3e7-09910b642fdb] EVENT_ID: UPLOAD_IMAGE_NETWORK_ERROR(1,038), Correlation ID: 07371038-41b4-4b60-b3e7-09910b642fdb, Call Stack: null, Custom Event ID: -1, Message: Unable to upload image to disk bbc68bfe-c3f7-49fa-a6e4-b275c505de1d 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.
2017-05-10 11:37:14,828+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Transfer was paused by system. Upload disk 'HUN400-25V_Disk1' (id 'bbc68bfe-c3f7-49fa-a6e4-b275c505de1d')
2017-05-10 11:37:14,842+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.RemoveImageTicketVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] START, RemoveImageTicketVDSCommand(HostName = node01.hft.rosenberger.local, RemoveImageTicketVDSCommandParameters:{runAsync='true', hostId='5ecab10c-e920-4d49-b992-c2bb00217fbd', ticketId='9ed861f6-b7d4-4fee-9cdf-c9268bb0e6cd', timeout='null'}), log id: 61f9680d
2017-05-10 11:37:15,884+02 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.RemoveImageTicketVDSCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] FINISH, RemoveImageTicketVDSCommand, return: StatusOnlyReturn [status=Status [code=0, message=Done]], log id: 61f9680d
2017-05-10 11:37:15,884+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (DefaultQuartzScheduler1) [853e1fe3-0ec4-490e-8760-52252b919a03] Successfully stopped image transfer session for ticket '9ed861f6-b7d4-4fee-9cdf-c9268bb0e6cd'
2017-05-10 11:37:15,895+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-11) [24c89bb0-c00d-4768-8606-52b8fee1130e] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER
2017-05-10 11:37:15,899+02 INFO [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (default task-11) [24c89bb0-c00d-4768-8606-52b8fee1130e] Failed to acquire lock and wait lock 'EngineLock:{exclusiveLocks='[438daa28-a3b1-4c9c-996f-50baf54183a2=]', sharedLocks='null'}'
2017-05-10 11:37:19,884+02 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default task-3) [8d54a0ea-d3a6-46fe-be15-7cfc1710c55a] Running command: TransferImageStatusCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type USER