Gns3-gui: GNS3 Doesn't detect that the VMware VM is started

[ColdIce1]

Hello,
GNS3 doesn't detect that the GNS3 VM has started in VMware. I suspect that this is a VMware bug with the vmrun.exe.

GNS3 calls this command output = subprocess.check_output(command, timeout=timeout) and waits 60 seconds for it output. But vmrun.exe doesn't output anything. So GNS3 will fail after 60 seconds with this: except subprocess.TimeoutExpired: self.error.emit("vmrun timeout expired", True) return

Is there a fix for this soon?

[grossmj]

Hi,

Do you know what command was called or what action was performed?

Thanks,

[ColdIce1]

Command run from GNS3 to start the VM:
"C:\Program Files (x86)\VMware\VMware Workstation\vmrun.exe" -T ws start "C:\Users\ColdIce-Desktop\Documents\Virtual Machines\GNS3 VM\GNS3 VM.vmx"

Command works fine command line, VM starts as expected but vmrun.exe doesn't output any status.
Running VMware 12.1.0 build-3272444

[noplay]

Are you running GNS3 as administrator? If it's that GNS3 can see the VM
imported as a user in VMware.

On Thu, Feb 11, 2016 at 6:31 PM ColdIce [email protected] wrote:

Command run from GNS3 to start the VM:
"C:Program Files (x86)VMwareVMware Workstationvmrun.exe" -T ws start
"C:UsersColdIce-DesktopDocumentsVirtual MachinesGNS3 VMGNS3 VM.vmx"

Command works fine command line, VM starts as expected but vmrun.exe
doesn't output any status.
Running VMware 12.1.0 build-3272444

—
Reply to this email directly or view it on GitHub
https://github.com/GNS3/gns3-gui/issues/1027#issuecomment-182968038.

[ColdIce1]

I ran GNS3 as administrator, no difference.

[grossmj]

subprocess.check_output shouldn't block if the command doesn't return anything.

https://docs.python.org/3/library/subprocess.html#subprocess.check_output

Can you start the GUI with the debug param? gns3.exe --debug and give us the output.

For instance, on my Linux box I get:

=> GNS3 VM server initialized http://unset:8000
Executing vmrun with command: ['/usr/bin/vmrun', '-T', 'ws', 'start', '/home/grossmj/vmware/GNS3 VM/GNS3 VM.vmx']
Executing vmrun with command: ['/usr/bin/vmrun', '-T', 'ws', 'checkToolsState', '/home/grossmj/vmware/GNS3 VM/GNS3 VM.vmx']
Executing vmrun with command: ['/usr/bin/vmrun', '-T', 'ws', 'getGuestIPAddress', '/home/grossmj/vmware/GNS3 VM/GNS3 VM.vmx', '-wait']
GNS3 VM IP address set to 172.16.55.136
GNS3 VM is started and server is running on 172.16.55.136:8000
Synchronous get http://172.16.55.136:8000/v1/version with user 
GNS3 VM IP address is 172.16.55.136
Adjust local server IP address to 172.16.55.1

Thanks,

[grossmj]

@ColdIce1 have you tried with the latest release? (version 1.4.2).

Thanks,

[ColdIce1]

@grossmj Running 1.4.4.
Still doesn't work. Here is debug log: http://pastebin.com/T41vD3WC

[noplay]

The problem is normally the command should exit when the VM is start. If you run the command from the command line the command exit normally after a few seconds?

[ColdIce1]

@noplay Command doesn't exist from command line.

[noplay]

Can you share a screenshot of the command line?

[ColdIce1]

I don't believe that is necessary. There is literally no output, the command prompt is blinking.

[noplay]

If you start the VM from a terminal outside GNS3 your command prompt is blinking?

[grossmj]

Alternatively, I would be happy to remote control to your PC using TeamViewer to see what is wrong. What is your timezone?

[grossmj]

Or you can create a video to show us...

[ColdIce1]

@grossmj How can I come in personal contact with you to make an arrangement for remote control?

[noplay]

Send a mail to jeremy at gns3.net

On Thu, Mar 17, 2016 at 9:39 AM ColdIce [email protected] wrote:

@grossmj https://github.com/grossmj How can I come in personal contact
with you to make an arrangement for remote control?

