Skip to content

Instantly share code, notes, and snippets.

@phylib
Last active March 27, 2017 12:14
Show Gist options
  • Save phylib/058f8f75124ad60ccc6de6cc9d8e1f2f to your computer and use it in GitHub Desktop.
Save phylib/058f8f75124ad60ccc6de6cc9d8e1f2f to your computer and use it in GitHub Desktop.
Installation of vICN

Installation of vICN on Ubuntu 16.04

Installation of dependencies

# Install all Python packages
sudo apt-get install python3 python3-pip python3-daemon
# Upgrade pip
pip3 install --upgrade pip

# openssl-dev not available in Repositories, therefore install libssl-dev
sudo apt-get install ssh libssl-dev

# Install lxc stuff
sudo apt-get install lxc lxd zfsutils-linux openvswitch-switch

# All documented dependencies installed (https://wiki.fd.io/view/Vicn)

# Check versions
python3 --version
Python 3.5.2

lxc --version
2.0.9

pip --version
pip 9.0.1
pip3 --version
pip 9.0.1

Checkout vICN Repository

git clone -b vicn/master https://gerrit.fd.io/r/cicn vicn
cd vicn

# Install python dependencies
# (Typo in Wiki: requirements.pip --> requirements.txt)
sudo pip3 install -r requirements.txt

# Fix file as described
vim ...

# Generate ssh-keys
./bootstrap.sh

# Create zfs storage for lxc
sudo lxd init
Name of the storage backend to use (dir or zfs) [default=zfs]:
Create a new ZFS pool (yes/no) [default=yes]?
Name of the new ZFS pool [default=lxd]:
Would you like to use an existing block device (yes/no) [default=no]?
Size in GB of the new loop device (1GB minimum) [default=90]: 10
Would you like LXD to be available over the network (yes/no) [default=no]?
Do you want to configure the LXD bridge (yes/no) [default=yes]? no
LXD has been successfully configured.

# Download and import preconfigured image
wget https://cisco.box.com/shared/static/o9idhgfcsrwawxp7rtkafjlurhhqblit.gz -O ~/ubuntu1604-cicnsuite-rc1.tar.gz
sudo lxc image import ~/ubuntu1604-cicnsuite-rc1.tar.gz --alias=ubuntu1604-cicnsuite-rc1
# 'sudo lxc image list' now lists the image

Create and Deploy Topology

According to the wiki, there are 2 possibilities.

  • Manually write the JSON file
  • Use the topology_gen.py script in the examples/ folder

I suppose that writing the topology manually is to complicated for big scenarios, BUT the examples folder does not contain a python script.

In order to run the sample topology from the examples/tutorial folder I changed the following attributes to my local settings:

  • "hostname": "localhost"
  • "device_name": "eno1",
  • "network": "[nw-addresse]/[subnetmask]"

Attempt 1

When deploying the topology with sudo vicn/bin/vicn.py -s examples/tutorial/tutorial01.json I get the folloing error:

error: You have existing containers or images. lxd init requires an empty LXD.

Attempt 2

Therefore, I unloaded the lxd image with sudo lxc image delete ubuntu1604-cicnsuite-rc1.

Now the log output looks as follows:

