2020-08-23 19:44:10 INFO run.py:219 GNS3 server version 2.2.12
2020-08-23 19:44:10 INFO run.py:221 Copyright (c) 2007-2020 GNS3 Technologies Inc.
2020-08-23 19:44:10 INFO run.py:224 Config file /home/josuer08/.config/GNS3/2.2/gns3_server.conf loaded
2020-08-23 19:44:10 WARNING run.py:230 Local mode is enabled. Beware, clients will have full control on your filesystem
2020-08-23 19:44:10 INFO run.py:237 HTTP authentication is enabled with username 'admin'
2020-08-23 19:44:10 INFO run.py:243 Running with Python 3.8.5 and has PID 2845
2020-08-23 19:44:10 INFO run.py:79 Current locale is en_US.UTF-8
2020-08-23 19:44:10 INFO web_server.py:307 Starting server on localhost:3080
2020-08-23 19:44:10 INFO __init__.py:62 Load controller configuration file /home/josuer08/.config/GNS3/2.2/gns3_controller.conf
2020-08-23 19:44:10 INFO __init__.py:66 Controller is starting
2020-08-23 19:44:10 INFO compute.py:63 Create compute local
2020-08-23 19:44:10 INFO compute.py:360 Connecting to compute 'local'
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/compute/capabilities HTTP/1.1" 200 552 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/version HTTP/1.1" 200 227 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO notification_handler.py:50 New client has connected to compute WebSocket
2020-08-23 19:44:10 INFO compute.py:430 Connected to compute 'local' WebSocket 'http://localhost:3080/v2/compute/notifications/ws'
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/computes HTTP/1.1" 200 1019 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/templates HTTP/1.1" 200 3227 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO notification_handler.py:73 New client has connected to controller WebSocket
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/appliances?symbol_theme=Classic HTTP/1.1" 200 713356 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/projects HTTP/1.1" 200 1447 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/version HTTP/1.1" 200 227 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:10 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:10 +0000] "GET /v2/projects HTTP/1.1" 200 1447 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:18 INFO project.py:78 Project be277f9a-9e07-4dec-a165-b872958d31e4 with path '/home/josuer08/GNS3/projects/firts lab' created
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "POST /v2/compute/projects HTTP/1.1" 201 304 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:18 INFO base_node.py:274 VPCS: PC1 [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b] created
2020-08-23 19:44:18 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:44:18 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes HTTP/1.1" 201 574 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:18 INFO base_node.py:274 VPCS: PC2 [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1] created
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes HTTP/1.1" 201 574 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/open HTTP/1.1" 201 752 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:18 INFO project_handler.py:271 New client has connected to the notification stream for project ID 'be277f9a-9e07-4dec-a165-b872958d31e4' (WebSocket method)
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "GET /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes HTTP/1.1" 200 3224 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "GET /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 200 202 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:18 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:18 +0000] "GET /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/drawings HTTP/1.1" 200 205 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:36 INFO docker_vm.py:1058 Docker container "gns3-ubuntu-1" [5fedc5e0-384d-4f3c-8c89-f3307014a210]: number of Ethernet adapters changed to 3
2020-08-23 19:44:36 INFO docker_vm.py:406 Docker container 'gns3-ubuntu-1' [5fedc5e0-384d-4f3c-8c89-f3307014a210] created
2020-08-23 19:44:36 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:36 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/docker/nodes HTTP/1.1" 201 939 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:36 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:36 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/templates/2a1c5a73-66b0-43dc-a3f4-814b74e3f58c HTTP/1.1" 201 2457 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:36 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:44:36 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/docker/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 200 944 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:36 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:36 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 200 2531 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:36 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:36 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:38 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:38 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/docker/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 200 944 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:38 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:38 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 200 2531 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:52 INFO base_node.py:323 Docker: 'gns3-ubuntu-1' [5fedc5e0-384d-4f3c-8c89-f3307014a210]: is closing
2020-08-23 19:44:52 INFO docker_vm.py:872 Docker container 'gns3-ubuntu-1' [gns3/ubuntu:xenial] removed
2020-08-23 19:44:52 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:52 +0000] "DELETE /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/docker/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 204 241 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:44:52 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:52 +0000] "DELETE /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/5fedc5e0-384d-4f3c-8c89-f3307014a210 HTTP/1.1" 204 226 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:59 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:59 +0000] "GET /v2/gns3vm HTTP/1.1" 200 345 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:59 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:59 +0000] "GET /v2/iou_license HTTP/1.1" 200 239 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:59 INFO __init__.py:62 Load controller configuration file /home/josuer08/.config/GNS3/2.2/gns3_controller.conf
2020-08-23 19:44:59 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:59 +0000] "GET /v2/gns3vm/engines HTTP/1.1" 200 1316 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:44:59 INFO web_log.py:233 ::1 [23/Aug/2020:23:44:59 +0000] "GET /v2/gns3vm/engines/vmware/vms HTTP/1.1" 200 202 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:45:23 INFO web_log.py:233 ::1 [23/Aug/2020:23:45:23 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:45:28 INFO __init__.py:65 A path to VBoxManage has not been configured, trying to find it...
2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list vms
2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo getextradata 98fc184a-9875-4e50-88dc-84c3a0b48b36 GNS3/Clone
2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 98fc184a-9875-4e50-88dc-84c3a0b48b36 --machinereadable
2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo getextradata 699c46e6-6255-41c6-b9b8-df2de6975a0f GNS3/Clone
2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:45:28 INFO web_log.py:233 ::1 [23/Aug/2020:23:45:28 +0000] "GET /v2/compute/virtualbox/vms HTTP/1.1" 200 330 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:45:28 INFO web_log.py:233 ::1 [23/Aug/2020:23:45:28 +0000] "GET /v2/computes/local/virtualbox/vms HTTP/1.1" 200 352 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:46:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:45 +0000] "POST /v2/templates HTTP/1.1" 201 903 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list systemproperties
2020-08-23 19:46:55 INFO virtualbox_vm.py:196 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] created
2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:46:55 INFO virtualbox_vm.py:696 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] can have a maximum of 8 network adapters for chipset PIIX3
2020-08-23 19:46:55 INFO virtualbox_vm.py:709 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] has changed the number of Ethernet adapters to 3
2020-08-23 19:46:55 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:55 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes HTTP/1.1" 201 724 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:46:55 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:55 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/templates/135d567e-04e5-4b2c-b7ef-cc7ea5a69a5f HTTP/1.1" 201 2437 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:46:55 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:46:55 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 729 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:46:55 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:55 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 2511 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:46:57 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:57 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 729 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:46:57 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:57 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 2511 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:46:57 INFO web_log.py:233 ::1 [23/Aug/2020:23:46:57 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:15 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:15 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:15 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:15 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:15 INFO vpcs_vm.py:374 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP added to port 0
2020-08-23 19:47:15 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:15 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/adapters/0/ports/0/nio HTTP/1.1" 201 378 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:15 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:47:15 ERROR route.py:217 Node error detected: VirtualBoxError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 293, in create_nio
    await vm.adapter_add_nio_binding(int(request.match_info["adapter_number"]), nio)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 1014, in adapter_add_nio_binding
    raise VirtualBoxError("Attachment '{attachment}' is already configured on adapter {adapter_number}. "
gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: Attachment 'nat' is already configured on adapter 0. Please remove it or allow VirtualBox VM 'ubuntuserver-1' to use any adapter.
2020-08-23 19:47:15 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:15 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/adapters/0/ports/0/nio HTTP/1.1" 409 500 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:15 INFO vpcs_vm.py:417 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP removed from port 0
2020-08-23 19:47:15 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:15 +0000] "DELETE /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/adapters/0/ports/0/nio HTTP/1.1" 204 297 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:15 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:15 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 409 377 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:20 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:20 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:20 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:20 INFO vpcs_vm.py:374 VPCS "PC2" [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1]: NIO UDP added to port 0
2020-08-23 19:47:20 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:20 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/adapters/0/ports/0/nio HTTP/1.1" 201 378 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:20 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:47:20 INFO virtualbox_vm.py:1039 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]: NIO UDP added to adapter 1
2020-08-23 19:47:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:20 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/adapters/1/ports/0/nio HTTP/1.1" 201 384 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:20 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 201 1197 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:20 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/9bf4a3a1-87a2-4241-986c-359b575bda6c HTTP/1.1" 201 1288 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:20 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/9bf4a3a1-87a2-4241-986c-359b575bda6c HTTP/1.1" 201 1368 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:30 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:30 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:30 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:30 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:30 INFO vpcs_vm.py:374 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP added to port 0
2020-08-23 19:47:30 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:30 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/adapters/0/ports/0/nio HTTP/1.1" 201 378 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:30 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:47:30 INFO virtualbox_vm.py:1039 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]: NIO UDP added to adapter 2
2020-08-23 19:47:30 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:47:30 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/adapters/2/ports/0/nio HTTP/1.1" 201 384 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:31 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:30 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 201 1197 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:31 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:31 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/d367dcf6-8474-4120-8321-aa37f95e9a54 HTTP/1.1" 201 1288 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:31 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:31 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/d367dcf6-8474-4120-8321-aa37f95e9a54 HTTP/1.1" 201 1368 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:47:48 ERROR route.py:217 Node error detected: NodeError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/nat_handler.py", line 55, in create
    node = await builtin_manager.create_node(request.json.pop("name"),
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 257, in create_node
    node = self._NODE_CLASS(name, node_id, project, self, *args, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/builtin_node_factory.py", line 45, in __new__
    return BUILTIN_NODES[node_type](name, node_id, project, manager, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/nodes/nat.py", line 41, in __init__
    raise NodeError("NAT interface {} is missing, please install libvirt".format(nat_interface))
gns3server.compute.error.NodeError: NAT interface virbr0 is missing, please install libvirt
2020-08-23 19:47:48 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:48 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nat/nodes HTTP/1.1" 409 345 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:47:48 INFO web_log.py:233 ::1 [23/Aug/2020:23:47:48 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/templates/df8f4ea9-33b7-3e96-86a2-c39bc9bb649c HTTP/1.1" 409 320 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:14 ERROR route.py:217 Node error detected: NodeError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/nat_handler.py", line 55, in create
    node = await builtin_manager.create_node(request.json.pop("name"),
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 257, in create_node
    node = self._NODE_CLASS(name, node_id, project, self, *args, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/builtin_node_factory.py", line 45, in __new__
    return BUILTIN_NODES[node_type](name, node_id, project, manager, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/nodes/nat.py", line 41, in __init__
    raise NodeError("NAT interface {} is missing, please install libvirt".format(nat_interface))
gns3server.compute.error.NodeError: NAT interface virbr0 is missing, please install libvirt
2020-08-23 19:48:14 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:14 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nat/nodes HTTP/1.1" 409 345 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:14 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:14 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/templates/df8f4ea9-33b7-3e96-86a2-c39bc9bb649c HTTP/1.1" 409 320 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:20 INFO base_node.py:622 Starting new uBridge hypervisor localhost:45125
2020-08-23 19:48:20 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:45125']
2020-08-23 19:48:20 INFO hypervisor.py:171 logging to /home/josuer08/GNS3/projects/firts lab/project-files/builtin/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/ubridge.log
2020-08-23 19:48:20 INFO hypervisor.py:179 ubridge started PID=3819
2020-08-23 19:48:20 INFO base_node.py:625 Hypervisor localhost:45125 has successfully started
2020-08-23 19:48:20 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:45125 after 0.1008 seconds
2020-08-23 19:48:20 INFO cloud.py:215 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6] has been created
2020-08-23 19:48:20 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:20 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes HTTP/1.1" 201 1290 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:20 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/templates/39e257dc-8412-3174-b6b3-0ee3ed6a43e9 HTTP/1.1" 201 2391 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:20 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6 HTTP/1.1" 200 1295 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:20 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6 HTTP/1.1" 200 2464 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:20 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:20 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6 HTTP/1.1" 200 1295 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:20 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:20 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6 HTTP/1.1" 200 2464 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:26 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:26 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:26 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:26 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:26 INFO cloud.py:396 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP bound to port 0
2020-08-23 19:48:26 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:26 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/adapters/0/ports/0/nio HTTP/1.1" 201 379 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:26 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:48:26 ERROR route.py:217 Node error detected: VirtualBoxError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 293, in create_nio
    await vm.adapter_add_nio_binding(int(request.match_info["adapter_number"]), nio)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 1014, in adapter_add_nio_binding
    raise VirtualBoxError("Attachment '{attachment}' is already configured on adapter {adapter_number}. "
gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: Attachment 'nat' is already configured on adapter 0. Please remove it or allow VirtualBox VM 'ubuntuserver-1' to use any adapter.
2020-08-23 19:48:26 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:26 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/adapters/0/ports/0/nio HTTP/1.1" 409 500 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:26 INFO cloud.py:449 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP removed from port 0
2020-08-23 19:48:26 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:26 +0000] "DELETE /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/adapters/0/ports/0/nio HTTP/1.1" 204 298 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:26 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:26 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 409 377 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:35 INFO virtualbox_vm.py:732 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] is allowed to use any adapter
2020-08-23 19:48:35 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:35 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 728 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:35 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:35 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 2510 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:38 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:38 +0000] "PUT /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 728 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:38 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:38 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679 HTTP/1.1" 200 2510 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:38 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:38 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:45 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:45 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:45 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/ports/udp HTTP/1.1" 201 243 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:45 INFO cloud.py:396 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP bound to port 0
2020-08-23 19:48:45 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:45 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/adapters/0/ports/0/nio HTTP/1.1" 201 379 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:45 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:48:45 INFO virtualbox_vm.py:1039 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]: NIO UDP added to adapter 0
2020-08-23 19:48:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:45 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/adapters/0/ports/0/nio HTTP/1.1" 201 384 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:48:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:45 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links HTTP/1.1" 201 1197 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:45 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/6068594b-e893-42b9-ad86-281286538d93 HTTP/1.1" 201 1292 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:45 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:45 +0000] "PUT /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/links/6068594b-e893-42b9-ad86-281286538d93 HTTP/1.1" 201 1372 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:48:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:48:55 INFO base_node.py:789 VPCS: 'PC2' [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1]:local UDP tunnel created between port 10008 and 10009
2020-08-23 19:48:55 INFO vpcs_vm.py:225 Starting VPCS: ['/usr/bin/vpcs', '-p', '5003', '-m', '1', '-i', '1', '-F', '-R', '-s', '10008', '-c', '10009', '-t', '127.0.0.1', 'startup.vpc']
2020-08-23 19:48:55 INFO vpcs_vm.py:227 Logging to /home/josuer08/GNS3/projects/firts lab/project-files/vpcs/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/vpcs.log
2020-08-23 19:48:55 INFO base_node.py:789 VPCS: 'PC1' [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]:local UDP tunnel created between port 10010 and 10011
2020-08-23 19:48:55 INFO vpcs_vm.py:225 Starting VPCS: ['/usr/bin/vpcs', '-p', '5001', '-m', '0', '-i', '1', '-F', '-R', '-s', '10010', '-c', '10011', '-t', '127.0.0.1', 'startup.vpc']
2020-08-23 19:48:55 INFO vpcs_vm.py:227 Logging to /home/josuer08/GNS3/projects/firts lab/project-files/vpcs/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/vpcs.log
2020-08-23 19:48:55 INFO base_node.py:622 Starting new uBridge hypervisor localhost:46497
2020-08-23 19:48:55 INFO base_node.py:622 Starting new uBridge hypervisor localhost:43913
2020-08-23 19:48:55 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:46497']
2020-08-23 19:48:55 INFO hypervisor.py:171 logging to /home/josuer08/GNS3/projects/firts lab/project-files/vpcs/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/ubridge.log
2020-08-23 19:48:55 INFO hypervisor.py:179 ubridge started PID=4035
2020-08-23 19:48:55 INFO base_node.py:625 Hypervisor localhost:46497 has successfully started
2020-08-23 19:48:55 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:43913']
2020-08-23 19:48:55 INFO hypervisor.py:171 logging to /home/josuer08/GNS3/projects/firts lab/project-files/vpcs/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/ubridge.log
2020-08-23 19:48:55 INFO hypervisor.py:179 ubridge started PID=4039
2020-08-23 19:48:55 INFO base_node.py:625 Hypervisor localhost:43913 has successfully started
2020-08-23 19:48:55 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:46497 after 0.1013 seconds
2020-08-23 19:48:55 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:43913 after 0.1013 seconds
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:48:56 INFO base_node.py:789 VirtualBox: 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]:local UDP tunnel created between port 10012 and 10013
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictrace1 off
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictype1 82540EM
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic1 generic
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicgenericdrv1 UDPTunnel
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty1 sport=10012
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty1 dest=127.0.0.1
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty1 dport=10013
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --cableconnected1 on
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic2 null
2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --cableconnected2 off
2020-08-23 19:48:57 INFO base_node.py:789 VirtualBox: 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]:local UDP tunnel created between port 10014 and 10015
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictrace2 off
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictype2 82540EM
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic2 generic
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicgenericdrv2 UDPTunnel
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty2 sport=10014
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty2 dest=127.0.0.1
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty2 dport=10015
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --cableconnected2 on
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic3 null
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --cableconnected3 off
2020-08-23 19:48:57 INFO base_node.py:789 VirtualBox: 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]:local UDP tunnel created between port 10016 and 10017
2020-08-23 19:48:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictrace3 off
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictype3 82540EM
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic3 generic
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicgenericdrv3 UDPTunnel
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty3 sport=10016
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty3 dest=127.0.0.1
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nicproperty3 dport=10017
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --cableconnected3 on
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic4 none
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic5 none
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic6 none
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic7 none
2020-08-23 19:48:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nic8 none
2020-08-23 19:48:59 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --uart1 0x3F8 4
2020-08-23 19:48:59 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --uartmode1 server /tmp/gns3_vbox/0e39764b-a765-4e58-a480-ce14d6fe2679
2020-08-23 19:48:59 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo startvm 699c46e6-6255-41c6-b9b8-df2de6975a0f
2020-08-23 19:49:00 INFO virtualbox_vm.py:292 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] started
2020-08-23 19:49:00 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo guestproperty set 699c46e6-6255-41c6-b9b8-df2de6975a0f NameInGNS3 ubuntuserver-1
2020-08-23 19:49:00 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo guestproperty set 699c46e6-6255-41c6-b9b8-df2de6975a0f ProjectDirInGNS3 /home/josuer08/GNS3/projects/firts lab/project-files/virtualbox/0e39764b-a765-4e58-a480-ce14d6fe2679
2020-08-23 19:49:00 INFO base_node.py:622 Starting new uBridge hypervisor localhost:45331
2020-08-23 19:49:00 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:45331']
2020-08-23 19:49:00 INFO hypervisor.py:171 logging to /home/josuer08/GNS3/projects/firts lab/project-files/virtualbox/0e39764b-a765-4e58-a480-ce14d6fe2679/ubridge.log
2020-08-23 19:49:00 INFO hypervisor.py:179 ubridge started PID=4792
2020-08-23 19:49:00 INFO base_node.py:625 Hypervisor localhost:45331 has successfully started
2020-08-23 19:49:00 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:45331 after 0.1011 seconds
2020-08-23 19:49:00 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
2020-08-23 19:49:00 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:55 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/start HTTP/1.1" 204 251 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:49:00 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:49:00 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/start HTTP/1.1" 204 246 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:49:00 INFO web_log.py:233 ::1 [23/Aug/2020:23:49:00 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:49:01 ERROR vpcs_vm.py:251 Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5003)