—
You are receiving this because you were mentioned.

Reply to this email directly or view it on GitHub
https://github.com/GNS3/gns3-gui/issues/1027#issuecomment-197764077

[noplay]

Thanks!

On Thu, Mar 17, 2016 at 10:21 AM Julien Duponchelle [email protected] wrote:

Send a mail to [email protected]

On Thu, Mar 17, 2016 at 9:39 AM ColdIce [email protected] wrote:

@grossmj https://github.com/grossmj How can I come in personal contact
with you to make an arrangement for remote control?

—
You are receiving this because you were mentioned.

Reply to this email directly or view it on GitHub
https://github.com/GNS3/gns3-gui/issues/1027#issuecomment-197764077

[grossmj]

I haven't received any email. However, you could try to following:

Add the following lines to C:\Users\ColdIce-Desktop\Documents\Virtual Machines\GNS3 VM\GNS3 VM.vmx

hints.hideAll = "TRUE"
msg.noOk = "TRUE"

and try again.

Thanks,

[grossmj]

Must be a problem with vmrun.exe.

[kaage]

Hi all!

I have this same issue on Windows 7 and in both Workstation Pro 12 and Workstation Player 12 + VIX.

VM starts normally but vmrun.exe doesn't exit and GNS3 1.5.2 returns timeout error message after 60 seconds.

I can provide all debug information you need. Just in case we need my timezone is UTC +2.

[kaage]

Sorry, I'm using GNS3 1.5.3rc1 for now as I tried to resolve the problem by upgrading GNS3 with no success. However, here comes details:

This is the initial error message:

From cmd VM starts but vmrun.exe doesn't exit and cursor is just blinking:

Here GNS3 starts, GNS3 VM starts normally and after 60 seconds you get timetout error:

[kaage]

I also tried to add lines:

hints.hideAll = "TRUE"
msg.noOk = "TRUE"

to the .vmx file but issue stays. Here's debug output from that situation:

[babuutz]

Hello guys
same issue here, was working fine just yesterday I start machine and give me that error as the rest of the guy mention I am using gns3 vm 2.0.04a. when I run the command in CLI it says unknown file suffix.
NO UPDATE DONE IN MY MACHINE, my time zone is +3GMT. I am using vmware workstation 12 pro. gns3 vmware server IP address is 192.168.56.101 and I can ping that from PC which has IP address of 192.168.56.1 from one of the vmware interface, also I can ping that interface from GNS3 vm server.
also when open http://192.168.56.1:3080 open fine and http://192.168.56.101:3080 open fine. please advice more

[babuutz]

I checked to day, I open vmware workstation but not guest vmware gor gns3 server and then start gns3 it start the gns3 vmware server but after that it keep run not stopping what could be the issue

[babuutz]

Microsoft Windows [Version 6.3.9600]
(c) 2013 Microsoft Corporation. All rights reserved.

C:UsersHashil>cd c:program files

c:Program Files>cd GNS3

c:Program FilesGNS3>gns3.exe --debug
GNS3 GUI version 1.5.3
Copyright (c) 2007-2017 GNS3 Technologies Inc.
2017-02-20 18:41:48 INFO logger.py:107 Log level: DEBUG
2017-02-20 18:41:48 DEBUG analytics.py:113 Send stats to Google Analytics: v=1&t
id=UA-55817127-3&cid=51927a71-d586-42b9-b306-d6d15bb81653&aip=1&t=screenview&an=
GNS3&av=1.5.3&ua=Mozilla/5.0%20%28Windows%20NT%208.1%29%20AppleWebKit/537.36%20%
28KHTML%2C%20like%20Gecko%29%20Safari/537.36%20GNS3/1.5.3&cd=Main%20Window&ds=gn
s3-gui&sr=1366x768&ul=en_us
2017-02-20 18:41:49 INFO servers.py:103 New local server connection http://192.1
68.56.1:3080 registered
2017-02-20 18:41:49 INFO __init__.py:181 VPCS module reset
2017-02-20 18:41:49 INFO __init__.py:322 Dynamips module reset
2017-02-20 18:41:49 INFO __init__.py:262 IOU module reset
2017-02-20 18:41:49 INFO __init__.py:256 QEMU module reset
2017-02-20 18:41:49 INFO __init__.py:302 VirtualBox module reset
2017-02-20 18:41:49 INFO __init__.py:369 VMware module reset
2017-02-20 18:41:49 INFO __init__.py:193 Docker module reset
2017-02-20 18:41:49 INFO __init__.py:70 Built-in module reset
2017-02-20 18:41:49 INFO topology.py:408 Topology reset
2017-02-20 18:41:49 INFO servers.py:655 GNS3 VM server initialized http://unset:
3080
qt.network.ssl: QSslSocket: cannot call unresolved function SSLv23_client_method