* Loading the configuration file at examples/tutorial/tutorial01_philipp.json
2017-03-24 12:21:13,471 - vicn.core.api - INFO - Parsing configuration file
2017-03-24 12:21:13,471 - vicn.core.resource_factory - INFO - Registering resources
2017-03-24 12:21:13,535 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/Grammar.txt
2017-03-24 12:21:13,563 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/PatternGrammar.txt
2017-03-24 12:21:13,617 - vicn.core.resource_factory - INFO - Registered resources are: {Application, BaseNetDevice, Bridge, BridgeManager, CICNForwarder, CcnxConsumerTest, CcnxProducerTest, CcnxSimpleTrafficGenerator, CentralICN, CentralIP, Certificate, Channel, Consumer, ContainerSetup, ContainersSetup, DnsMasq, DnsServer, DnsServerEntry, DpdkDevice, EmulatedChannel, EmulatedLteChannel, EmulatedWiFiChannel, Face, File, Forwarder, GUI, ICNApplication, ICNFaces, ICNRoutes, ICNTools, IPAssignment, IPRoute, IPRoutes, IPing, IPingClient, IPingServer, Interface, Iperf3, L2Face, L4Face, Link, LinuxApplication, LxcContainer, LxcImage, LxdHypervisor, LxdInit, LxdInstallCert, MacVlan, MacVtap, MetisForwarder, MetisKeystore, NDNPingServer, NDNPingServerBase, NDNPingService, NFD, NetDevice, NetMon, Node, NonTapBaseNetDevice, NumaManager, OVS, Package, PackageManager, Packages, PhyInterface, PhyLink, Physical, Producer, RepoNG, Repository, Route, RoutingTable, Script, Service, SlaveBaseNetDevice, SlaveNetDevice, SymVethPair, TapChannel, TapDevice, TextFile, Traceroute, VPP, VPPBridge, VPPHost, VPPInterface, VethPair, VirtualRepo, WebServer}
2017-03-24 12:21:13,621 - netmodel.network.interface - WARNING - Interface netmodel.interfaces.websocket automatically disabled. Please install dependencies if you wish to use it: No module named 'autobahn'
2017-03-24 12:21:13,621 - netmodel.network.router - INFO - Successfully created interface unixserver with name interface-AFI
2017-03-24 12:21:13,621 - netmodel.network.router - INFO - Successfully created interface local with name interface-BKT
2017-03-24 12:21:13,638 - netmodel.network.router - INFO - Successfully created interface vicn with name interface-7MZ
2017-03-24 12:21:13,638 - netmodel.network.router - WARNING - Could not create a websocketserver interface
2017-03-24 12:21:13,679 - netmodel.network.interface - INFO - Interface unixserver : new state UP.
2017-03-24 12:21:13,687 - netmodel.network.interface - INFO - Interface local : new state UP.
2017-03-24 12:21:13,687 - netmodel.network.interface - INFO - Interface vicn : new state UP.
2017-03-24 12:21:13,700 - netmodel.util.socket - INFO - Check port status for localhost:22
2017-03-24 12:21:13,707 - vicn.core.resource - WARNING - Ignored unknown attribute node for resource lxdinstallcert
2017-03-24 12:21:13,720 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/../../../c...
2017-03-24 12:21:13,722 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/../../../c...
2017-03-24 12:21:13,732 - vicn.core.task - INFO - Execute: server - dpkg -s lsof
2017-03-24 12:21:13,735 - vicn.core.task - INFO - Execute: server - dpkg -s zfsutils-linux
2017-03-24 12:21:13,736 - vicn.core.task - INFO - Execute: server - dpkg -s lxd
2017-03-24 12:21:13,778 - vicn.core.task - INFO - Execute: server - lsof -i:8443
2017-03-24 12:21:13,808 - vicn.core.task - INFO - Execute: server - bash -c 'lxd init --auto --storage-create-loop=100 --storage-pool=vicn --netw...
/usr/lib/python3/dist-packages/urllib3/connectionpool.py:794: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.org/en/latest/security.html
 InsecureRequestWarning)
2017-03-24 12:21:14,943 - vicn.resource.lxd.lxd_hypervisor - INFO - Adding certificate on LXD
 File "/home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py", line 1067, in _trigger_state_change
   ret = fut.result()
 File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
   raise self._exception
 File "/home/philipp/Desktop/cicn/vicn/vicn/core/task.py", line 183, in _done_callback
   self._future.set_result(fut.result())
 File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
   raise self._exception
 File "/usr/lib/python3.5/concurrent/futures/thread.py", line 55, in run
   result = self.fn(*self.args, **self.kwargs)
 File "/home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 136, in __create__
   self.owner.client.authenticate(DEFAULT_TRUST_PASSWORD)
 File "/home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 181, in client
   verify=False)
 File "/usr/local/lib/python3.5/dist-packages/pylxd/client.py", line 225, in __init__
   self.certificates = managers.CertificateManager(self)
 File "/usr/local/lib/python3.5/dist-packages/pylxd/managers.py", line 18, in __init__
   target_module = importlib.import_module(module)
 File "/usr/lib/python3.5/importlib/__init__.py", line 126, in import_module
   return _bootstrap._gcd_import(name[level:], package, level)
 File "<frozen importlib._bootstrap>", line 986, in _gcd_import
 File "<frozen importlib._bootstrap>", line 969, in _find_and_load
 File "<frozen importlib._bootstrap>", line 958, in _find_and_load_unlocked
 File "<frozen importlib._bootstrap>", line 673, in _load_unlocked
 File "<frozen importlib._bootstrap_external>", line 665, in exec_module
 File "<frozen importlib._bootstrap>", line 222, in _call_with_frames_removed
 File "/usr/local/lib/python3.5/dist-packages/pylxd/models/__init__.py", line 2, in <module>
   from pylxd.models.container import Container, Snapshot  # NOQA