2020-08-23 19:49:01 ERROR route.py:217 Node error detected: VPCSError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 244, in start
    await self.start_wrap_console()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 356, in start_wrap_console
    raise e
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 352, in start_wrap_console
    (reader, writer) = await asyncio.open_connection(host="127.0.0.1", port=self._internal_console_port)
  File "/usr/lib/python3.8/asyncio/streams.py", line 52, in open_connection
    transport, _ = await loop.create_connection(
  File "/usr/lib/python3.8/asyncio/base_events.py", line 1025, in create_connection
    raise exceptions[0]
  File "/usr/lib/python3.8/asyncio/base_events.py", line 1010, in create_connection
    sock = await self._connect_sock(
  File "/usr/lib/python3.8/asyncio/base_events.py", line 924, in _connect_sock
    await self.sock_connect(sock, address)
  File "/usr/lib/python3.8/asyncio/selector_events.py", line 494, in sock_connect
    return await fut
  File "/usr/lib/python3.8/asyncio/selector_events.py", line 526, in _sock_connect_cb
    raise OSError(err, f'Connect call failed {address}')
ConnectionRefusedError: [Errno 111] Connect call failed ('127.0.0.1', 5003)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/vpcs_handler.py", line 160, in start
    await vm.start()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 252, in start
    raise VPCSError("Could not start VPCS {}: {}\n{}".format(self._vpcs_path(), e, vpcs_stdout))
gns3server.compute.vpcs.vpcs_error.VPCSError: Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5003)

2020-08-23 19:49:01 ERROR vpcs_vm.py:251 Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5001)

