[ovirt-devel] Re: imageio proxy and engine dev setup

Hi Nir, First of all, thanks for your continued support with this issue, I do appreciate it! >What is the result of the test in the UI? I guess you get yellow warning? Yes. "Connection to ovirt-imageio-proxy service has failed. Make sure the service is installed, configured, and ovirt-engine certificate is registered as a valid CA in the browser." >$ENGINE_PREFIX/etc/ovirt-imageio-proxy/image-proxy.conf there is no such file for me, only logger.conf there I must notice, imageio proxy is running: apple 1211 0.0 0.3 295616 25756 pts/0 Sl 11:18 0:03 python git/ovirt-imageio/proxy/ovirt-imageio-proxy image-proxy.log is very uneventful: (MainThread) INFO 2019-02-08 11:18:17,239 server:45:server:(start) Starting (pid=1211, version=1.5.0) (MainThread) INFO 2019-02-08 11:18:17,245 image_proxy:26:root:(main) Server started, unable to notify systemd >answers file vi ovirt-engine/var/lib/ovirt-engine/setup/answers/20190207155217-setup.conf OTOPI answer file, generated by human dialog [environment:default] QUESTION/1/OVESETUP_CONFIG_ADMIN_SETUP=str:engine QUESTION/1/OVESETUP_CONFIG_APPLICATION_MODE=str:both QUESTION/1/OVESETUP_CONFIG_IMAGEIO_PROXY=str:yes QUESTION/1/OVESETUP_CONFIG_SAN_WIPE_AFTER_DELETE=str:no QUESTION/1/OVESETUP_CONFIG_VMCONSOLE_PROXY=str:yes QUESTION/1/OVESETUP_CONFIG_WEBSOCKET_PROXY=str:yes QUESTION/1/OVESETUP_DIALOG_CONFIRM_SETTINGS=str:ok QUESTION/1/OVESETUP_ENGINE_DB_DATABASE=str:engine QUESTION/1/OVESETUP_ENGINE_DB_HOST=str:localhost QUESTION/1/OVESETUP_ENGINE_DB_PASSWORD=str:engine QUESTION/1/OVESETUP_ENGINE_DB_PORT=str:5432 QUESTION/1/OVESETUP_ENGINE_DB_SECURED=str:no QUESTION/1/OVESETUP_ENGINE_DB_USER=str:engine QUESTION/1/OVESETUP_ENGINE_ENABLE=str:yes QUESTION/1/OVESETUP_NETWORK_FQDN_this=str:localhost.localdomain QUESTION/1/OVESETUP_PKI_ORG=str:localdomain QUESTION/1/OVESETUP_SYSTEM_UNPRIVILEGED=str:yes QUESTION/1/ovirt-provider-ovn=str:no QUESTION/2/OVESETUP_CONFIG_ADMIN_SETUP=str:engine >Trying to upload to proxy or daemon? from the UI or using upload_disk.py example? From what I understood from the doc, imageio proxy needs to be running where the engine is, imageio daemon needs to be running where host is and machine from where the file is uploaded needs neither. So, yeah, that's what I did. From the client machine with nothign but certificate installed (192.168.111.1) I am accessing the engine (192.168.111.2) through UI and trying to upload an image to a data domain accessed by and located on the host (192.168.111.3). > Did you restart engine after changing the config? I did a fresh install, so the only time I configured the engine was already with imageio included. But anyway, I restarted it today, same UI warning, same (lack of) results. > Did you add engine CA to the browser? Yes, added it to the browser of client machine aka 192.168.111.1. No certificate juggling needs to be done to engine and host machines from what I understood, right? > Did you check the browser console.log? Yes. There is an error but seems to be unrelated. Here is the log from my firefox: Fri Feb 08 11:26:59 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Polling for status webadmin:1:8676 Fri Feb 08 11:26:59 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Upload phase: Resuming webadmin:1:8676 Fri Feb 08 11:27:03 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Polling for status webadmin:1:8676 Fri Feb 08 11:27:03 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Upload phase: Resuming webadmin:1:8676 Fri Feb 08 11:27:07 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Polling for status webadmin:1:8676 Fri Feb 08 11:27:07 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Upload phase: Transferring webadmin:1:8676 Fri Feb 08 11:27:07 GMT+100 2019 SEVERE: Uncaught exception com.google.gwt.core.client.JavaScriptException: (TypeError) : a.n is null at Unknown.BFs(webadmin-147.js) at Unknown._Fs(webadmin-147.js) at Unknown.K_p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.x0p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.A0p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.N2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Q2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.n2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.q2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.i8e( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.F1( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.U1( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.onreadystatechange<( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Qu( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Tu( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Su/<( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.anonymous(Unknown) webadmin:1:8591 Fri Feb 08 11:27:07 GMT+100 2019 remote SEVERE: Uncaught exception com.google.gwt.core.client.JavaScriptException: (TypeError) : a.n is null at Unknown.BFs(webadmin-147.js) at Unknown._Fs(webadmin-147.js) at Unknown.K_p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.x0p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.A0p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.N2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Q2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.n2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.q2p( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.i8e( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.F1( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.U1( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.onreadystatechange<( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Qu( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Tu( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.Su/<( http://192.168.111.2:8080/ovirt-engine/webadmin/?locale=en_US) at Unknown.anonymous(Unknown) webadmin:1:8591 Fri Feb 08 11:27:11 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Polling for status webadmin:1:8676 Fri Feb 08 11:27:11 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Upload phase: Transferring webadmin:1:8676 Fri Feb 08 11:27:15 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Polling for status webadmin:1:8676 Fri Feb 08 11:27:15 GMT+100 2019 org.ovirt.engine.ui.uicommonweb.models.storage.UploadImageHandler INFO: Upload phase: Paused by System > Can you share your logs? Please let me know if there are additional logs needed. I think this + previous email is all I got. > Maybe you can be interested in implementing this? I am for sure, I would be glad to simplify the process if possible, but let me first understand how this thing works right now :) Btw I have my notes about what needs to be fixed with dev docs for both engine and imageio (lacking python libs, postgres needs some caressing etc.), so I'm planning to improve documentation a bit. Well, after I can get imageio working. Thanks, Fedor ----- Original Message ----- From: "Nir Soffer" <nsoffer(a)redhat.com&gt; To: "Fedor Gavrilov" <fgavrilo(a)redhat.com&gt; Cc: "Roy Golan" <rgolan(a)redhat.com&gt;, "devel" <devel(a)ovirt.org&gt;, "Daniel Erez" <derez(a)redhat.com&gt;, "Yedidyah Bar David" <didi(a)redhat.com&gt; Sent: Thursday, February 7, 2019 6:42:48 PM Subject: Re: [ovirt-devel] Re: imageio proxy and engine dev setup On Thu, Feb 7, 2019 at 7:32 PM Fedor Gavrilov <fgavrilo(a)redhat.com&gt; wrote: > I just did a fresh setup, applying the latest suggestions and it seems now > there is ab error message in the engine log when I press "test connection" > in upload image window: > What is the result of the test in the UI? I guess you get yellow warning? > > *** > 192.168.111.1 is machine where iso is > 192.168.111.2 is engine > 192.168.111.3 is host and nfs storage > *** > > ---------------------------------------- > Exception happened during processing of request from ('192.168.111.1', > 46230) > Traceback (most recent call last): > File "/usr/lib64/python2.7/SocketServer.py", line 596, in > process_request_thread > self.finish_request(request, client_address) > File "/usr/lib64/python2.7/SocketServer.py", line 331, in finish_request > self.RequestHandlerClass(request, client_address, self) > File "/usr/lib64/python2.7/SocketServer.py", line 652, in __init__ > self.handle() > File "/usr/lib64/python2.7/wsgiref/simple_server.py", line 116, in handle > self.raw_requestline = self.rfile.readline(65537) > File "/usr/lib64/python2.7/socket.py", line 480, in readline > data = self._sock.recv(self._rbufsize) > File "/usr/lib64/python2.7/ssl.py", line 772, in recv > return self.read(buflen) > File "/usr/lib64/python2.7/ssl.py", line 659, in read > v = self._sslobj.read(len) > SSLError: [SSL: SSLV3_ALERT_BAD_CERTIFICATE] sslv3 alert bad certificate > (_ssl.c:1941) > ---------------------------------------- > This looks like bad proxy configuration, it does not accept the engine certificate. Can you share: - $ENGINE_PREFIX/etc/ovirt-imageio-proxy/image-proxy.conf? - your engine-setup answer file Didi, where do we keep the answer file? Not sure what it means though. Certificate is installed in my browser, just > double-checked that. > When trying to upload the file nevertheless, this is what appears in > engine logs: > Trying to upload to proxy or daemon? from the UI or using upload_disk.py example? 2019-02-07 18:27:34,768+01 INFO > [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] > (EE-ManagedThreadFactory-engineScheduled-Thread-56) > [1b6235be-02b4-446a-b486-22cce0d7a1bb] Adding image ticket to > ovirt-imageio-proxy, id 00e11769-70c4-4b92-9cb9-4ff633566d8e > 2019-02-07 18:27:34,820+01 ERROR > [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] > (EE-ManagedThreadFactory-engineScheduled-Thread-56) > [1b6235be-02b4-446a-b486-22cce0d7a1bb] Failed to add image ticket to > ovirt-imageio-proxy: javax.net.ssl.SSLHandshakeException: > java.security.cert.CertificateException: No subject alternative names > matching IP address 192.168.111.2 found > at sun.security.ssl.Alerts.getSSLException(Alerts.java:192) > [jsse.jar:1.8.0_191] > at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1946) > [jsse.jar:1.8.0_191] > at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:316) > [jsse.jar:1.8.0_191] > at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:310) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.java:1639) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.java:223) > [jsse.jar:1.8.0_191] > at sun.security.ssl.Handshaker.processLoop(Handshaker.java:1037) > [jsse.jar:1.8.0_191] > at sun.security.ssl.Handshaker.process_record(Handshaker.java:965) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1064) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1367) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1395) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1379) > [jsse.jar:1.8.0_191] > at > sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:559) > [rt.jar:1.8.0_191] > at > sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185) > [rt.jar:1.8.0_191] > at > sun.net.www.protocol.http.HttpURLConnection.getOutputStream0(HttpURLConnection.java:1334) > [rt.jar:1.8.0_191] > at > sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:1309) > [rt.jar:1.8.0_191] > at > sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:259) > [rt.jar:1.8.0_191] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.addImageTicketToProxy(TransferDiskImageCommand.java:837) > [bll.jar:] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.startImageTransferSession(TransferDiskImageCommand.java:763) > [bll.jar:] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleImageIsReadyForTransfer(TransferDiskImageCommand.java:452) > [bll.jar:] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleInitializing(TransferDiskImageCommand.java:423) > [bll.jar:] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.executeStateHandler(TransferDiskImageCommand.java:358) > [bll.jar:] > at > org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.proceedCommandExecution(TransferDiskImageCommand.java:345) > [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_191] > at > java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) > [rt.jar:1.8.0_191] > 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_191] > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) > [rt.jar:1.8.0_191] > at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_191] > 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 > names matching IP address 192.168.111.2 found > at > sun.security.util.HostnameChecker.matchIP(HostnameChecker.java:168) > [rt.jar:1.8.0_191] > at > sun.security.util.HostnameChecker.match(HostnameChecker.java:94) > [rt.jar:1.8.0_191] > at > sun.security.ssl.X509TrustManagerImpl.checkIdentity(X509TrustManagerImpl.java:455) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.X509TrustManagerImpl.checkIdentity(X509TrustManagerImpl.java:436) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.X509TrustManagerImpl.checkTrusted(X509TrustManagerImpl.java:200) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.X509TrustManagerImpl.checkServerTrusted(X509TrustManagerImpl.java:124) > [jsse.jar:1.8.0_191] > at > sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.java:1621) > [jsse.jar:1.8.0_191] > ... 30 more > > 2019-02-07 18:27:34,830+01 ERROR > [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] > (EE-ManagedThreadFactory-engineScheduled-Thread-56) > [1b6235be-02b4-446a-b486-22cce0d7a1bb] Failed to add image ticket to > ovirt-imageio-proxy > Expected when proxy will not accept engine request because of bad certificate. > 2019-02-07 18:27:34,836+01 ERROR > [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] > (EE-ManagedThreadFactory-engineScheduled-Thread-56) > [1b6235be-02b4-446a-b486-22cce0d7a1bb] 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. > > I will continue looking into it tomorrow as well, but any advice is much > appreciated. > > Thanks, > Fedor Gavrilov > > ----- Original Message ----- > From: "Nir Soffer" <nsoffer(a)redhat.com&gt; > To: "Fedor Gavrilov" <fgavrilo(a)redhat.com&gt; > Cc: "Roy Golan" <rgolan(a)redhat.com&gt;, "devel" <devel(a)ovirt.org&gt;, "Daniel > Erez" <derez(a)redhat.com&gt; > Sent: Wednesday, February 6, 2019 10:26:00 PM > Subject: Re: [ovirt-devel] Re: imageio proxy and engine dev setup > > On Wed, Feb 6, 2019 at 12:24 PM Fedor Gavrilov <fgavrilo(a)redhat.com&gt; > wrote: > > First, please keep Daniel in the CC, this is your best chance to get a help > on > this, and a good practice for most issues :-) > > Thanks, Roy! I will try setting it up according to what you suggested. > > Last attempt failed indeed: according to logs, both daemon and proxy > tried > > establishing a connection with each other with some 200 OK in logs, no > > error messages but nevertheless upload did not happen after all. > > > > Did you restart engine after changing the config? > Did you add engine CA to the browser? > Did you check the browser console.log? > Can you share your logs? > Can you reply to these questions? > Speaking about it, does anyone know more straightforward way to have ISO > > disk on data domain? > > > Uploading from the UI is the most straightforward way. But you need to get > a working setup > first. > > I am not as much interested in debugging ISO upload but rather attaching it > > to VM. > > > > Sad that you are not interested in this yet, but in the meantime you can > use the ovirt SDK > upload_disk.py example. > > 1. install first the ovirt python sdk version 4: > > dnf install python3-ovirt-engine-sdk4 > > 2. Download the upload disk example: > > > > https://github.com/oVirt/ovirt-engine-sdk/blob/master/sdk/examples/upload... > > 3. Change the configuration to match your setup (e.g. storage domain name) > > 4. Upload: > > python upload_disk.py --direct /path/to/disk.iso >

Note that --direct goes directly to the host, this is faster compared with > going to the proxy. > > I think we should have a proper command line tool that make all this much > easier. We have > this RFE: > https://bugzilla.redhat.com/show_bug.cgi?id=1626262 > > Maybe you can be interested in implementing this? > > Nir >