2017-03-24 12:21:15,041 - asyncio - ERROR - Task exception was never retrieved
future: <Task finished coro=<ResourceManager._process_resource() done, defined at /home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py:1173> exception=NotImplementedError()>
Traceback (most recent call last):
 File "/usr/lib/python3.5/asyncio/tasks.py", line 239, in _step
   result = coro.send(None)
 File "/home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py", line 1407, in _process_resource
   raise NotImplementedError
NotImplementedError

Attempt 3

As suggested on the cicn-mailing list, lxd should be started before deploying the topology. Therefore the prepared image is loaded again and the lxd started

sudo lxc image list
+--------------------------+--------------+--------+------------------------------------+--------+----------+------------------------------+
|          ALIAS           | FINGERPRINT  | PUBLIC |            DESCRIPTION             |  ARCH  |   SIZE   |         UPLOAD DATE          |
+--------------------------+--------------+--------+------------------------------------+--------+----------+------------------------------+
| ubuntu1604-cicnsuite-rc1 | 3154116cfadc | no     | Ubuntu 16.04 LTS server (20170113) | x86_64 | 402.82MB | Mar 24, 2017 at 2:09pm (UTC) |
+--------------------------+--------------+--------+------------------------------------+--------+----------+------------------------------+
sudo service lxd start

# check if lxd is listening to port 8443
sudo lsof -i:8443
COMMAND   PID USER   FD   TYPE DEVICE SIZE/OFF NODE NAME
lxd     20957 root   11u  IPv6 349812      0t0  TCP *:8443 (LISTEN)

The following error occurs when deploying the topology:

