On Mon, Aug 3, 2020 at 8:55 AM zhouhao(a)vip.friendtimes.net
<zhouhao(a)vip.friendtimes.net> wrote:
We need basic detail on this issue like oVirt version used, but this
smells like this bug:
Note that this issue is only about the proxy, you can upload images
directly the host using
the SDK:
Here is example upload on my test environment:
$ ./upload_disk.py --engine-url
\
--username admin@internal \
--password-file engine3-password \
--cafile engine3.pem \
--sd-name nfs1 \
--disk-format raw \
--disk-sparse \
/var/tmp/fedora-32.raw
Checking image...
Image format: raw
Disk format: raw
Disk content type: data
Disk provisioned size: 6442450944
Disk initial size: 6442450944
Disk name: fedora-32.raw
Disk backup: False
Connecting...
Creating disk...
Disk ID: 139c29a3-b9a8-4501-836d-92417c3d2eaf
Creating image transfer...
Transfer ID: d50a1b50-5bd8-417e-a950-d3a19a262daa
Transfer host name: host4
Uploading image...
[ 100.00% ] 6.00 GiB, 3.01 seconds, 1.99 GiB/s
Finalizing image transfer...
Upload completed successfully
Nir
THE LOGS BELOW
————————
2020-08-03 13:37:42,276+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default
task-28) [272b83fa-1d1a-473e-b72a-19886433801e] Running command:
TransferImageStatusCommand internal: false. Entities affected : ID:
aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type
USER
2020-08-03 13:37:43,679+08 INFO [org.ovirt.engine.core.sso.utils.AuthenticationUtils]
(default task-27) [] User yuanqing(a)ft.com successfully logged in with scopes:
ovirt-app-admin ovirt-app-api ovirt-app-portal ovirt-ext=auth:sequence-priority=~
ovirt-ext=revoke:revoke-all ovirt-ext=token-info:authz-search
ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate
ovirt-ext=token:password-access
2020-08-03 13:37:43,773+08 INFO [org.ovirt.engine.core.bll.aaa.CreateUserSessionCommand]
(default task-27) [1e6c5da4] Running command: CreateUserSessionCommand internal: false.
2020-08-03 13:37:43,814+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-27)
[1e6c5da4] EVENT_ID: USER_VDC_LOGIN(30), User yuanqing@ft.com(a)ft.com connecting from
'192.168.16.199' using session
'AkdaHSmXHYlF3v53VoJRWVCIp0VYjFJPcR/vbRs0tfT20Qq9zylnacmSQKJJ8kwkWmj392Lq8j6EFcz22BKdTg=='
logged in.
2020-08-03 13:37:44,428+08 INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Command 'AddDisk' id: '0f22fdf1-6016-40f3-9768-b436b5c83972' child
commands '[abaa6f3d-82a1-4317-857e-0c32e3ffeca1]' executions were completed,
status 'SUCCEEDED'
2020-08-03 13:37:44,428+08 INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Command 'AddDisk' id: '0f22fdf1-6016-40f3-9768-b436b5c83972' Updating
status to 'SUCCEEDED', The command end method logic will be executed by one of its
parent commands.
2020-08-03 13:37:44,488+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Successfully added Upload disk 'vyos-1.1.8-amd64.iso' (disk id:
'2720658b-c1cb-4021-810c-8333e80858eb', image id:
'6a61dee5-fc07-4afb-af81-3672b9077a3a') for image transfer command
'900b725e-d409-4192-bb52-c52cb29b37ee'
2020-08-03 13:37:44,524+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
START, PrepareImageVDSCommand(HostName = 192.168.4.23,
PrepareImageVDSCommandParameters:{hostId='b6142941-cc9e-4da3-b66d-5132f359edb5'}),
log id: 4bfe1a2c
2020-08-03 13:37:44,640+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0,
message=Done]'}, log id: 4bfe1a2c
2020-08-03 13:37:44,641+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
START, SetVolumeLegalityVDSCommand(
SetVolumeLegalityVDSCommandParameters:{storagePoolId='17fae97b-4a94-4de5-88c0-0743ab2b9ab8',
ignoreFailoverLimit='false',
storageDomainId='0d707e2b-42ed-48d4-9675-2021a3840f40',
imageGroupId='2720658b-c1cb-4021-810c-8333e80858eb',
imageId='6a61dee5-fc07-4afb-af81-3672b9077a3a'}), log id: 31d7b9fe
2020-08-03 13:37:44,658+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SetVolumeLegalityVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
FINISH, SetVolumeLegalityVDSCommand, return: , log id: 31d7b9fe
2020-08-03 13:37:44,659+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
START, AddImageTicketVDSCommand(HostName = 192.168.4.23,
AddImageTicketVDSCommandParameters:{hostId='b6142941-cc9e-4da3-b66d-5132f359edb5',
ticketId='de8fa245-78ca-4d0a-b0b3-b7897aec7af6', timeout='300',
operations='[write]', size='241172480',
url='file:///rhev/data-center/mnt/_vmdata/0d707e2b-42ed-48d4-9675-2021a3840f40/images/2720658b-c1cb-4021-810c-8333e80858eb/6a61dee5-fc07-4afb-af81-3672b9077a3a',
filename='null', sparse='true',
transferId='900b725e-d409-4192-bb52-c52cb29b37ee'}), log id: 1687202b
2020-08-03 13:37:44,668+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.AddImageTicketVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
FINISH, AddImageTicketVDSCommand, return: StatusOnlyReturn [status=Status [code=0,
message=Done]], log id: 1687202b
2020-08-03 13:37:44,668+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Started transfer session with ticket id de8fa245-78ca-4d0a-b0b3-b7897aec7af6, timeout 300
seconds
2020-08-03 13:37:44,668+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Adding image ticket to ovirt-imageio-proxy, id de8fa245-78ca-4d0a-b0b3-b7897aec7af6
2020-08-03 13:37:44,679+08 ERROR
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Failed to add image ticket to ovirt-imageio-proxy: javax.net.ssl.SSLHandshakeException:
java.security.cert.CertificateException: No subject alternative DNS name matching
vdesk.bojoy.net found.
at sun.security.ssl.Alerts.getSSLException(Alerts.java:192) [jsse.jar:1.8.0_212]
at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1946) [jsse.jar:1.8.0_212]
at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:316) [jsse.jar:1.8.0_212]
at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:310) [jsse.jar:1.8.0_212]
at sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.java:1639)
[jsse.jar:1.8.0_212]
at sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.java:223)
[jsse.jar:1.8.0_212]
at sun.security.ssl.Handshaker.processLoop(Handshaker.java:1037) [jsse.jar:1.8.0_212]
at sun.security.ssl.Handshaker.process_record(Handshaker.java:965) [jsse.jar:1.8.0_212]
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1064)
[jsse.jar:1.8.0_212]
at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1367)
[jsse.jar:1.8.0_212]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1395)
[jsse.jar:1.8.0_212]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1379)
[jsse.jar:1.8.0_212]
at sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:559)
[rt.jar:1.8.0_212]
at
sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185)
[rt.jar:1.8.0_212]
at
sun.net.www.protocol.http.HttpURLConnection.getOutputStream0(HttpURLConnection.java:1334)
[rt.jar:1.8.0_212]
at
sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:1309)
[rt.jar:1.8.0_212]
at
sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:259)
[rt.jar:1.8.0_212]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.addImageTicketToProxy(TransferDiskImageCommand.java:988)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.startImageTransferSession(TransferDiskImageCommand.java:911)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleImageIsReadyForTransfer(TransferDiskImageCommand.java:554)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleInitializing(TransferDiskImageCommand.java:525)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.executeStateHandler(TransferDiskImageCommand.java:460)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.proceedCommandExecution(TransferDiskImageCommand.java:447)
[bll.jar:]
at
org.ovirt.engine.core.bll.storage.disk.image.TransferImageCommandCallback.doPolling(TransferImageCommandCallback.java:21)
[bll.jar:]
at
org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller.invokeCallbackMethodsImpl(CommandCallbacksPoller.java:175)
[bll.jar:]
at
org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller.invokeCallbackMethods(CommandCallbacksPoller.java:109)
[bll.jar:]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[rt.jar:1.8.0_212]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [rt.jar:1.8.0_212]
at
org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.access$201(ManagedScheduledThreadPoolExecutor.java:383)
[javax.enterprise.concurrent-1.0.jar:]
at
org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.run(ManagedScheduledThreadPoolExecutor.java:534)
[javax.enterprise.concurrent-1.0.jar:]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[rt.jar:1.8.0_212]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[rt.jar:1.8.0_212]
at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_212]
at
org.glassfish.enterprise.concurrent.ManagedThreadFactoryImpl$ManagedThread.run(ManagedThreadFactoryImpl.java:250)
[javax.enterprise.concurrent-1.0.jar:]
at
org.jboss.as.ee.concurrent.service.ElytronManagedThreadFactory$ElytronManagedThread.run(ElytronManagedThreadFactory.java:78)
Caused by: java.security.cert.CertificateException: No subject alternative DNS name
matching
vdesk.bojoy.net found.
at sun.security.util.HostnameChecker.matchDNS(HostnameChecker.java:214)
[rt.jar:1.8.0_212]
at sun.security.util.HostnameChecker.match(HostnameChecker.java:96) [rt.jar:1.8.0_212]
at sun.security.ssl.X509TrustManagerImpl.checkIdentity(X509TrustManagerImpl.java:455)
[jsse.jar:1.8.0_212]
at sun.security.ssl.X509TrustManagerImpl.checkIdentity(X509TrustManagerImpl.java:436)
[jsse.jar:1.8.0_212]
at sun.security.ssl.X509TrustManagerImpl.checkTrusted(X509TrustManagerImpl.java:200)
[jsse.jar:1.8.0_212]
at
sun.security.ssl.X509TrustManagerImpl.checkServerTrusted(X509TrustManagerImpl.java:124)
[jsse.jar:1.8.0_212]
at sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.java:1621)
[jsse.jar:1.8.0_212]
... 30 more
2020-08-03 13:37:44,680+08 ERROR
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Failed to add image ticket to ovirt-imageio-proxy
2020-08-03 13:37:44,691+08 ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
EVENT_ID: TRANSFER_IMAGE_STOPPED_BY_SYSTEM_FAILED_TO_ADD_TICKET_TO_PROXY(1,070), Transfer
was stopped by system. Reason: failed to add image ticket to ovirt-imageio-proxy.
2020-08-03 13:37:44,693+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Updating image transfer 900b725e-d409-4192-bb52-c52cb29b37ee (image
2720658b-c1cb-4021-810c-8333e80858eb) phase to Paused by System
2020-08-03 13:37:44,700+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Returning from proceedCommandExecution after starting transfer session for image transfer
command '900b725e-d409-4192-bb52-c52cb29b37ee'
2020-08-03 13:37:44,751+08 ERROR [org.ovirt.engine.core.bll.GetPermissionsForObjectQuery]
(default task-28) [d1ae3442-a241-458f-a0cc-1a9ee9a3d0aa] Query execution failed due to
insufficient permissions.
2020-08-03 13:37:44,752+08 ERROR
[org.ovirt.engine.api.restapi.resource.AbstractBackendResource] (default task-28) []
Operation Failed: query execution failed due to insufficient permissions.
2020-08-03 13:37:45,760+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-90) [2a5567e7-25bc-4d58-ab31-8f88f5a4a5fa]
Transfer was paused by system. Upload disk 'vyos-1.1.8-amd64.iso' (disk id:
'2720658b-c1cb-4021-810c-8333e80858eb', image id:
'6a61dee5-fc07-4afb-af81-3672b9077a3a')
2020-08-03 13:37:46,263+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand] (default
task-32) [86b6811a-69a1-4771-b7dc-decaee05edf2] Running command:
TransferImageStatusCommand internal: false. Entities affected : ID:
aaa00000-0000-0000-0000-123456789aaa Type: SystemAction group CREATE_DISK with role type
USER
2020-08-03 13:37:49,107+08 INFO
[org.ovirt.engine.core.bll.AttachUserToVmFromPoolAndRunCommand] (default task-32)
[97b00c94-904c-454e-bd5e-b4500a3e4a89] Lock Acquired to object
'EngineLock:{exclusiveLocks='[513a013e-7a92-4a28-801c-b1ceefcb551d=VM,
05230164-af26-468d-b1c9-32f2e4d64569=USER_VM_POOL]', sharedLocks=''}'
2020-08-03 13:37:49,196+08 INFO
[org.ovirt.engine.core.bll.AttachUserToVmFromPoolAndRunCommand] (default task-32)
[97b00c94-904c-454e-bd5e-b4500a3e4a89] Running command:
AttachUserToVmFromPoolAndRunCommand internal: false. Entities affected : ID:
77584b78-82a4-48de-8b75-78ff3628a5b7 Type: VmPoolAction group VM_POOL_BASIC_OPERATIONS
with role type USER
________________________________
zhouhao(a)vip.friendtimes.net
_______________________________________________
Users mailing list -- users(a)ovirt.org
To unsubscribe send an email to users-leave(a)ovirt.org
Privacy Statement:
https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct:
https://www.ovirt.org/community/about/community-guidelines/
List Archives:
https://lists.ovirt.org/archives/list/users@ovirt.org/message/DCF53I4GOXY...