qt.network.ssl: QSslSocket: cannot call unresolved function SSL_CTX_new
qt.network.ssl: QSslSocket: cannot call unresolved function SSL_library_init
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
2017-02-20 18:41:49 DEBUG analytics.py:47 Error when pushing to Google Analytics
Error creating SSL context ()
2017-02-20 18:41:51 DEBUG progress_dialog.py:98 WaitForVMWorker thread started
2017-02-20 18:41:51 DEBUG gns3_vm.py:109 Executing vmrun with command: ['C:\Pro
gram Files (x86)\VMware\VMware Workstation\vmrun.exe', '-T', 'ws', 'start', '
D:\Virtual Machines\GNS3 VM-1.5.3\GNS3 VM-1.5.3.vmx']
2017-02-20 18:42:51 CRITICAL progress_dialog.py:159 WaitForVMWorker thread stopp
ing with an error: Could not execute vmrun: Command '['C:\Program Files (x86)\
VMware\VMware Workstation\vmrun.exe', '-T', 'ws', 'start', 'D:\Virtual Machin
es\GNS3 VM-1.5.3\GNS3 VM-1.5.3.vmx']' timed out after 60 seconds with output '
'

Make sure the correct product (Fusion, Workstation or Player) is selected in Pre
ferences / VMware
2017-02-20 18:42:51 CRITICAL __init__.py:95 Could not execute vmrun: Command '['
C:\Program Files (x86)\VMware\VMware Workstation\vmrun.exe', '-T', 'ws', 'st
art', 'D:\Virtual Machines\GNS3 VM-1.5.3\GNS3 VM-1.5.3.vmx']' timed out after
60 seconds with output ''

Make sure the correct product (Fusion, Workstation or Player) is selected in Pre
ferences / VMware
Stack (most recent call last):
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libsite-packa
gescx_FreezeinitscriptsConsole.py", line 27, in
File "gns3-gui/gns3/main.py", line 282, in
File "gns3-gui/gns3/main.py", line 264, in main
File "./gns3-guigns3main_window.py", line 1233, in startupLoading
File "./gns3-guigns3qt__init__.py", line 223, in func_wrapper
File "./gns3-guigns3utilsprogress_dialog.py", line 160, in _error
File "./gns3-guigns3qt__init__.py", line 95, in critical
2017-02-20 18:43:37 DEBUG progress_dialog.py:104 WaitForVMWorker thread canceled

2017-02-20 18:43:37 DEBUG progress_dialog.py:128 WaitForVMWorker thread is being
destroyed
2017-02-20 18:43:37 DEBUG progress_dialog.py:135 WaitForVMWorker thread destroye
d
2017-02-20 18:43:38 DEBUG progress_dialog.py:104 WaitForVMWorker thread canceled

2017-02-20 18:43:38 DEBUG http_client.py:302 Synchronous get http://192.168.56.1
:3080/v1/version with user 'S3eoY2TUvHvl7zH96S9f54eZjgRUzfxM9Nsoqi4xcCIq81AdKqU4
OZMOtTCmeziL'
2017-02-20 18:43:39 DEBUG http_client.py:302 Synchronous get http://192.168.56.1
:3080/v1/version with user 'S3eoY2TUvHvl7zH96S9f54eZjgRUzfxM9Nsoqi4xcCIq81AdKqU4
OZMOtTCmeziL'
2017-02-20 18:43:40 INFO servers.py:540 Starting local server process with "C:P
rogram FilesGNS3gns3server.EXE" --host=192.168.56.1 --port=3080 --local --cont
roller --allow --debug --log="C:UsersHashilAppDataRoamingGNS3gns3_server.l
og" --pid="C:UsersHashilAppDataRoamingGNS3gns3_server.pid"
2017-02-20 18:43:40 INFO servers.py:553 Local server process has started (PID=32
32)
2017-02-20 18:43:40 DEBUG progress_dialog.py:98 WaitForConnectionWorker thread s
tarted
2017-02-20 18:43:41 DEBUG progress_dialog.py:109 WaitForConnectionWorker thread
finished
2017-02-20 18:43:41 DEBUG progress_dialog.py:128 WaitForConnectionWorker thread
is being destroyed
2017-02-20 18:43:41 DEBUG progress_dialog.py:135 WaitForConnectionWorker thread
destroyed
2017-02-20 18:43:41 DEBUG analytics.py:113 Send stats to Google Analytics: v=1&t
id=UA-55817127-3&cid=51927a71-d586-42b9-b306-d6d15bb81653&aip=1&t=screenview&an=
GNS3&av=1.5.3&ua=Mozilla/5.0%20%28Windows%20NT%208.1%29%20AppleWebKit/537.36%20%
28KHTML%2C%20like%20Gecko%29%20Safari/537.36%20GNS3/1.5.3&cd=Setup%20Wizard&ds=g
ns3-gui&sr=1366x768&ul=en_us
qt.network.ssl: QSslSocket: cannot call unresolved function SSLv23_client_method

qt.network.ssl: QSslSocket: cannot call unresolved function SSL_CTX_new
qt.network.ssl: QSslSocket: cannot call unresolved function SSL_library_init
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
2017-02-20 18:43:42 DEBUG analytics.py:47 Error when pushing to Google Analytics
Error creating SSL context ()
2017-02-20 18:43:43 DEBUG local_config.py:306 Section MainWindow has not changed
. Skip saving configuration
2017-02-20 18:43:43 DEBUG analytics.py:113 Send stats to Google Analytics: v=1&t
id=UA-55817127-3&cid=51927a71-d586-42b9-b306-d6d15bb81653&aip=1&t=screenview&an=
GNS3&av=1.5.3&ua=Mozilla/5.0%20%28Windows%20NT%208.1%29%20AppleWebKit/537.36%20%
28KHTML%2C%20like%20Gecko%29%20Safari/537.36%20GNS3/1.5.3&cd=Main%20Window&ds=gn
s3-gui&sr=1366x768&ul=en_us
2017-02-20 18:43:43 INFO __init__.py:181 VPCS module reset
2017-02-20 18:43:43 INFO __init__.py:322 Dynamips module reset
2017-02-20 18:43:43 INFO __init__.py:262 IOU module reset
2017-02-20 18:43:43 INFO __init__.py:256 QEMU module reset
2017-02-20 18:43:43 INFO __init__.py:302 VirtualBox module reset
2017-02-20 18:43:43 INFO __init__.py:369 VMware module reset
2017-02-20 18:43:43 INFO __init__.py:193 Docker module reset
2017-02-20 18:43:43 INFO __init__.py:70 Built-in module reset
2017-02-20 18:43:43 INFO topology.py:408 Topology reset
2017-02-20 18:43:43 DEBUG analytics.py:113 Send stats to Google Analytics: v=1&t
id=UA-55817127-3&cid=51927a71-d586-42b9-b306-d6d15bb81653&aip=1&t=screenview&an=
GNS3&av=1.5.3&ua=Mozilla/5.0%20%28Windows%20NT%208.1%29%20AppleWebKit/537.36%20%
28KHTML%2C%20like%20Gecko%29%20Safari/537.36%20GNS3/1.5.3&cd=New%20Project%20Dia
log&ds=gns3-gui&sr=1366x768&ul=en_us
qt.network.ssl: QSslSocket: cannot call unresolved function SSLv23_client_method

qt.network.ssl: QSslSocket: cannot call unresolved function SSL_CTX_new
qt.network.ssl: QSslSocket: cannot call unresolved function SSL_library_init
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
2017-02-20 18:43:43 DEBUG analytics.py:47 Error when pushing to Google Analytics
Error creating SSL context ()
qt.network.ssl: QSslSocket: cannot call unresolved function SSLv23_client_method

qt.network.ssl: QSslSocket: cannot call unresolved function SSL_CTX_new
qt.network.ssl: QSslSocket: cannot call unresolved function SSL_library_init
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
qt.network.ssl: QSslSocket: cannot call unresolved function ERR_get_error
2017-02-20 18:43:43 DEBUG analytics.py:47 Error when pushing to Google Analytics
Error creating SSL context ()
2017-02-20 18:43:46 DEBUG main_window.py:1115 Close the main Windows
2017-02-20 18:43:46 DEBUG analytics.py:113 Send stats to Google Analytics: v=1&t
id=UA-55817127-3&cid=51927a71-d586-42b9-b306-d6d15bb81653&aip=1&t=screenview&an=
GNS3&av=1.5.3&ua=Mozilla/5.0%20%28Windows%20NT%208.1%29%20AppleWebKit/537.36%20%
28KHTML%2C%20like%20Gecko%29%20Safari/537.36%20GNS3/1.5.3&cd=Main%20Window&ds=gn
s3-gui&sc=end&sr=1366x768&ul=en_us
2017-02-20 18:43:46 DEBUG main_window.py:1121 Project is closed killing server a
nd closing main windows
2017-02-20 18:43:46 DEBUG main_window.py:1141 _finish_application_closing
2017-02-20 18:43:46 DEBUG local_config.py:306 Section MainWindow has not changed
. Skip saving configuration
2017-02-20 18:43:46 INFO servers.py:578 Stopping local server (PID=3232)
Error in atexit._run_exitfuncs:
Traceback (most recent call last):
File "./gns3-servergns3serverserver.py", line 192, in close_asyncio_loop
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciopr
oactor_events.py", line 427, in close
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciopr
oactor_events.py", line 537, in _stop_accept_futures
AttributeError: 'int' object has no attribute 'cancel'
Exception ignored in: running=False closed=False debug=True>>
Traceback (most recent call last):
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasyncioba
se_events.py", line 431, in __del__
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciopr
oactor_events.py", line 427, in close
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciopr
oactor_events.py", line 537, in _stop_accept_futures
AttributeError: 'int' object has no attribute 'cancel'
Exception ignored in: pped#=2 result#=0>>
Traceback (most recent call last):
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciowi
ndows_events.py", line 749, in __del__
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciowi
ndows_events.py", line 741, in close
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1267, in debug
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1415, in _log
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1425, in handle
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1487, in callHandlers
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 855, in handle
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1047, in emit
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1037, in _open
NameError: name 'open' is not defined
Exception ignored in: ctor.accept..accept_coro() running at C:JenkinsworkspaceRelease Windo
wsWindowspython-3.5.2libasynciowindows_events.py:484> wait_for=<_Overlapped
Future cancelled created at C:\Jenkins\workspace\Release Windows\Windows\python-
3.5.2\lib\asyncio\windows_events.py:489> created at C:JenkinsworkspaceRelease
WindowsWindowspython-3.5.2libasynciowindows_events.py:491>>
Traceback (most recent call last):
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasynciota
sks.py", line 92, in __del__
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2libasyncioba
se_events.py", line 1177, in call_exception_handler
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1308, in error
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1415, in _log
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1425, in handle
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1487, in callHandlers
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 855, in handle
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1047, in emit
File "C:JenkinsworkspaceRelease WindowsWindowspython-3.5.2liblogging__
init__.py", line 1037, in _open
NameError: name 'open' is not defined
2017-02-20 18:43:50 DEBUG main_window.py:1153 Time spend in the software is 121
External WM_DESTROY received for QWidgetWindow(0xc8f1690100, name="NewProjectDi
alogWindow") , parent: QWindow(0x0) , transient parent: QWidgetWindow(0xc8f169
1360, name="MainWindowWindow")

c:Program FilesGNS3>

GNS3.EXE DEBUG output please help me out I am stuck here

[ColdIce1]

@grossmj
Error still exist in 1.5.3 and 2.0.0 beta 4. I e-mailed you also.

[ColdIce1]

After hours of debugging, I reinstalled Windows. Issue resolved. VMrun now runs perfectly.

[noplay]

Thanks for the feedback :(