* Loading the configuration file at examples/tutorial/tutorial01_philipp.json
2017-03-24 15:31:00,361 - vicn.core.api - INFO - Parsing configuration file
2017-03-24 15:31:00,362 - vicn.core.resource_factory - INFO - Registering resources
2017-03-24 15:31:00,425 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/Grammar.txt
2017-03-24 15:31:00,454 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/PatternGrammar.txt
2017-03-24 15:31:00,508 - vicn.core.resource_factory - INFO - Registered resources are: {Application, BaseNetDevice, Bridge, BridgeManager, CICNForwarder, CcnxConsumerTest, CcnxProducerTest, CcnxSimpleTrafficGenerator, CentralICN, CentralIP, Certificate, Channel, Consumer, ContainerSetup, ContainersSetup, DnsMasq, DnsServer, DnsServerEntry, DpdkDevice, EmulatedChannel, EmulatedLteChannel, EmulatedWiFiChannel, Face, File, Forwarder, GUI, ICNApplication, ICNFaces, ICNRoutes, ICNTools, IPAssignment, IPRoute, IPRoutes, IPing, IPingClient, IPingServer, Interface, Iperf3, L2Face, L4Face, Link, LinuxApplication, LxcContainer, LxcImage, LxdHypervisor, LxdInit, LxdInstallCert, MacVlan, MacVtap, MetisForwarder, MetisKeystore, NDNPingServer, NDNPingServerBase, NDNPingService, NFD, NetDevice, NetMon, Node, NonTapBaseNetDevice, NumaManager, OVS, Package, PackageManager, Packages, PhyInterface, PhyLink, Physical, Producer, RepoNG, Repository, Route, RoutingTable, Script, Service, SlaveBaseNetDevice, SlaveNetDevice, SymVethPair, TapChannel, TapDevice, TextFile, Traceroute, VPP, VPPBridge, VPPHost, VPPInterface, VethPair, VirtualRepo, WebServer}
2017-03-24 15:31:00,512 - netmodel.network.interface - WARNING - Interface netmodel.interfaces.websocket automatically disabled. Please install dependencies if you wish to use it: No module named 'autobahn'
2017-03-24 15:31:00,512 - netmodel.network.router - INFO - Successfully created interface unixserver with name interface-EJ8
2017-03-24 15:31:00,513 - netmodel.network.router - INFO - Successfully created interface local with name interface-X6E
2017-03-24 15:31:00,529 - netmodel.network.router - INFO - Successfully created interface vicn with name interface-R76
2017-03-24 15:31:00,529 - netmodel.network.router - WARNING - Could not create a websocketserver interface
2017-03-24 15:31:00,569 - netmodel.network.interface - INFO - Interface unixserver : new state UP.
2017-03-24 15:31:00,577 - netmodel.network.interface - INFO - Interface local : new state UP.
2017-03-24 15:31:00,577 - netmodel.network.interface - INFO - Interface vicn : new state UP.
2017-03-24 15:31:00,590 - netmodel.util.socket - INFO - Check port status for localhost:22
2017-03-24 15:31:00,602 - vicn.core.resource - WARNING - Ignored unknown attribute node for resource lxdinstallcert
2017-03-24 15:31:00,615 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/../../../c...
2017-03-24 15:31:00,617 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/../../../c...
2017-03-24 15:31:00,628 - vicn.core.task - INFO - Execute: server - dpkg -s lsof
2017-03-24 15:31:00,631 - vicn.core.task - INFO - Execute: server - dpkg -s zfsutils-linux
2017-03-24 15:31:00,634 - vicn.core.task - INFO - Execute: server - dpkg -s lxd
2017-03-24 15:31:00,683 - vicn.core.task - INFO - Execute: server - lsof -i:8443
/usr/lib/python3/dist-packages/urllib3/connectionpool.py:794: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.org/en/latest/security.html
InsecureRequestWarning)
2017-03-24 15:31:00,885 - vicn.resource.lxd.lxd_hypervisor - INFO - Adding certificate on LXD
File "/home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py", line 1067, in _trigger_state_change
ret = fut.result()
File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
raise self._exception
File "/home/philipp/Desktop/cicn/vicn/vicn/core/task.py", line 183, in _done_callback
self._future.set_result(fut.result())
File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
raise self._exception
File "/usr/lib/python3.5/concurrent/futures/thread.py", line 55, in run
result = self.fn(*self.args, **self.kwargs)
File "/home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 136, in __create__
self.owner.client.authenticate(DEFAULT_TRUST_PASSWORD)
File "/home/philipp/Desktop/cicn/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 181, in client
verify=False)
File "/usr/local/lib/python3.5/dist-packages/pylxd/client.py", line 225, in __init__
self.certificates = managers.CertificateManager(self)
File "/usr/local/lib/python3.5/dist-packages/pylxd/managers.py", line 18, in __init__
target_module = importlib.import_module(module)
File "/usr/lib/python3.5/importlib/__init__.py", line 126, in import_module
return _bootstrap._gcd_import(name[level:], package, level)
File "<frozen importlib._bootstrap>", line 986, in _gcd_import
File "<frozen importlib._bootstrap>", line 969, in _find_and_load
File "<frozen importlib._bootstrap>", line 958, in _find_and_load_unlocked
File "<frozen importlib._bootstrap>", line 673, in _load_unlocked
File "<frozen importlib._bootstrap_external>", line 665, in exec_module
File "<frozen importlib._bootstrap>", line 222, in _call_with_frames_removed
File "/usr/local/lib/python3.5/dist-packages/pylxd/models/__init__.py", line 2, in <module>
from pylxd.models.container import Container, Snapshot  # NOQA
2017-03-24 15:31:00,926 - asyncio - ERROR - Task exception was never retrieved
future: <Task finished coro=<ResourceManager._process_resource() done, defined at /home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py:1173> exception=NotImplementedError()>
Traceback (most recent call last):
File "/usr/lib/python3.5/asyncio/tasks.py", line 239, in _step
result = coro.send(None)
File "/home/philipp/Desktop/cicn/vicn/vicn/core/resource_mgr.py", line 1407, in _process_resource
raise NotImplementedError
NotImplementedError

Attempt 4

Configure changes regarding to updated vICN tutorial and mailing list. Only noticeable problems are mentioned in the following listings. SSH daemon is running and root-SSH access is permitted.

