1 2020-08-23 19:44:10 INFO run.py:219 GNS3 server version 2.2.12
2 2020-08-23 19:44:10 INFO run.py:221 Copyright (c) 2007-2020 GNS3 Technologies Inc.
3 2020-08-23 19:44:10 INFO run.py:224 Config file /home/josuer08/.config/GNS3/2.2/gns3_server.conf loaded
4 2020-08-23 19:44:10 WARNING run.py:230 Local mode is enabled. Beware, clients will have full control on your filesystem
5 2020-08-23 19:44:10 INFO run.py:237 HTTP authentication is enabled with username 'admin'
6 2020-08-23 19:44:10 INFO run.py:243 Running with Python 3.8.5 and has PID 2845
7 2020-08-23 19:44:10 INFO run.py:79 Current locale is en_US.UTF-8
8 2020-08-23 19:44:10 INFO web_server.py:307 Starting server on localhost:3080
9 2020-08-23 19:44:10 INFO __init__.py:62 Load controller configuration file /home/josuer08/.config/GNS3/2.2/gns3_controller.conf
10 2020-08-23 19:44:10 INFO __init__.py:66 Controller is starting
11 2020-08-23 19:44:10 INFO compute.py:63 Create compute local
12 2020-08-23 19:44:10 INFO compute.py:360 Connecting to compute 'local'
13 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"
14 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"
15 2020-08-23 19:44:10 INFO notification_handler.py:50 New client has connected to compute WebSocket
16 2020-08-23 19:44:10 INFO compute.py:430 Connected to compute 'local' WebSocket 'http://localhost:3080/v2/compute/notifications/ws'
17 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"
18 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"
19 2020-08-23 19:44:10 INFO notification_handler.py:73 New client has connected to controller WebSocket
20 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"
21 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"
22 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"
23 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"
24 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
25 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"
26 2020-08-23 19:44:18 INFO base_node.py:274 VPCS: PC1 [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b] created
27 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"
28 2020-08-23 19:44:18 INFO base_node.py:274 VPCS: PC2 [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1] created
29 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"
30 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"
31 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)
32 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"
33 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"
34 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"
35 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
36 2020-08-23 19:44:36 INFO docker_vm.py:406 Docker container 'gns3-ubuntu-1' [5fedc5e0-384d-4f3c-8c89-f3307014a210] created
37 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"
38 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"
39 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"
40 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"
41 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"
42 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"
43 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"
44 2020-08-23 19:44:52 INFO base_node.py:323 Docker: 'gns3-ubuntu-1' [5fedc5e0-384d-4f3c-8c89-f3307014a210]: is closing
45 2020-08-23 19:44:52 INFO docker_vm.py:872 Docker container 'gns3-ubuntu-1' [gns3/ubuntu:xenial] removed
46 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"
47 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"
48 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"
49 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"
50 2020-08-23 19:44:59 INFO __init__.py:62 Load controller configuration file /home/josuer08/.config/GNS3/2.2/gns3_controller.conf
51 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"
52 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"
53 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"
54 2020-08-23 19:45:28 INFO __init__.py:65 A path to VBoxManage has not been configured, trying to find it...
55 2020-08-23 19:45:28 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list vms
56 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
57 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
58 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
59 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
60 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"
61 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"
62 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"
63 2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list systemproperties
64 2020-08-23 19:46:55 INFO virtualbox_vm.py:196 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] created
65 2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
66 2020-08-23 19:46:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
67 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
68 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
69 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"
70 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"
71 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"
72 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"
73 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"
74 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"
75 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"
76 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"
77 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"
78 2020-08-23 19:47:15 INFO vpcs_vm.py:374 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP added to port 0
79 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"
80 2020-08-23 19:47:15 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
81 2020-08-23 19:47:15 ERROR route.py:217 Node error detected: VirtualBoxError
82 Traceback (most recent call last):
83 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
84 await func(request, response)
85 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 293, in create_nio
86 await vm.adapter_add_nio_binding(int(request.match_info["adapter_number"]), nio)
87 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 1014, in adapter_add_nio_binding
88 raise VirtualBoxError("Attachment '{attachment}' is already configured on adapter {adapter_number}. "
89 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.
90 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"
91 2020-08-23 19:47:15 INFO vpcs_vm.py:417 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP removed from port 0
92 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"
93 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"
94 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"
95 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"
96 2020-08-23 19:47:20 INFO vpcs_vm.py:374 VPCS "PC2" [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1]: NIO UDP added to port 0
97 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"
98 2020-08-23 19:47:20 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
99 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
100 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"
101 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"
102 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"
103 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"
104 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"
105 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"
106 2020-08-23 19:47:30 INFO vpcs_vm.py:374 VPCS "PC1" [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: NIO UDP added to port 0
107 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"
108 2020-08-23 19:47:30 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
109 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
110 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"
111 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"
112 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"
113 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"
114 2020-08-23 19:47:48 ERROR route.py:217 Node error detected: NodeError
115 Traceback (most recent call last):
116 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
117 await func(request, response)
118 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/nat_handler.py", line 55, in create
119 node = await builtin_manager.create_node(request.json.pop("name"),
120 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 257, in create_node
121 node = self._NODE_CLASS(name, node_id, project, self, *args, **kwargs)
122 File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/builtin_node_factory.py", line 45, in __new__
123 return BUILTIN_NODES[node_type](name, node_id, project, manager, **kwargs)
124 File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/nodes/nat.py", line 41, in __init__
125 raise NodeError("NAT interface {} is missing, please install libvirt".format(nat_interface))
126 gns3server.compute.error.NodeError: NAT interface virbr0 is missing, please install libvirt
127 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"
128 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"
129 2020-08-23 19:48:14 ERROR route.py:217 Node error detected: NodeError
130 Traceback (most recent call last):
131 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
132 await func(request, response)
133 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/nat_handler.py", line 55, in create
134 node = await builtin_manager.create_node(request.json.pop("name"),
135 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 257, in create_node
136 node = self._NODE_CLASS(name, node_id, project, self, *args, **kwargs)
137 File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/builtin_node_factory.py", line 45, in __new__
138 return BUILTIN_NODES[node_type](name, node_id, project, manager, **kwargs)
139 File "/usr/lib/python3.8/site-packages/gns3server/compute/builtin/nodes/nat.py", line 41, in __init__
140 raise NodeError("NAT interface {} is missing, please install libvirt".format(nat_interface))
141 gns3server.compute.error.NodeError: NAT interface virbr0 is missing, please install libvirt
142 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"
143 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"
144 2020-08-23 19:48:20 INFO base_node.py:622 Starting new uBridge hypervisor localhost:45125
145 2020-08-23 19:48:20 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:45125']
146 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
147 2020-08-23 19:48:20 INFO hypervisor.py:179 ubridge started PID=3819
148 2020-08-23 19:48:20 INFO base_node.py:625 Hypervisor localhost:45125 has successfully started
149 2020-08-23 19:48:20 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:45125 after 0.1008 seconds
150 2020-08-23 19:48:20 INFO cloud.py:215 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6] has been created
151 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"
152 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"
153 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"
154 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"
155 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"
156 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"
157 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"
158 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"
159 2020-08-23 19:48:26 INFO cloud.py:396 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP bound to port 0
160 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"
161 2020-08-23 19:48:26 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
162 2020-08-23 19:48:26 ERROR route.py:217 Node error detected: VirtualBoxError
163 Traceback (most recent call last):
164 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
165 await func(request, response)
166 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 293, in create_nio
167 await vm.adapter_add_nio_binding(int(request.match_info["adapter_number"]), nio)
168 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 1014, in adapter_add_nio_binding
169 raise VirtualBoxError("Attachment '{attachment}' is already configured on adapter {adapter_number}. "
170 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.
171 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"
172 2020-08-23 19:48:26 INFO cloud.py:449 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP removed from port 0
173 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"
174 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"
175 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
176 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"
177 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"
178 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"
179 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"
180 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"
181 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"
182 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"
183 2020-08-23 19:48:45 INFO cloud.py:396 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: NIO NIO UDP bound to port 0
184 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"
185 2020-08-23 19:48:45 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
186 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
187 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"
188 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"
189 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"
190 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"
191 2020-08-23 19:48:55 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
192 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
193 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']
194 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
195 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
196 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']
197 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
198 2020-08-23 19:48:55 INFO base_node.py:622 Starting new uBridge hypervisor localhost:46497
199 2020-08-23 19:48:55 INFO base_node.py:622 Starting new uBridge hypervisor localhost:43913
200 2020-08-23 19:48:55 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:46497']
201 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
202 2020-08-23 19:48:55 INFO hypervisor.py:179 ubridge started PID=4035
203 2020-08-23 19:48:55 INFO base_node.py:625 Hypervisor localhost:46497 has successfully started
204 2020-08-23 19:48:55 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:43913']
205 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
206 2020-08-23 19:48:55 INFO hypervisor.py:179 ubridge started PID=4039
207 2020-08-23 19:48:55 INFO base_node.py:625 Hypervisor localhost:43913 has successfully started
208 2020-08-23 19:48:55 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:46497 after 0.1013 seconds
209 2020-08-23 19:48:55 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:43913 after 0.1013 seconds
210 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
211 2020-08-23 19:48:56 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
212 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
213 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
214 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
215 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
216 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
217 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
218 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
219 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
220 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
221 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
222 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
223 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
224 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
225 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
226 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
227 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
228 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
229 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
230 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
231 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
232 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
233 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
234 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
235 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
236 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
237 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
238 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
239 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
240 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
241 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
242 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
243 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
244 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
245 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
246 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
247 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
248 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
249 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
250 2020-08-23 19:48:59 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo startvm 699c46e6-6255-41c6-b9b8-df2de6975a0f
251 2020-08-23 19:49:00 INFO virtualbox_vm.py:292 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] started
252 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
253 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
254 2020-08-23 19:49:00 INFO base_node.py:622 Starting new uBridge hypervisor localhost:45331
255 2020-08-23 19:49:00 INFO hypervisor.py:169 starting ubridge: ['/usr/bin/ubridge', '-H', 'localhost:45331']
256 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
257 2020-08-23 19:49:00 INFO hypervisor.py:179 ubridge started PID=4792
258 2020-08-23 19:49:00 INFO base_node.py:625 Hypervisor localhost:45331 has successfully started
259 2020-08-23 19:49:00 INFO ubridge_hypervisor.py:83 Connected to uBridge hypervisor on localhost:45331 after 0.1011 seconds
260 2020-08-23 19:49:00 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo showvminfo --machinereadable -- ubuntuserver
261 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"
262 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"
263 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"
264 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)
266 2020-08-23 19:49:01 ERROR route.py:217 Node error detected: VPCSError
267 Traceback (most recent call last):
268 File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 244, in start
269 await self.start_wrap_console()
270 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 356, in start_wrap_console
272 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 352, in start_wrap_console
273 (reader, writer) = await asyncio.open_connection(host="127.0.0.1", port=self._internal_console_port)
274 File "/usr/lib/python3.8/asyncio/streams.py", line 52, in open_connection
275 transport, _ = await loop.create_connection(
276 File "/usr/lib/python3.8/asyncio/base_events.py", line 1025, in create_connection
278 File "/usr/lib/python3.8/asyncio/base_events.py", line 1010, in create_connection
279 sock = await self._connect_sock(
280 File "/usr/lib/python3.8/asyncio/base_events.py", line 924, in _connect_sock
281 await self.sock_connect(sock, address)
282 File "/usr/lib/python3.8/asyncio/selector_events.py", line 494, in sock_connect
284 File "/usr/lib/python3.8/asyncio/selector_events.py", line 526, in _sock_connect_cb
285 raise OSError(err, f'Connect call failed {address}')
286 ConnectionRefusedError: [Errno 111] Connect call failed ('127.0.0.1', 5003)
288 During handling of the above exception, another exception occurred:
290 Traceback (most recent call last):
291 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
292 await func(request, response)
293 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/vpcs_handler.py", line 160, in start
295 File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 252, in start
296 raise VPCSError("Could not start VPCS {}: {}\n{}".format(self._vpcs_path(), e, vpcs_stdout))
297 gns3server.compute.vpcs.vpcs_error.VPCSError: Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5003)
299 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)
301 2020-08-23 19:49:01 ERROR route.py:217 Node error detected: VPCSError
302 Traceback (most recent call last):
303 File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 244, in start
304 await self.start_wrap_console()
305 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 356, in start_wrap_console
307 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_node.py", line 352, in start_wrap_console
308 (reader, writer) = await asyncio.open_connection(host="127.0.0.1", port=self._internal_console_port)
309 File "/usr/lib/python3.8/asyncio/streams.py", line 52, in open_connection
310 transport, _ = await loop.create_connection(
311 File "/usr/lib/python3.8/asyncio/base_events.py", line 1025, in create_connection
313 File "/usr/lib/python3.8/asyncio/base_events.py", line 1010, in create_connection
314 sock = await self._connect_sock(
315 File "/usr/lib/python3.8/asyncio/base_events.py", line 924, in _connect_sock
316 await self.sock_connect(sock, address)
317 File "/usr/lib/python3.8/asyncio/selector_events.py", line 494, in sock_connect
319 File "/usr/lib/python3.8/asyncio/selector_events.py", line 526, in _sock_connect_cb
320 raise OSError(err, f'Connect call failed {address}')
321 ConnectionRefusedError: [Errno 111] Connect call failed ('127.0.0.1', 5001)
323 During handling of the above exception, another exception occurred:
325 Traceback (most recent call last):
326 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
327 await func(request, response)
328 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/vpcs_handler.py", line 160, in start
330 File "/usr/lib/python3.8/site-packages/gns3server/compute/vpcs/vpcs_vm.py", line 252, in start
331 raise VPCSError("Could not start VPCS {}: {}\n{}".format(self._vpcs_path(), e, vpcs_stdout))
332 gns3server.compute.vpcs.vpcs_error.VPCSError: Could not start VPCS /usr/bin/vpcs: [Errno 111] Connect call failed ('127.0.0.1', 5001)
334 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"
335 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"
336 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"
337 2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:45331
338 2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4792
339 2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:43913
340 2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4039
341 2020-08-23 19:50:08 INFO base_node.py:636 Stopping uBridge hypervisor localhost:46497
342 2020-08-23 19:50:08 INFO hypervisor.py:208 Stopping uBridge process PID=4035
343 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"
344 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"
345 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"
346 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
347 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)
348 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
349 2020-08-23 19:51:09 ERROR route.py:217 Node error detected: VirtualBoxError
350 Traceback (most recent call last):
351 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 119, in execute
352 stdout_data, stderr_data = await asyncio.wait_for(process.communicate(), timeout=timeout)
353 File "/usr/lib/python3.8/asyncio/tasks.py", line 490, in wait_for
354 raise exceptions.TimeoutError()
355 asyncio.exceptions.TimeoutError
357 During handling of the above exception, another exception occurred:
359 Traceback (most recent call last):
360 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
361 await func(request, response)
362 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 209, in stop
364 File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
365 return await f(oself, *args, **kwargs)
366 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 349, in stop
367 result = await self._control_vm("poweroff")
368 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 138, in _control_vm
369 result = await self.manager.execute("controlvm", [self._uuid] + args)
370 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 121, in execute
371 raise VirtualBoxError("VBoxManage has timed out after {} seconds!".format(timeout))
372 gns3server.compute.virtualbox.virtualbox_error.VirtualBoxError: VBoxManage has timed out after 60 seconds!
373 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"
374 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"
375 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"
376 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"
377 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
378 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"
379 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"
380 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)
381 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"
382 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"
383 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"
384 2020-08-23 19:51:57 INFO notification_handler.py:82 Client has disconnected from controller WebSocket
385 2020-08-23 19:51:57 INFO server_handler.py:53 Start shutting down the server
386 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
387 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"
388 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"
389 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"
390 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)
391 2020-08-23 19:51:57 INFO virtualbox_vm.py:356 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] stopped
392 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
393 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)
394 VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
395 VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
397 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
398 2020-08-23 19:51:57 ERROR route.py:217 Node error detected: VirtualBoxError
399 Traceback (most recent call last):
400 File "/usr/lib/python3.8/site-packages/gns3server/web/route.py", line 198, in control_schema
401 await func(request, response)
402 File "/usr/lib/python3.8/site-packages/gns3server/handlers/api/compute/virtualbox_handler.py", line 209, in stop
404 File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
405 return await f(oself, *args, **kwargs)
406 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 369, in stop
407 await self._modify_vm("--nictrace{} off".format(adapter_number + 1))
408 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 149, in _modify_vm
409 await self.manager.execute("modifyvm", [self._uuid] + args)
410 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 125, in execute
411 raise VirtualBoxError("VirtualBox has returned an error: {}".format(vboxmanage_error))
412 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)
413 VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
414 VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
416 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"
417 2020-08-23 19:51:57 INFO base_node.py:323 Builtin: 'Cloud1' [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6]: is closing
418 2020-08-23 19:51:57 INFO base_node.py:636 Stopping uBridge hypervisor localhost:45125
419 2020-08-23 19:51:57 INFO hypervisor.py:208 Stopping uBridge process PID=3819
420 2020-08-23 19:51:57 INFO base_node.py:323 VPCS: 'PC1' [39acbafd-c1af-4e4c-9d58-41c9a6b1be8b]: is closing
421 2020-08-23 19:51:57 INFO base_node.py:323 VPCS: 'PC2' [e6d18559-df02-4f7d-8bb4-aeaf0c605ff1]: is closing
422 2020-08-23 19:51:57 INFO base_node.py:323 VirtualBox: 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679]: is closing
423 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"
424 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
425 2020-08-23 19:51:57 INFO cloud.py:248 Cloud "Cloud1" [a25c6dba-066f-4ba6-bb1e-b28ac6a25ea6] has been closed
426 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)
427 2020-08-23 19:51:57 INFO virtualbox_vm.py:356 VirtualBox VM 'ubuntuserver-1' [0e39764b-a765-4e58-a480-ce14d6fe2679] stopped
428 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
429 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)
430 VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
431 VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
433 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
434 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)
435 VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
436 VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
437 Traceback (most recent call last):
438 File "/usr/lib/python3.8/site-packages/gns3server/compute/project.py", line 349, in _close_and_clean
440 File "/usr/lib/python3.8/site-packages/gns3server/compute/base_manager.py", line 308, in close_node
442 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 533, in close
444 File "/usr/lib/python3.8/site-packages/gns3server/utils/asyncio/__init__.py", line 163, in wrapper
445 return await f(oself, *args, **kwargs)
446 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 369, in stop
447 await self._modify_vm("--nictrace{} off".format(adapter_number + 1))
448 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/virtualbox_vm.py", line 149, in _modify_vm
449 await self.manager.execute("modifyvm", [self._uuid] + args)
450 File "/usr/lib/python3.8/site-packages/gns3server/compute/virtualbox/__init__.py", line 125, in execute
451 raise VirtualBoxError("VirtualBox has returned an error: {}".format(vboxmanage_error))
452 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)
453 VBoxManage: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee nsISupports
454 VBoxManage: error: Context: "LockMachine(a->session, LockType_Write)" at line 554 of file VBoxManageModifyVM.cpp
456 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
457 2020-08-23 19:51:58 WARNING project.py:366 Project be277f9a-9e07-4dec-a165-b872958d31e4 has UDP ports still in use: {10001, 10006}
458 2020-08-23 19:51:58 INFO __init__.py:112 Executing VBoxManage with command: /usr/bin/vboxmanage --nologo list hdds
459 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"
460 2020-08-23 19:51:58 INFO web_server.py:114 Closing 2 websocket connections...
461 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"
462 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)
463 2020-08-23 19:51:58 INFO compute.py:456 Connection closed to compute 'local' WebSocket 'http://localhost:3080/v2/compute/notifications/ws'
464 2020-08-23 19:51:58 INFO notification_handler.py:59 Client has disconnected from compute WebSocket
465 2020-08-23 19:51:58 INFO __init__.py:123 Controller is stopping
466 2020-08-23 19:51:58 INFO run.py:272 Remove PID file /home/josuer08/.config/GNS3/2.2/gns3_server.pid
projects / dotfiles / .git / blob