2020-08-23 19:49:01 ERROR route.py:217 Node error detected: VPCSError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 244, in start
    await self.start_wrap_console()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 356, in start_wrap_console
    raise e
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 352, in start_wrap_console
    (reader, writer) = await asyncio.open_connection(host="127.0.0.1", port=self._internal_console_port)
  File "/usr/lib/python3.8/asyncio/streams.py", line 52, in open_connection
    transport, _ = await loop.create_connection(
  File "/usr/lib/python3.8/asyncio/base_events.py", line 1025, in create_connection
    raise exceptions[0]
  File "/usr/lib/python3.8/asyncio/base_events.py", line 1010, in create_connection
    sock = await self._connect_sock(
  File "/usr/lib/python3.8/asyncio/base_events.py", line 924, in _connect_sock
    await self.sock_connect(sock, address)
  File "/usr/lib/python3.8/asyncio/selector_events.py", line 494, in sock_connect
    return await fut
  File "/usr/lib/python3.8/asyncio/selector_events.py", line 526, in _sock_connect_cb
    raise OSError(err, f'Connect call failed {address}')
ConnectionRefusedError: [Errno 111] Connect call failed ('127.0.0.1', 5001)

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/vpcs_handler.py", line 160, in start
    await vm.start()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 252, in start
    raise VPCSError("Could not start VPCS {}: {}\n{}".format(self._vpcs_path(), e, vpcs_stdout))
gns3server.compute.vpcs.vpcs_error.VPCSError: Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5001)

2020-08-23 19:49:01 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:48:55 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/start HTTP/1.1" 409 396 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:49:01 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:55 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/start HTTP/1.1" 409 396 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:49:01 INFO web_log.py:233 ::1 [23/Aug/2020:23:48:55 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/start HTTP/1.1" 409 343 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:45331
2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4792
2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:43913
2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4039
2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:46497
2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4035
2020-08-23 19:50:08 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:50:08 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:50:08 INFO web_log.py:233 ::1 [23/Aug/2020:23:50:08 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:50:08 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:50:08 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/stop HTTP/1.1" 204 245 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:50:09 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:50:09 INFO virtualbox_vm.py:323 Stopping VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] (current state is running)
2020-08-23 19:50:09 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo controlvm 699c46e6-6255-41c6-b9b8-df2de6975a0f poweroff
2020-08-23 19:51:09 ERROR route.py:217 Node error detected: VirtualBoxError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 119, in execute
    stdout_data, stderr_data = await asyncio.wait_for(process.communicate(), timeout=timeout)
  File "/usr/lib/python3.8/asyncio/tasks.py", line 490, in wait_for
    raise exceptions.TimeoutError()
asyncio.exceptions.TimeoutError

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 209, in stop
    await vm.stop()
  File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
    return await f(oself, *args, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 349, in stop
    result = await self._control_vm("poweroff")
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 138, in _control_vm
    result = await self.manager.execute("controlvm", [self._uuid] + args)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 121, in execute
    raise VirtualBoxError("VBoxManage has timed out after {} seconds!".format(timeout))
gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: VBoxManage has timed out after 60 seconds!
2020-08-23 19:51:09 INFO web_log.py:233 ::1 [23/Aug/2020:23:50:08 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/stop HTTP/1.1" 409 360 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:09 INFO web_log.py:233 ::1 [23/Aug/2020:23:50:08 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/stop HTTP/1.1" 204 221 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:51:39 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:39 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:51:51 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:51 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:51 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:51:51 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:51 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:51 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:51:51 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/stop HTTP/1.1" 204 245 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:52 INFO virtualbox_vm.py:323 Stopping VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] (current state is stopping)
2020-08-23 19:51:52 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:51:51 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/stop HTTP/1.1" 204 250 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:52 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:51 +0000] "POST /v2/projects/be277f9a-9e07-4dec-a165-b872958d31e4/nodes/stop HTTP/1.1" 204 221 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:51:52 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:52 +0000] "GET /v2/computes HTTP/1.1" 200 1018 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:51:57 INFO notification_handler.py:82 Client has disconnected from controller WebSocket
2020-08-23 19:51:57 INFO server_handler.py:53 Start shutting down the server
2020-08-23 19:51:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:51:57 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:57 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/e6d18559-df02-4f7d-8bb4-aeaf0c605ff1/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:57 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:51:57 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/vpcs/nodes/39acbafd-c1af-4e4c-9d58-41c9a6b1be8b/stop HTTP/1.1" 204 244 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:57 INFO web_log.py:233 127.0.0.1 [23/Aug/2020:23:51:57 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/cloud/nodes/a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6/stop HTTP/1.1" 204 245 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:57 INFO virtualbox_vm.py:323 Stopping VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] (current state is stopping)
2020-08-23 19:51:57 INFO virtualbox_vm.py:356 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] stopped
2020-08-23 19:51:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --uart1 off
2020-08-23 19:51:57 WARNING virtualbox_vm.py:364 Could not deactivate the first serial port: VirtualBox has returned an error: VBoxManage: error: The machine 'ubuntuserver' is already locked for a session (or being unlocked)
VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp

2020-08-23 19:51:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictrace1 off
2020-08-23 19:51:57 ERROR route.py:217 Node error detected: VirtualBoxError
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
    await func(request, response)
  File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 209, in stop
    await vm.stop()
  File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
    return await f(oself, *args, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 369, in stop
    await self._modify_vm("--nictrace{} off".format(adapter_number + 1))
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 149, in _modify_vm
    await self.manager.execute("modifyvm", [self._uuid] + args)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 125, in execute
    raise VirtualBoxError("VirtualBox has returned an error: {}".format(vboxmanage_error))
gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: VirtualBox has returned an error: VBoxManage: error: The machine 'ubuntuserver' is already locked for a session (or being unlocked)
VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp

2020-08-23 19:51:57 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:57 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/virtualbox/nodes/0e39764b-a765-4e58-a480-ce14d6fe2679/stop HTTP/1.1" 409 705 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:57 INFO base_node.py:323 Builtin: 'Cloud1' [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: is closing
2020-08-23 19:51:57 INFO base_node.py:636 Stopping uBridge hypervisor localhost:45125
2020-08-23 19:51:57 INFO hypervisor.py:208 Stopping uBridge process PID=3819
2020-08-23 19:51:57 INFO base_node.py:323 VPCS: 'PC1' [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: is closing
2020-08-23 19:51:57 INFO base_node.py:323 VPCS: 'PC2' [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1]: is closing
2020-08-23 19:51:57 INFO base_node.py:323 VirtualBox: 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]: is closing
2020-08-23 19:51:57 INFO virtualbox_vm.py:604 VirtualBox VM "ubuntuserver-1" [0e39764b-a765-4e58-a480-ce14d6fe2679] set the close action to "power_off"
2020-08-23 19:51:57 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo 699c46e6-6255-41c6-b9b8-df2de6975a0f --machinereadable
2020-08-23 19:51:57 INFO cloud.py:248 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6] has been closed
2020-08-23 19:51:57 INFO virtualbox_vm.py:323 Stopping VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] (current state is stopping)
2020-08-23 19:51:57 INFO virtualbox_vm.py:356 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] stopped
2020-08-23 19:51:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --uart1 off
2020-08-23 19:51:58 WARNING virtualbox_vm.py:364 Could not deactivate the first serial port: VirtualBox has returned an error: VBoxManage: error: The machine 'ubuntuserver' is already locked for a session (or being unlocked)
VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp

2020-08-23 19:51:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo modifyvm 699c46e6-6255-41c6-b9b8-df2de6975a0f --nictrace1 off
2020-08-23 19:51:58 ERROR project.py:351 Could not close node VirtualBox has returned an error: VBoxManage: error: The machine 'ubuntuserver' is already locked for a session (or being unlocked)
VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/gns3server/compute/project.py", line 349, in _close_and_clean
    future.result()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 308, in close_node
    await node.close()
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 533, in close
    await self.stop()
  File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
    return await f(oself, *args, **kwargs)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 369, in stop
    await self._modify_vm("--nictrace{} off".format(adapter_number + 1))
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 149, in _modify_vm
    await self.manager.execute("modifyvm", [self._uuid] + args)
  File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 125, in execute
    raise VirtualBoxError("VirtualBox has returned an error: {}".format(vboxmanage_error))
gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: VirtualBox has returned an error: VBoxManage: error: The machine 'ubuntuserver' is already locked for a session (or being unlocked)
VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp

2020-08-23 19:51:58 INFO project.py:361 Project be277f9a-9e07-4dec-a165-b872958d31e4 with path '/home/josuer08/GNS3/projects/firts lab' closed
2020-08-23 19:51:58 WARNING project.py:366 Project be277f9a-9e07-4dec-a165-b872958d31e4 has UDP ports still in use: {10001, 10006}
2020-08-23 19:51:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list hdds
2020-08-23 19:51:58 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:57 +0000] "POST /v2/compute/projects/be277f9a-9e07-4dec-a165-b872958d31e4/close HTTP/1.1" 204 224 "-" "Python/3.8 aiohttp/3.6.2"
2020-08-23 19:51:58 INFO web_server.py:114 Closing 2 websocket connections...
2020-08-23 19:51:58 INFO web_log.py:233 ::1 [23/Aug/2020:23:51:57 +0000] "POST /v2/shutdown HTTP/1.1" 201 194 "-" "GNS3 QT Client v2.2.12"
2020-08-23 19:51:58 INFO project_handler.py:280 Client has disconnected from notification stream for project ID 'be277f9a-9e07-4dec-a165-b872958d31e4' (WebSocket method)
2020-08-23 19:51:58 INFO compute.py:456 Connection closed to compute 'local' WebSocket 'http://localhost:3080/v2/compute/notifications/ws'
2020-08-23 19:51:58 INFO notification_handler.py:59 Client has disconnected from compute WebSocket
2020-08-23 19:51:58 INFO __init__.py:123 Controller is stopping
2020-08-23 19:51:58 INFO run.py:272 Remove PID file /home/josuer08/.config/GNS3/2.2/gns3_server.pid