apt-get update ignores cisco sources (see log).

# Add cisco repository and update apt
echo "deb [trusted=yes] https://nexus.fd.io/content/repositories/fd.io.stable.1701.ubuntu.xenial.main/ ./" | sudo tee -a /etc/apt/sources.list.d/99fd.io.list

sudo apt-get update
...
... output omited
...
Ign:9 https://nexus.fd.io/content/repositories/fd.io.stable.1701.ubuntu.xenial.main ./ InRelease
Ign:11 https://nexus.fd.io/content/repositories/fd.io.stable.1701.ubuntu.xenial.main ./ Release.gpg
Fetched 268 kB in 1s (263 kB/s)
Reading package lists... Done

tutorial01.json is changed as described before.

sudo vicn/bin/vicn.py -s examples/tutorial/tutorial01.json
 * Loading the configuration file at examples/tutorial/tutorial01.json
2017-03-27 15:28:05,021 - vicn.core.api - INFO - Parsing configuration file
2017-03-27 15:28:05,021 - vicn.core.resource_factory - INFO - Registering resources
2017-03-27 15:28:05,102 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/Grammar.txt
2017-03-27 15:28:05,131 - root - INFO - Generating grammar tables from /usr/lib/python3.5/lib2to3/PatternGrammar.txt
2017-03-27 15:28:05,190 - vicn.core.resource_factory - INFO - Registered resources are: {Application, BaseNetDevice, Bridge, BridgeManager, CICNForwarder, CcnxConsumerTest, CcnxProducerTest, CcnxSimpleTrafficGenerator, CentralICN, CentralIP, Certificate, Channel, Consumer, ContainerSetup, ContainersSetup, DnsMasq, DnsServer, DnsServerEntry, DpdkDevice, EmulatedChannel, EmulatedLteChannel, EmulatedWiFiChannel, Face, File, Forwarder, GUI, ICNApplication, ICNFaces, ICNRoutes, ICNTools, IPAssignment, IPRoute, IPRoutes, IPing, IPingClient, IPingServer, Interface, Iperf3, Keypair, L2Face, L4Face, Link, LinuxApplication, LxcContainer, LxcImage, LxdHypervisor, LxdInit, LxdInstallCert, MacVlan, MacVtap, MetisForwarder, MetisKeystore, NDNPingServer, NDNPingServerBase, NDNPingService, NFD, NetDevice, NetMon, Node, NonTapBaseNetDevice, NumaManager, OVS, Package, PackageManager, Packages, PhyInterface, PhyLink, Physical, Producer, RepoNG, Repository, Route, RoutingTable, Script, Service, SlaveBaseNetDevice, SlaveNetDevice, SymVethPair, TapChannel, TapDevice, TextFile, Traceroute, VPP, VPPBridge, VPPHost, VPPInterface, VethPair, VirtualRepo, WebServer}
2017-03-27 15:28:05,194 - netmodel.network.interface - WARNING - Interface netmodel.interfaces.websocket automatically disabled. Please install dependencies if you wish to use it: No module named 'autobahn'
2017-03-27 15:28:05,194 - netmodel.network.router - INFO - Successfully created interface unixserver with name interface-QUM
2017-03-27 15:28:05,194 - netmodel.network.router - INFO - Successfully created interface local with name interface-ROC
2017-03-27 15:28:05,212 - netmodel.network.router - INFO - Successfully created interface vicn with name interface-RBH
2017-03-27 15:28:05,212 - netmodel.network.router - WARNING - Could not create a websocketserver interface
2017-03-27 15:28:05,255 - netmodel.network.interface - INFO - Interface unixserver : new state UP.
2017-03-27 15:28:05,256 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Link-PH66M>
2017-03-27 15:28:05,257 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-cons1>
2017-03-27 15:28:05,257 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-6GN03>
2017-03-27 15:28:05,257 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Link-Y6OXU>
2017-03-27 15:28:05,258 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID WebServer-RMPVT>
2017-03-27 15:28:05,259 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-prod1>
2017-03-27 15:28:05,259 - vicn.core.resource_mgr - INFO - Resource <UUID NetDevice-ZCNVA> is marked as CLEAN (1/25)
2017-03-27 15:28:05,259 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-BLL8G>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-core1>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Link-LQDBT>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Link-TSREO>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-UHJHQ>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-NWH1T>
2017-03-27 15:28:05,261 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-9IZEW>
2017-03-27 15:28:05,262 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID CentralICN-FTERX>
2017-03-27 15:28:05,263 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-core2>
2017-03-27 15:28:05,263 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Link-CSRN0>
2017-03-27 15:28:05,263 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID MetisForwarder-DDIQT>
2017-03-27 15:28:05,263 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID WebServer-UJPJC>
2017-03-27 15:28:05,263 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcImage-ubuntu1604-cicnsuite-rc1>
2017-03-27 15:28:05,265 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-cons2>
2017-03-27 15:28:05,266 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxcContainer-prod2>
2017-03-27 15:28:05,266 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Physical-server>
2017-03-27 15:28:05,267 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID CentralIP-ZEPK0>
2017-03-27 15:28:05,267 - netmodel.network.interface - INFO - Interface local : new state UP.
2017-03-27 15:28:05,267 - netmodel.network.interface - INFO - Interface vicn : new state UP.
2017-03-27 15:28:05,267 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-Z905U>
2017-03-27 15:28:05,267 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-NRI95>
2017-03-27 15:28:05,268 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-ID128>
2017-03-27 15:28:05,268 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-DQR0A>
2017-03-27 15:28:05,269 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-CPQ0D>
2017-03-27 15:28:05,269 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID NetMon-NCNRN>
2017-03-27 15:28:05,281 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Keypair-8XBBC>
2017-03-27 15:28:05,282 - vicn.core.task - INFO - Scheduling task <Task[ipy] __initialize__> for resource <UUID Keypair-8XBBC>
2017-03-27 15:28:05,285 - vicn.core.task - INFO - Scheduling task <Concurrent [<Task[bash] test -f {file.filename} && readlink -e {file.filename} / {'file': <File: <UUID File-969WI> filename=/home/phmoll/.vicn/ssh_client_cert/ssh_client_key.pub, name=None, managed=False, overwrite=False, node=None>}>, <Task[bash] test -f {file.filename} && readlink -e {file.filename} / {'file': <File: <UUID File-I9WA6> filename=/home/phmoll/.vicn/ssh_client_cert/ssh_client_key, name=None, managed=False, overwrite=False, node=None>}>]> for resource <UUID Keypair-8XBBC>
2017-03-27 15:28:05,285 - vicn.core.task - INFO - Execute: (LOCAL) - bash -c 'test -f /home/phmoll/.vicn/ssh_client_cert/ssh_client_key.pub && rea...
2017-03-27 15:28:05,288 - vicn.core.task - INFO - Execute: (LOCAL) - bash -c 'test -f /home/phmoll/.vicn/ssh_client_cert/ssh_client_key && readlin...
2017-03-27 15:28:05,295 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Keypair-8XBBC>
2017-03-27 15:28:05,296 - vicn.core.resource_mgr - INFO - Resource <UUID Keypair-8XBBC> is marked as CLEAN (2/30)
2017-03-27 15:28:05,298 - netmodel.util.socket - INFO - Check port status for localhost:22
2017-03-27 15:28:05,298 - vicn.core.task - INFO - Scheduling task <Task[py] _setup_ssh_key> for resource <UUID Physical-server>
/usr/bin/ssh-copy-id: INFO: Source of key(s) to be installed: "/home/phmoll/.vicn/ssh_client_cert/ssh_client_key.pub"
/usr/bin/ssh-copy-id: INFO: attempting to log in with the new key(s), to filter out any that are already installed

/usr/bin/ssh-copy-id: WARNING: All keys were skipped because they already exist on the remote system.
		(if you think this is a mistake, you may want to use -f option)

2017-03-27 15:28:05,621 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Physical-server>
2017-03-27 15:28:05,622 - vicn.core.resource_mgr - INFO - Resource <UUID Physical-server> is marked as CLEAN (3/30)
2017-03-27 15:28:05,625 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxdHypervisor-7N2LC>
2017-03-27 15:28:05,632 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxdInit-KFD9Y>
2017-03-27 15:28:05,632 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Certificate-X8GDN>
2017-03-27 15:28:05,636 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Packages-V0B8V>
2017-03-27 15:28:05,638 - vicn.core.task - INFO - Scheduling task <Task[ipy] __initialize__> for resource <UUID Certificate-X8GDN>
2017-03-27 15:28:05,639 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID PackageManager-RB6J7>
2017-03-27 15:28:05,646 - vicn.core.task - INFO - Scheduling task <Concurrent [<Task[bash] test -f {file.filename} && readlink -e {file.filename} / {'file': <File: <UUID File-AZNO7> filename=/home/phmoll/.vicn/lxd_client_cert/client_cert.pem, name=None, managed=False, overwrite=False, node=Physical-server>}>, <Task[bash] test -f {file.filename} && readlink -e {file.filename} / {'file': <File: <UUID File-QWJCY> filename=/home/phmoll/.vicn/lxd_client_cert/client_key.pem, name=None, managed=False, overwrite=False, node=Physical-server>}>]> for resource <UUID Certificate-X8GDN>
2017-03-27 15:28:05,646 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/phmoll/.vicn/lxd_client_cert/client_cert.pem && readli...
2017-03-27 15:28:05,648 - vicn.core.task - INFO - Execute: server - bash -c 'test -f /home/phmoll/.vicn/lxd_client_cert/client_key.pem && readlin...
2017-03-27 15:28:05,650 - vicn.core.task - INFO - Scheduling task <Task[ipy] __get__> for resource <UUID PackageManager-RB6J7>
2017-03-27 15:28:05,650 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID PackageManager-RB6J7>
2017-03-27 15:28:05,654 - vicn.core.resource_mgr - INFO - Resource <UUID PackageManager-RB6J7> is marked as CLEAN (4/35)
2017-03-27 15:28:05,659 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Package-C3XHW>
2017-03-27 15:28:05,659 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Package-LX5YK>
2017-03-27 15:28:05,659 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID Package-1QT68>
2017-03-27 15:28:05,663 - vicn.core.task - INFO - Scheduling task <Task[bash] dpkg -s {self.package_name} / {'self': <Package: <UUID Package-C3XHW> owner=Packages-V0B8V, name=None, managed=True, package_name=lsof, node=Physical-server>}> for resource <UUID Package-C3XHW>
2017-03-27 15:28:05,664 - vicn.core.task - INFO - Scheduling task <Task[bash] dpkg -s {self.package_name} / {'self': <Package: <UUID Package-LX5YK> owner=Packages-V0B8V, name=None, managed=True, package_name=lxd, node=Physical-server>}> for resource <UUID Package-LX5YK>
2017-03-27 15:28:05,664 - vicn.core.task - INFO - Scheduling task <Task[bash] dpkg -s {self.package_name} / {'self': <Package: <UUID Package-1QT68> owner=Packages-V0B8V, name=None, managed=True, package_name=zfsutils-linux, node=Physical-server>}> for resource <UUID Package-1QT68>
2017-03-27 15:28:05,665 - vicn.core.task - INFO - Execute: server - dpkg -s lsof
2017-03-27 15:28:05,667 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Certificate-X8GDN>
2017-03-27 15:28:05,667 - vicn.core.task - INFO - Execute: server - dpkg -s lxd
2017-03-27 15:28:05,668 - vicn.core.task - INFO - Execute: server - dpkg -s zfsutils-linux
2017-03-27 15:28:05,671 - vicn.core.resource_mgr - INFO - Resource <UUID Certificate-X8GDN> is marked as CLEAN (5/38)
2017-03-27 15:28:05,697 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Package-C3XHW>
2017-03-27 15:28:05,708 - vicn.core.resource_mgr - INFO - Resource <UUID Package-C3XHW> is marked as CLEAN (6/38)
2017-03-27 15:28:05,715 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Package-1QT68>
2017-03-27 15:28:05,716 - vicn.core.resource_mgr - INFO - Resource <UUID Package-1QT68> is marked as CLEAN (7/38)
2017-03-27 15:28:05,720 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Package-LX5YK>
2017-03-27 15:28:05,721 - vicn.core.resource_mgr - INFO - Resource <UUID Package-LX5YK> is marked as CLEAN (8/38)
2017-03-27 15:28:05,721 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID Packages-V0B8V>
2017-03-27 15:28:05,722 - vicn.core.resource_mgr - INFO - Resource <UUID Packages-V0B8V> is marked as CLEAN (9/38)
2017-03-27 15:28:05,723 - vicn.core.task - INFO - Scheduling task <Task[bash] lsof -i:{lxd.lxd_port} / {'lxd': <LxdHypervisor: <UUID LxdHypervisor-7N2LC> name=None, managed=True, node=Physical-server>}> for resource <UUID LxdInit-KFD9Y>
2017-03-27 15:28:05,723 - vicn.core.task - INFO - Execute: server - lsof -i:8443
2017-03-27 15:28:05,757 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_task_resource_update>> for resource <UUID LxdInit-KFD9Y>
2017-03-27 15:28:05,758 - vicn.core.resource_mgr - INFO - Resource <UUID LxdInit-KFD9Y> is marked as CLEAN (10/38)
2017-03-27 15:28:05,758 - vicn.core.task - INFO - Scheduling task <Task[apy] partial<_resource_wait_dependencies>> for resource <UUID LxdInstallCert-KO5E4>
2017-03-27 15:28:05,759 - vicn.core.task - INFO - Scheduling task <Task[py] __get__> for resource <UUID LxdInstallCert-KO5E4>
/usr/lib/python3/dist-packages/urllib3/connectionpool.py:794: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.org/en/latest/security.html
  InsecureRequestWarning)
2017-03-27 15:28:05,943 - vicn.core.task - INFO - Scheduling task <Task[py] __create__ :
        Some operations with containers requires the client to be trusted by
        the server. So at the beginning we have to upload a (self signed)
        client certificate for the LXD daemon.
        > for resource <UUID LxdInstallCert-KO5E4>
2017-03-27 15:28:05,943 - vicn.resource.lxd.lxd_hypervisor - INFO - Adding certificate on LXD
  File "/home/phmoll/Desktop/vicn/vicn/core/resource_mgr.py", line 1082, in _trigger_state_change
    ret = fut.result()
  File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
    raise self._exception
  File "/home/phmoll/Desktop/vicn/vicn/core/task.py", line 204, in _done_callback
    self._future.set_result(fut.result())
  File "/usr/lib/python3.5/asyncio/futures.py", line 274, in result
    raise self._exception
  File "/usr/lib/python3.5/concurrent/futures/thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/home/phmoll/Desktop/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 135, in __create__
    self.owner.client.authenticate(DEFAULT_TRUST_PASSWORD)
  File "/home/phmoll/Desktop/vicn/vicn/resource/lxd/lxd_hypervisor.py", line 180, in client
    verify=False)
  File "/usr/local/lib/python3.5/dist-packages/pylxd/client.py", line 225, in __init__
    self.certificates = managers.CertificateManager(self)
  File "/usr/local/lib/python3.5/dist-packages/pylxd/managers.py", line 18, in __init__
    target_module = importlib.import_module(module)
  File "/usr/lib/python3.5/importlib/__init__.py", line 126, in import_module
    return _bootstrap._gcd_import(name[level:], package, level)
  File "<frozen importlib._bootstrap>", line 986, in _gcd_import
  File "<frozen importlib._bootstrap>", line 969, in _find_and_load
  File "<frozen importlib._bootstrap>", line 958, in _find_and_load_unlocked
  File "<frozen importlib._bootstrap>", line 673, in _load_unlocked
  File "<frozen importlib._bootstrap_external>", line 665, in exec_module
  File "<frozen importlib._bootstrap>", line 222, in _call_with_frames_removed
  File "/usr/local/lib/python3.5/dist-packages/pylxd/models/__init__.py", line 2, in <module>
    from pylxd.models.container import Container, Snapshot  # NOQA
2017-03-27 15:28:05,984 - asyncio - ERROR - Task exception was never retrieved
future: <Task finished coro=<ResourceManager._process_resource() done, defined at /home/phmoll/Desktop/vicn/vicn/core/resource_mgr.py:1188> exception=NotImplementedError()>
Traceback (most recent call last):
  File "/usr/lib/python3.5/asyncio/tasks.py", line 239, in _step
    result = coro.send(None)
  File "/home/phmoll/Desktop/vicn/vicn/core/resource_mgr.py", line 1419, in _process_resource
    raise NotImplementedError
NotImplementedError
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment