autotest: Wireguard pump version

4 files changed, 597 insertions, 644 deletions

diff --git a/docs/configexamples/autotest/Wireguard/Wireguard.log b/docs/configexamples/autotest/Wireguard/Wireguard.log
index aa02352c..3f36b1ab 100644
--- a/docs/configexamples/autotest/Wireguard/Wireguard.log
+++ b/docs/configexamples/autotest/Wireguard/Wireguard.log
@@ -1,630 +1,581 @@
-2021-11-30 21:33:12,893 p=91291 u=rob n=ansible | PLAY [prepare node and Lab] ***********************************************************************************************************************************************
-2021-11-30 21:33:12,911 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : fail] ******************************************************************************************************************************************
-2021-11-30 21:33:12,926 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:12,934 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:12,935 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:12,939 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:12,941 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : fail] ******************************************************************************************************************************************
-2021-11-30 21:33:12,956 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:12,964 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:12,966 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:12,970 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:12,973 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie] ****************************************************************************************************************
-2021-11-30 21:33:13,004 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:13,005 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:13,009 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:13,973 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:13,978 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : get template facts] ****************************************************************************************************************************
-2021-11-30 21:33:14,000 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,005 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,010 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,489 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:14,495 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Register path status] **************************************************************************************************************************
-2021-11-30 21:33:14,522 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,524 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,528 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,833 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:14,836 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : create path] ***********************************************************************************************************************************
-2021-11-30 21:33:14,851 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,859 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,860 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,864 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,867 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Download iso] **********************************************************************************************************************************
-2021-11-30 21:33:14,880 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,886 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,887 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,891 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,893 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : create virtioa.qcow2 file] *********************************************************************************************************************
-2021-11-30 21:33:14,906 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,912 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,914 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,917 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,918 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie] ****************************************************************************************************************
-2021-11-30 21:33:14,930 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,936 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,938 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,941 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,943 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : create lab for node install] *******************************************************************************************************************
-2021-11-30 21:33:14,957 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,963 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,965 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,967 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,969 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : open lab] **************************************************************************************************************************************
-2021-11-30 21:33:14,982 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:14,988 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:14,989 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:14,993 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:14,996 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : set_fact] **************************************************************************************************************************************
-2021-11-30 21:33:15,008 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,013 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,015 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,018 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,020 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : add node to lab] *******************************************************************************************************************************
-2021-11-30 21:33:15,031 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,037 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,039 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,041 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,043 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : start node] ************************************************************************************************************************************
-2021-11-30 21:33:15,056 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,062 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,064 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,067 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,068 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : get node infos] ********************************************************************************************************************************
-2021-11-30 21:33:15,080 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,086 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,089 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,091 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,093 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : set_fact] **************************************************************************************************************************************
-2021-11-30 21:33:15,106 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,111 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,113 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,116 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,119 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : copy file] *************************************************************************************************************************************
-2021-11-30 21:33:15,130 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,136 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,138 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,140 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,143 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : run expect script] *****************************************************************************************************************************
-2021-11-30 21:33:15,155 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,161 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,163 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,166 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,168 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie (due timeout)] **************************************************************************************************
-2021-11-30 21:33:15,180 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,185 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,187 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,190 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,192 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : stop node] *************************************************************************************************************************************
-2021-11-30 21:33:15,203 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,208 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,210 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,213 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,216 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : Pause to wait node is shutdown] ****************************************************************************************************************
-2021-11-30 21:33:15,226 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,228 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : delete iso] ************************************************************************************************************************************
-2021-11-30 21:33:15,241 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,247 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,248 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,253 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,255 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : commit virtioa.qcow2] **************************************************************************************************************************
-2021-11-30 21:33:15,267 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,273 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,275 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,278 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,280 p=91291 u=rob n=ansible | TASK [eve-ng-create-node : delete lab for node install] *******************************************************************************************************************
-2021-11-30 21:33:15,291 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,297 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,299 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,301 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,308 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : fail] *********************************************************************************************************************************************
-2021-11-30 21:33:15,321 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:15,328 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,330 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,333 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:15,335 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************************
-2021-11-30 21:33:15,354 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:15,355 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:15,359 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:16,018 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:16,024 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : get running lab list] *****************************************************************************************************************************
-2021-11-30 21:33:16,052 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:16,054 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:16,058 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:16,535 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:16,541 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : delete existing lab] ******************************************************************************************************************************
-2021-11-30 21:33:16,573 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:16,576 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:16,583 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:17,044 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:17,052 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Ensure labtest is present] ************************************************************************************************************************
-2021-11-30 21:33:17,081 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:17,085 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:17,089 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:17,412 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:17,418 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Create Wireguard Lab] *****************************************************************************************************************************
-2021-11-30 21:33:17,443 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:17,445 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:17,449 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:18,120 p=91291 u=rob n=ansible | changed: [eveng]
-2021-11-30 21:33:18,124 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************************
-2021-11-30 21:33:18,150 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:18,160 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:18,163 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:18,886 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:18,891 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : start vyos-oobm] **********************************************************************************************************************************
-2021-11-30 21:33:18,930 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:33:18,932 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:18,937 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:33:20,115 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:33:20,122 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos-oobm] *******************************************************************************************************************************
-2021-11-30 21:33:20,141 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:33:20,156 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:33:20,161 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:34:03,079 p=91291 u=rob n=ansible | ok: [vyos-oobm]
-2021-11-30 21:34:03,086 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************************
-2021-11-30 21:34:03,116 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:34:03,119 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:34:03,124 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:34:03,840 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:34:03,846 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : get lab status] ***********************************************************************************************************************************
-2021-11-30 21:34:03,873 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:34:03,876 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:34:03,882 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:34:04,356 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:34:04,361 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : start all nodes] **********************************************************************************************************************************
-2021-11-30 21:34:04,391 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:34:04,391 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:34:04,399 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:34:04,972 p=91291 u=rob n=ansible | ok: [eveng] => (item=1)
-2021-11-30 21:34:06,097 p=91291 u=rob n=ansible | ok: [eveng] => (item=4)
-2021-11-30 21:34:07,233 p=91291 u=rob n=ansible | ok: [eveng] => (item=6)
-2021-11-30 21:34:08,143 p=91291 u=rob n=ansible | ok: [eveng] => (item=2)
-2021-11-30 21:34:09,060 p=91291 u=rob n=ansible | ok: [eveng] => (item=3)
-2021-11-30 21:34:09,068 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************************
-2021-11-30 21:34:09,087 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:34:09,096 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:34:10,046 p=91755 u=rob n=ansible | network_os is set to vyos
-2021-11-30 21:34:10,047 p=91756 u=rob n=ansible | network_os is set to vyos
-2021-11-30 21:34:25,068 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
-2021-11-30 21:34:25,071 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:34:25,071 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:34:25,071 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:34:25,071 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     raise socket.timeout()
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | socket.timeout
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
-2021-11-30 21:34:25,072 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     self._check_banner()
-2021-11-30 21:34:25,073 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     raise SSHException(
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:34:25,073 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:34:25,074 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:34:25,075 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:34:25,076 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:34:25,076 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:34:25,076 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:41,100 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:34:41,101 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:34:41,102 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:34:41,103 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:34:41,103 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:34:41,103 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:34:41,103 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:41,112 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
-2021-11-30 21:34:41,113 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:34:41,113 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:34:41,113 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:34:41,113 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:34:41,113 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     raise socket.timeout()
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | socket.timeout
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:34:41,114 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:34:41,115 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     self._check_banner()
-2021-11-30 21:34:41,115 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:34:41,115 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] |     raise SSHException(
-2021-11-30 21:34:41,115 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:34:41,115 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | 
-2021-11-30 21:34:43,749 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:34:43,804 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:34:43,805 p=91756 u=rob n=p=91756 u=rob | paramiko [branch] | Authentication (publickey) successful!
-2021-11-30 21:34:44,529 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:34:57,139 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:34:57,139 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:34:57,140 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:34:57,141 p=91755 u=rob n=p=91755 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:34:57,142 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:34:57,142 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | 
-2021-11-30 21:34:58,833 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:34:58,925 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:34:58,926 p=91755 u=rob n=p=91755 u=rob | paramiko [central] | Authentication (publickey) successful!
-2021-11-30 21:34:59,733 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:34:59,735 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : include Wireguard lab_config.yml] *****************************************************************************************************************
-2021-11-30 21:34:59,750 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:34:59,755 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:34:59,770 p=91291 u=rob n=ansible | included: /Users/rob/git/_vyos/vyos-eveng/labs/Wireguard/lab_config.yml for central, branch
-2021-11-30 21:34:59,787 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : show wireguard keypairs pubkey default] ***********************************************************************************************************
-2021-11-30 21:35:01,570 p=91763 u=rob n=p=91763 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:35:01,657 p=91763 u=rob n=p=91763 u=rob | paramiko [central] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:35:01,658 p=91763 u=rob n=p=91763 u=rob | paramiko [central] | Authentication (publickey) successful!
-2021-11-30 21:35:01,824 p=91764 u=rob n=p=91764 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:35:01,915 p=91764 u=rob n=p=91764 u=rob | paramiko [branch] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:35:01,915 p=91764 u=rob n=p=91764 u=rob | paramiko [branch] | Authentication (publickey) successful!
-2021-11-30 21:35:03,133 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:35:03,426 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:35:03,433 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : fail] *********************************************************************************************************************************************
-2021-11-30 21:35:04,306 p=91291 u=rob n=ansible | fatal: [branch]: FAILED! => {"changed": false, "msg": "Failed as requested from task"}
-2021-11-30 21:35:04,307 p=91291 u=rob n=ansible | fatal: [central]: FAILED! => {"changed": false, "msg": "Failed as requested from task"}
-2021-11-30 21:35:04,317 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : generate wireguard default-keypair] ***************************************************************************************************************
-2021-11-30 21:35:05,666 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:35:05,666 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:35:05,674 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : show wireguard keypairs pubkey default] ***********************************************************************************************************
-2021-11-30 21:35:07,015 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:35:07,016 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:35:07,031 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : setup nodes] **************************************************************************************************************************************
-2021-11-30 21:35:14,895 p=91291 u=rob n=ansible | [WARNING]: To ensure idempotency and correct diff the input configuration lines should be similar to how they appear if present in the running configuration on device
-including the indentation
+2022-03-28 16:02:54,842 p=58769 u=rob n=ansible | [WARNING]: While constructing a mapping from /Users/rob/git/_vyos/vyos-eveng/roles/eve-ng-lab-test/defaults/main.yml, line 4, column 1, found a duplicate dict
+key (upgrade_iso). Using last defined value only.
 
-2021-11-30 21:35:14,895 p=91291 u=rob n=ansible | changed: [central]
-2021-11-30 21:35:14,896 p=91291 u=rob n=ansible | changed: [branch]
-2021-11-30 21:35:14,898 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************************
-2021-11-30 21:35:14,906 p=91977 u=rob n=ansible | Pausing for 30 seconds
-2021-11-30 21:35:14,907 p=91977 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

-2021-11-30 21:35:44,913 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:35:44,926 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************************
-2021-11-30 21:35:44,957 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:44,967 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:35:50,448 p=91291 u=rob n=ansible | ok: [branch] => (item=10.0.1.100)
-2021-11-30 21:35:50,449 p=91291 u=rob n=ansible | ok: [central] => (item=10.0.2.100)
-2021-11-30 21:35:50,454 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************************
-2021-11-30 21:35:50,478 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:50,479 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:35:51,750 p=91291 u=rob n=ansible | ok: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']})
-2021-11-30 21:35:51,920 p=91291 u=rob n=ansible | ok: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']})
-2021-11-30 21:35:52,213 p=91291 u=rob n=ansible | ok: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']})
-2021-11-30 21:35:52,216 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************************
-2021-11-30 21:35:52,241 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:52,242 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:35:53,570 p=91291 u=rob n=ansible | ok: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
-2021-11-30 21:35:53,570 p=91291 u=rob n=ansible | ok: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
-2021-11-30 21:35:56,996 p=91291 u=rob n=ansible | ok: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'})
-2021-11-30 21:35:57,000 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************************
-2021-11-30 21:35:57,017 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:57,024 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:35:57,928 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:35:57,928 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:35:57,938 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Reboot vyos] **************************************************************************************************************************************
-2021-11-30 21:35:57,962 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:57,970 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:35:59,233 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:35:59,233 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:35:59,236 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : wait while shutdown] ******************************************************************************************************************************
-2021-11-30 21:35:59,246 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:59,249 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************************
-2021-11-30 21:35:59,265 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:35:59,270 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:36:00,839 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:36:00,933 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:36:00,934 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Auth banner: b'System is going down. Unprivileged users are not permitted to log in anymore. For technical details, see pam_nologin(8).\n\n'
-2021-11-30 21:36:01,115 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:36:01,182 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:36:01,182 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Auth banner: b'System is going down. Unprivileged users are not permitted to log in anymore. For technical details, see pam_nologin(8).\n\n'
-2021-11-30 21:36:59,483 p=91763 u=rob n=ansible | persistent connection idle timeout triggered, timeout value is 60 secs.
+2022-03-28 16:02:54,842 p=58769 u=rob n=ansible | [WARNING]: While constructing a mapping from /Users/rob/git/_vyos/vyos-eveng/roles/eve-ng-lab-test/defaults/main.yml, line 4, column 1, found a duplicate dict
+key (upgrade_iso_version). Using last defined value only.
+
+2022-03-28 16:02:54,876 p=58769 u=rob n=ansible | PLAY [prepare node and Lab] ***********************************************************************************************************************************
+2022-03-28 16:02:54,894 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : fail] ******************************************************************************************************************************
+2022-03-28 16:02:54,908 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:54,914 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:54,916 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:54,919 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:54,921 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : fail] ******************************************************************************************************************************
+2022-03-28 16:02:54,933 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:54,938 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:54,940 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:54,944 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:54,947 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie] ****************************************************************************************************
+2022-03-28 16:02:54,967 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:54,968 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:54,972 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:55,945 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:55,950 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : get template facts] ****************************************************************************************************************
+2022-03-28 16:02:55,975 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:55,977 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:55,983 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:56,520 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:56,523 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Register path status] **************************************************************************************************************
+2022-03-28 16:02:56,545 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:56,547 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:56,551 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:56,920 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:56,925 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : create path] ***********************************************************************************************************************
+2022-03-28 16:02:56,942 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:56,949 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:56,951 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:56,955 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:56,958 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Download iso] **********************************************************************************************************************
+2022-03-28 16:02:56,971 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:56,977 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:56,979 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:56,983 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:56,986 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : create virtioa.qcow2 file] *********************************************************************************************************
+2022-03-28 16:02:56,999 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,005 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,006 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,009 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,011 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie] ****************************************************************************************************
+2022-03-28 16:02:57,023 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,030 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,031 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,034 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,036 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : create lab for node install] *******************************************************************************************************
+2022-03-28 16:02:57,048 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,054 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,056 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,059 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,061 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : open lab] **************************************************************************************************************************
+2022-03-28 16:02:57,073 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,078 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,080 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,084 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,086 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : set_fact] **************************************************************************************************************************
+2022-03-28 16:02:57,098 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,103 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,105 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,108 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,110 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : add node to lab] *******************************************************************************************************************
+2022-03-28 16:02:57,122 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,127 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,129 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,132 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,134 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : start node] ************************************************************************************************************************
+2022-03-28 16:02:57,146 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,152 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,154 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,156 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,159 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : get node infos] ********************************************************************************************************************
+2022-03-28 16:02:57,171 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,176 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,179 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,182 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,184 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : set_fact] **************************************************************************************************************************
+2022-03-28 16:02:57,195 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,200 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,202 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,206 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,209 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : copy file] *************************************************************************************************************************
+2022-03-28 16:02:57,221 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,226 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,229 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,231 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,234 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : run expect script] *****************************************************************************************************************
+2022-03-28 16:02:57,246 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,251 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,253 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,256 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,258 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Login to EVE-NG and get Cookie (due timeout)] **************************************************************************************
+2022-03-28 16:02:57,270 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,275 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,277 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,281 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,283 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : stop node] *************************************************************************************************************************
+2022-03-28 16:02:57,294 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,300 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,301 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,306 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,308 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : Pause to wait node is shutdown] ****************************************************************************************************
+2022-03-28 16:02:57,316 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,318 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : delete iso] ************************************************************************************************************************
+2022-03-28 16:02:57,334 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,336 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,336 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,340 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,342 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : commit virtioa.qcow2] **************************************************************************************************************
+2022-03-28 16:02:57,354 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,361 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,363 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,365 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,367 p=58769 u=rob n=ansible | TASK [eve-ng-create-node : delete lab for node install] *******************************************************************************************************
+2022-03-28 16:02:57,379 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:57,385 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:57,387 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:57,389 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:57,396 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Get env file content] *****************************************************************************************************************
+2022-03-28 16:02:57,595 p=58769 u=rob n=ansible | ok: [vyos-oobm -> localhost]
+2022-03-28 16:02:57,595 p=58769 u=rob n=ansible | ok: [eveng -> localhost]
+2022-03-28 16:02:57,595 p=58769 u=rob n=ansible | ok: [central -> localhost]
+2022-03-28 16:02:57,595 p=58769 u=rob n=ansible | ok: [branch -> localhost]
+2022-03-28 16:02:57,597 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Load facts] ***************************************************************************************************************************
+2022-03-28 16:02:57,616 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:57,618 p=58769 u=rob n=ansible | ok: [vyos-oobm]
+2022-03-28 16:02:58,489 p=58998 u=rob n=ansible | network_os is set to vyos
+2022-03-28 16:02:58,489 p=58997 u=rob n=ansible | network_os is set to vyos
+2022-03-28 16:02:58,496 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:02:58,496 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:02:58,502 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : fail] *********************************************************************************************************************************
+2022-03-28 16:02:58,522 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:02:58,530 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:58,532 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:58,537 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:58,540 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:02:58,561 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:58,563 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:58,567 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:59,248 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:59,253 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : get running lab list] *****************************************************************************************************************
+2022-03-28 16:02:59,280 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:59,282 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:59,288 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:02:59,836 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:02:59,842 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : delete existing lab] ******************************************************************************************************************
+2022-03-28 16:02:59,870 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:02:59,873 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:02:59,878 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:00,525 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:00,531 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Ensure labtest is present] ************************************************************************************************************
+2022-03-28 16:03:00,557 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:00,559 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:00,565 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:00,973 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:00,979 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Create Wireguard Lab] *****************************************************************************************************************
+2022-03-28 16:03:01,004 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:01,006 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:01,012 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:01,941 p=58769 u=rob n=ansible | changed: [eveng]
+2022-03-28 16:03:01,946 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:03:01,972 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:01,974 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:01,979 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:02,680 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:02,685 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : start vyos-oobm] **********************************************************************************************************************
+2022-03-28 16:03:02,712 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:02,714 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:02,720 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:03,737 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:03,744 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos-oobm] *******************************************************************************************************************
+2022-03-28 16:03:03,764 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:03:03,773 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:03,779 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:44,633 p=58769 u=rob n=ansible | ok: [vyos-oobm]
+2022-03-28 16:03:44,639 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:03:44,669 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:44,670 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:44,677 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:45,416 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:45,420 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : get lab status] ***********************************************************************************************************************
+2022-03-28 16:03:45,445 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:45,447 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:45,452 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:45,995 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:03:46,000 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : start all nodes] **********************************************************************************************************************
+2022-03-28 16:03:46,028 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:03:46,030 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:03:46,037 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:03:46,576 p=58769 u=rob n=ansible | ok: [eveng] => (item=1)
+2022-03-28 16:03:47,594 p=58769 u=rob n=ansible | ok: [eveng] => (item=4)
+2022-03-28 16:03:48,707 p=58769 u=rob n=ansible | ok: [eveng] => (item=6)
+2022-03-28 16:03:49,730 p=58769 u=rob n=ansible | ok: [eveng] => (item=2)
+2022-03-28 16:03:50,763 p=58769 u=rob n=ansible | ok: [eveng] => (item=3)
+2022-03-28 16:03:50,771 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************
+2022-03-28 16:03:50,790 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:03:50,798 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:04:06,672 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:06,675 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:06,675 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:06,675 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:06,675 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise socket.timeout()
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | socket.timeout
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:06,676 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:06,677 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     self._check_banner()
+2022-03-28 16:04:06,677 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:06,677 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise SSHException(
+2022-03-28 16:04:06,677 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:06,677 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:06,679 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:06,680 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise socket.timeout()
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | socket.timeout
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:06,681 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     self._check_banner()
+2022-03-28 16:04:06,682 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:06,682 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise SSHException(
+2022-03-28 16:04:06,682 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:06,682 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:22,708 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:22,709 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:22,709 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:22,709 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:22,709 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise socket.timeout()
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | socket.timeout
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:22,710 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     self._check_banner()
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise SSHException(
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:22,711 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:22,717 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:22,717 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:22,717 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise socket.timeout()
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | socket.timeout
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:22,718 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     self._check_banner()
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise SSHException(
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:22,719 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:38,739 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:38,739 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise socket.timeout()
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | socket.timeout
+2022-03-28 16:04:38,740 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Traceback (most recent call last):
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     self._check_banner()
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] |     raise SSHException(
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:38,741 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | 
+2022-03-28 16:04:38,743 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise socket.timeout()
+2022-03-28 16:04:38,744 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | socket.timeout
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Traceback (most recent call last):
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     self._check_banner()
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
+2022-03-28 16:04:38,745 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] |     raise SSHException(
+2022-03-28 16:04:38,746 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
+2022-03-28 16:04:38,746 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | 
+2022-03-28 16:04:40,534 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:04:40,538 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:04:40,651 p=59290 u=rob n=p=59290 u=rob | paramiko [central] | Authentication (publickey) successful!
+2022-03-28 16:04:40,658 p=59291 u=rob n=p=59291 u=rob | paramiko [branch] | Authentication (publickey) successful!
+2022-03-28 16:04:41,539 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:04:41,566 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:04:41,568 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : include Wireguard lab_config.yml] *****************************************************************************************************
+2022-03-28 16:04:41,581 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:04:41,588 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:04:41,599 p=58769 u=rob n=ansible | included: /Users/rob/git/_vyos/vyos-eveng/labs/Wireguard/lab_config.yml for central, branch
+2022-03-28 16:04:41,621 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : generate pki wireguard key-pair] ******************************************************************************************************
+2022-03-28 16:04:43,364 p=59005 u=rob n=p=59005 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:04:43,368 p=59006 u=rob n=p=59006 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:04:43,457 p=59006 u=rob n=p=59006 u=rob | paramiko [branch] | Authentication (publickey) successful!
+2022-03-28 16:04:43,457 p=59005 u=rob n=p=59005 u=rob | paramiko [central] | Authentication (publickey) successful!
+2022-03-28 16:04:45,078 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:04:45,124 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:04:45,129 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : set pub and private key] **************************************************************************************************************
+2022-03-28 16:04:45,985 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:04:45,985 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:04:46,008 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : setup nodes] **************************************************************************************************************************
+2022-03-28 16:04:53,892 p=58769 u=rob n=ansible | [WARNING]: To ensure idempotency and correct diff the input configuration lines should be similar to how they appear if present in the running configuration
+on device including the indentation
+
+2022-03-28 16:04:53,892 p=58769 u=rob n=ansible | changed: [central]
+2022-03-28 16:04:54,063 p=58769 u=rob n=ansible | changed: [branch]
+2022-03-28 16:04:54,067 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:04:54,090 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:04:54,091 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:04:54,095 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:04:55,312 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:04:55,317 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : stop nodes id] ************************************************************************************************************************
+2022-03-28 16:04:55,360 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after stop] **********************************************************************************************************************
+2022-03-28 16:04:55,369 p=59455 u=rob n=ansible | Pausing for 5 seconds
+2022-03-28 16:04:55,369 p=59455 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:05:00,378 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:05:00,384 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : start nodes id] ***********************************************************************************************************************
+2022-03-28 16:05:00,433 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after start] *********************************************************************************************************************
+2022-03-28 16:05:00,442 p=59461 u=rob n=ansible | Pausing for 5 seconds
+2022-03-28 16:05:00,442 p=59461 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:05:05,449 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:05:05,470 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************
+2022-03-28 16:05:05,485 p=59481 u=rob n=ansible | Pausing for 30 seconds
+2022-03-28 16:05:05,485 p=59481 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:05:35,492 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:05:35,500 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************
+2022-03-28 16:05:35,533 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:35,543 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:40,906 p=58769 u=rob n=ansible | ok: [branch] => (item=10.0.1.100)
+2022-03-28 16:05:40,983 p=58769 u=rob n=ansible | ok: [central] => (item=10.0.2.100)
+2022-03-28 16:05:40,987 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************
+2022-03-28 16:05:41,008 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:41,008 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:42,252 p=58769 u=rob n=ansible | ok: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']})
+2022-03-28 16:05:42,488 p=58769 u=rob n=ansible | ok: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']})
+2022-03-28 16:05:42,780 p=58769 u=rob n=ansible | ok: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']})
+2022-03-28 16:05:42,786 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************
+2022-03-28 16:05:42,811 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:42,811 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:44,167 p=58769 u=rob n=ansible | ok: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
+2022-03-28 16:05:44,169 p=58769 u=rob n=ansible | ok: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
+2022-03-28 16:05:47,614 p=58769 u=rob n=ansible | ok: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'})
+2022-03-28 16:05:47,620 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************
+2022-03-28 16:05:47,642 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:47,644 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:48,496 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:05:48,497 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:05:48,508 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Reboot vyos] **************************************************************************************************************************
+2022-03-28 16:05:48,533 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:48,540 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:49,806 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:05:49,806 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:05:49,809 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait while shutdown] ******************************************************************************************************************
+2022-03-28 16:05:49,819 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:49,822 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************
+2022-03-28 16:05:49,835 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:05:49,842 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:05:51,249 p=59714 u=rob n=p=59714 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:05:51,249 p=59715 u=rob n=p=59715 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:05:51,385 p=59714 u=rob n=p=59714 u=rob | paramiko [central] | Auth banner: b'System is going down. Unprivileged users are not permitted to log in anymore. For technical details, see pam_nologin(8).\n\n'
+2022-03-28 16:05:51,387 p=59715 u=rob n=p=59715 u=rob | paramiko [branch] | Auth banner: b'System is going down. Unprivileged users are not permitted to log in anymore. For technical details, see pam_nologin(8).\n\n'
+2022-03-28 16:07:50,046 p=59005 u=rob n=ansible | persistent connection idle timeout triggered, timeout value is 120 secs.
 See the timeout setting options in the Network Debug and Troubleshooting Guide.
-2021-11-30 21:36:59,489 p=91764 u=rob n=ansible | persistent connection idle timeout triggered, timeout value is 60 secs.
+2022-03-28 16:07:50,047 p=59006 u=rob n=ansible | persistent connection idle timeout triggered, timeout value is 120 secs.
 See the timeout setting options in the Network Debug and Troubleshooting Guide.
-2021-11-30 21:36:59,590 p=91763 u=rob n=ansible | shutdown complete
-2021-11-30 21:36:59,593 p=91764 u=rob n=ansible | shutdown complete
-2021-11-30 21:37:17,017 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:17,020 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:17,020 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise socket.timeout()
-2021-11-30 21:37:17,021 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | socket.timeout
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:17,022 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     self._check_banner()
-2021-11-30 21:37:17,023 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:17,023 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise SSHException(
-2021-11-30 21:37:17,023 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:17,023 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:17,255 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:17,256 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:17,256 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:17,256 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:17,256 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:17,257 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:17,258 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:33,055 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:33,055 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:33,056 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:33,056 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:33,056 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:33,056 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:33,056 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise socket.timeout()
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | socket.timeout
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:33,057 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     self._check_banner()
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise SSHException(
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:33,058 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:33,273 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:33,273 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:37:33,274 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:33,275 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:37:33,276 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:33,276 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:37:33,276 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:33,276 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:49,085 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:49,086 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:49,086 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:49,086 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:49,086 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:49,086 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise socket.timeout()
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | socket.timeout
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:49,087 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Traceback (most recent call last):
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     self._check_banner()
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] |     raise SSHException(
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:49,088 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | 
-2021-11-30 21:37:49,307 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Exception: Error reading SSH protocol banner
-2021-11-30 21:37:49,307 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:49,307 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2211, in _check_banner
-2021-11-30 21:37:49,307 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf = self.packetizer.readline(timeout)
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 380, in readline
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     buf += self._read_timeout(timeout)
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/packet.py", line 622, in _read_timeout
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise socket.timeout()
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | socket.timeout
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:49,308 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | During handling of the above exception, another exception occurred:
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Traceback (most recent call last):
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2039, in run
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     self._check_banner()
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |   File "/Users/rob/.local/share/virtualenvs/vyos-eveng-b9X2mBdh/lib/python3.9/site-packages/paramiko/transport.py", line 2215, in _check_banner
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] |     raise SSHException(
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | paramiko.ssh_exception.SSHException: Error reading SSH protocol banner
-2021-11-30 21:37:49,309 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | 
-2021-11-30 21:37:51,170 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:37:51,370 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:37:51,370 p=92210 u=rob n=p=92210 u=rob | paramiko [branch] | Authentication (publickey) successful!
-2021-11-30 21:37:51,512 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:37:51,709 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:37:51,709 p=92209 u=rob n=p=92209 u=rob | paramiko [central] | Authentication (publickey) successful!
-2021-11-30 21:37:52,515 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:37:52,741 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:37:52,746 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************************
-2021-11-30 21:37:52,753 p=92299 u=rob n=ansible | Pausing for 30 seconds
-2021-11-30 21:37:52,753 p=92299 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

-2021-11-30 21:38:22,856 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:38:22,863 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************************
-2021-11-30 21:38:22,899 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:22,900 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:23,861 p=92310 u=rob n=ansible | network_os is set to vyos
-2021-11-30 21:38:23,863 p=92309 u=rob n=ansible | network_os is set to vyos
-2021-11-30 21:38:25,085 p=92318 u=rob n=p=92318 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:38:25,085 p=92317 u=rob n=p=92317 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_7.9p1)
-2021-11-30 21:38:25,174 p=92318 u=rob n=p=92318 u=rob | paramiko [branch] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:38:25,175 p=92318 u=rob n=p=92318 u=rob | paramiko [branch] | Authentication (publickey) successful!
-2021-11-30 21:38:25,176 p=92317 u=rob n=p=92317 u=rob | paramiko [central] | Auth banner: b'Welcome to VyOS\n\n'
-2021-11-30 21:38:25,176 p=92317 u=rob n=p=92317 u=rob | paramiko [central] | Authentication (publickey) successful!
-2021-11-30 21:38:31,822 p=91291 u=rob n=ansible | ok: [central] => (item=10.0.2.100)
-2021-11-30 21:38:31,823 p=91291 u=rob n=ansible | ok: [branch] => (item=10.0.1.100)
-2021-11-30 21:38:31,827 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************************
-2021-11-30 21:38:31,846 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:31,855 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:33,035 p=91291 u=rob n=ansible | ok: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']})
-2021-11-30 21:38:33,213 p=91291 u=rob n=ansible | ok: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']})
-2021-11-30 21:38:33,515 p=91291 u=rob n=ansible | ok: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']})
-2021-11-30 21:38:33,520 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************************
-2021-11-30 21:38:33,547 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:33,548 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:34,881 p=91291 u=rob n=ansible | ok: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
-2021-11-30 21:38:34,882 p=91291 u=rob n=ansible | ok: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'})
-2021-11-30 21:38:38,374 p=91291 u=rob n=ansible | ok: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'})
-2021-11-30 21:38:38,378 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************************
-2021-11-30 21:38:38,396 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:38,403 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,272 p=91291 u=rob n=ansible | ok: [central]
-2021-11-30 21:38:39,273 p=91291 u=rob n=ansible | ok: [branch]
-2021-11-30 21:38:39,282 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : make sure tmp dir exist] **************************************************************************************************************************
-2021-11-30 21:38:39,311 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,322 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,322 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,328 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,332 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Download upgrade_iso] *****************************************************************************************************************************
-2021-11-30 21:38:39,352 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,360 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,361 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,365 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,370 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Copy iso to host] *********************************************************************************************************************************
-2021-11-30 21:38:39,383 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,392 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,393 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,396 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,399 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : upgrade vyos] *************************************************************************************************************************************
-2021-11-30 21:38:39,412 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,420 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,421 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,424 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,426 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Reboot vyos] **************************************************************************************************************************************
-2021-11-30 21:38:39,439 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,447 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,449 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,452 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,454 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : wait while shutdown] ******************************************************************************************************************************
-2021-11-30 21:38:39,462 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,463 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************************
-2021-11-30 21:38:39,476 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,482 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,484 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,488 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,492 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : clear tmp dir] ************************************************************************************************************************************
-2021-11-30 21:38:39,499 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,501 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************************
-2021-11-30 21:38:39,509 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,511 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************************
-2021-11-30 21:38:39,524 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,529 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,536 p=91291 u=rob n=ansible | skipping: [central] => (item=10.0.2.100) 
-2021-11-30 21:38:39,540 p=91291 u=rob n=ansible | skipping: [branch] => (item=10.0.1.100) 
-2021-11-30 21:38:39,543 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************************
-2021-11-30 21:38:39,557 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,563 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,571 p=91291 u=rob n=ansible | skipping: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']}) 
-2021-11-30 21:38:39,571 p=91291 u=rob n=ansible | skipping: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']}) 
-2021-11-30 21:38:39,575 p=91291 u=rob n=ansible | skipping: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']}) 
-2021-11-30 21:38:39,578 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************************
-2021-11-30 21:38:39,591 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,597 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,605 p=91291 u=rob n=ansible | skipping: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
-2021-11-30 21:38:39,605 p=91291 u=rob n=ansible | skipping: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'}) 
-2021-11-30 21:38:39,608 p=91291 u=rob n=ansible | skipping: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
-2021-11-30 21:38:39,611 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************************
-2021-11-30 21:38:39,625 p=91291 u=rob n=ansible | skipping: [eveng]
-2021-11-30 21:38:39,633 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,633 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,636 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,639 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : make sure output dir exist] ***********************************************************************************************************************
-2021-11-30 21:38:39,661 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,661 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,666 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,835 p=91291 u=rob n=ansible | ok: [eveng -> localhost]
-2021-11-30 21:38:39,838 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : make sure output include dir exist] ***************************************************************************************************************
-2021-11-30 21:38:39,861 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,862 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,866 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:39,967 p=91291 u=rob n=ansible | ok: [eveng -> localhost]
-2021-11-30 21:38:39,969 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Get timestamp from the system] ********************************************************************************************************************
-2021-11-30 21:38:39,990 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:39,991 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:39,995 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:40,525 p=91291 u=rob n=ansible | changed: [eveng]
-2021-11-30 21:38:40,529 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************************
-2021-11-30 21:38:40,553 p=91291 u=rob n=ansible | ok: [eveng]
-2021-11-30 21:38:40,555 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:40,555 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:40,559 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:40,562 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : generate lab rst file] ****************************************************************************************************************************
-2021-11-30 21:38:40,587 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:40,588 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:40,592 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:40,808 p=91291 u=rob n=ansible | changed: [eveng -> localhost]
-2021-11-30 21:38:40,811 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : find all *.conf files in Lab] *********************************************************************************************************************
-2021-11-30 21:38:40,834 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:40,835 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:40,839 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:41,002 p=91291 u=rob n=ansible | ok: [eveng -> localhost]
-2021-11-30 21:38:41,010 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : copy all *.conf files] ****************************************************************************************************************************
-2021-11-30 21:38:41,038 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:41,039 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:41,045 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:41,253 p=91291 u=rob n=ansible | changed: [eveng -> localhost] => (item={'path': 'labs/Wireguard/branch.conf', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 675, 'inode': 33278983, 'dev': 16777233, 'nlink': 1, 'atime': 1638304349.8431501, 'mtime': 1638304348.138039, 'ctime': 1638304348.138039, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
-2021-11-30 21:38:41,469 p=91291 u=rob n=ansible | changed: [eveng -> localhost] => (item={'path': 'labs/Wireguard/central.conf', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 668, 'inode': 33278984, 'dev': 16777233, 'nlink': 1, 'atime': 1638304349.7118278, 'mtime': 1638304348.1385467, 'ctime': 1638304348.1385467, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
-2021-11-30 21:38:41,474 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : find all *.png files in Lab] **********************************************************************************************************************
-2021-11-30 21:38:41,498 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:41,499 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:41,504 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:41,599 p=91291 u=rob n=ansible | ok: [eveng -> localhost]
-2021-11-30 21:38:41,604 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : copy all *.png files] *****************************************************************************************************************************
-2021-11-30 21:38:41,630 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:41,631 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:41,637 p=91291 u=rob n=ansible | skipping: [branch]
-2021-11-30 21:38:41,889 p=91291 u=rob n=ansible | ok: [eveng -> localhost] => (item={'path': 'labs/Wireguard/topology.png', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 158227, 'inode': 31651192, 'dev': 16777233, 'nlink': 1, 'atime': 1637677693.6729753, 'mtime': 1637092135.8691404, 'ctime': 1637092174.4312608, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
-2021-11-30 21:38:41,894 p=91291 u=rob n=ansible | TASK [eve-ng-lab-test : copy ansible log files] ***************************************************************************************************************************
-2021-11-30 21:38:41,917 p=91291 u=rob n=ansible | skipping: [vyos-oobm]
-2021-11-30 21:38:41,918 p=91291 u=rob n=ansible | skipping: [central]
-2021-11-30 21:38:41,922 p=91291 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:07:50,150 p=59006 u=rob n=ansible | shutdown complete
+2022-03-28 16:07:50,150 p=59005 u=rob n=ansible | shutdown complete
+2022-03-28 16:07:53,317 p=59715 u=rob n=p=59715 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:07:53,320 p=59714 u=rob n=p=59714 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:07:53,394 p=59714 u=rob n=p=59714 u=rob | paramiko [central] | Authentication (publickey) successful!
+2022-03-28 16:07:53,403 p=59715 u=rob n=p=59715 u=rob | paramiko [branch] | Authentication (publickey) successful!
+2022-03-28 16:07:54,548 p=58769 u=rob n=ansible | ok: [branch]
+2022-03-28 16:07:54,555 p=58769 u=rob n=ansible | ok: [central]
+2022-03-28 16:07:54,557 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:07:54,575 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:07:54,577 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:07:54,581 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:07:55,831 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:07:55,836 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : stop nodes id] ************************************************************************************************************************
+2022-03-28 16:07:55,882 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after stop] **********************************************************************************************************************
+2022-03-28 16:07:55,892 p=59800 u=rob n=ansible | Pausing for 5 seconds
+2022-03-28 16:07:55,892 p=59800 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:08:00,900 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:08:00,906 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : start nodes id] ***********************************************************************************************************************
+2022-03-28 16:08:00,956 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after start] *********************************************************************************************************************
+2022-03-28 16:08:00,965 p=59806 u=rob n=ansible | Pausing for 5 seconds
+2022-03-28 16:08:00,966 p=59806 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:08:05,971 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:08:05,977 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************
+2022-03-28 16:08:05,991 p=59807 u=rob n=ansible | Pausing for 30 seconds
+2022-03-28 16:08:05,991 p=59807 u=rob n=ansible | (ctrl+C then 'C' = continue early, ctrl+C then 'A' = abort)

+2022-03-28 16:08:36,001 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:08:36,007 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************
+2022-03-28 16:08:36,038 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:36,038 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:36,916 p=59814 u=rob n=ansible | network_os is set to vyos
+2022-03-28 16:08:36,916 p=59813 u=rob n=ansible | network_os is set to vyos
+2022-03-28 16:08:37,840 p=59821 u=rob n=p=59821 u=rob | paramiko [central] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:08:37,840 p=59822 u=rob n=p=59822 u=rob | paramiko [branch] | Connected (version 2.0, client OpenSSH_8.4p1)
+2022-03-28 16:08:37,918 p=59822 u=rob n=p=59822 u=rob | paramiko [branch] | Authentication (publickey) successful!
+2022-03-28 16:08:37,919 p=59821 u=rob n=p=59821 u=rob | paramiko [central] | Authentication (publickey) successful!
+2022-03-28 16:08:43,633 p=58769 u=rob n=ansible | ok: [branch] => (item=10.0.1.100)
+2022-03-28 16:08:43,666 p=58769 u=rob n=ansible | ok: [central] => (item=10.0.2.100)
+2022-03-28 16:08:43,669 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************
+2022-03-28 16:08:43,688 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:43,688 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:44,864 p=58769 u=rob n=ansible | ok: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']})
+2022-03-28 16:08:45,060 p=58769 u=rob n=ansible | ok: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']})
+2022-03-28 16:08:45,371 p=58769 u=rob n=ansible | ok: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']})
+2022-03-28 16:08:45,376 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************
+2022-03-28 16:08:45,400 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,400 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,408 p=58769 u=rob n=ansible | skipping: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
+2022-03-28 16:08:45,408 p=58769 u=rob n=ansible | skipping: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'}) 
+2022-03-28 16:08:45,412 p=58769 u=rob n=ansible | skipping: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
+2022-03-28 16:08:45,415 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************
+2022-03-28 16:08:45,433 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,433 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,435 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,440 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,443 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : make sure tmp dir exist] **************************************************************************************************************
+2022-03-28 16:08:45,458 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,465 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,467 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,469 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,472 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : register status of tmp/] **************************************************************************************************************
+2022-03-28 16:08:45,485 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,491 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,493 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,496 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,499 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Download upgrade_iso] *****************************************************************************************************************
+2022-03-28 16:08:45,513 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,520 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,522 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,525 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,528 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Copy iso to host] *********************************************************************************************************************
+2022-03-28 16:08:45,542 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,548 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,549 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,553 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,555 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : upgrade vyos] *************************************************************************************************************************
+2022-03-28 16:08:45,567 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,574 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,576 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,578 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,580 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Reboot vyos] **************************************************************************************************************************
+2022-03-28 16:08:45,593 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,598 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,601 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,603 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,606 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait while shutdown] ******************************************************************************************************************
+2022-03-28 16:08:45,613 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,615 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Wait for vyos nodes] ******************************************************************************************************************
+2022-03-28 16:08:45,626 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,633 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,634 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,638 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,641 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : clear tmp dir] ************************************************************************************************************************
+2022-03-28 16:08:45,649 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,651 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Login to EVE-NG and get Cookie] *******************************************************************************************************
+2022-03-28 16:08:45,664 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,670 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,672 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,675 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,677 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : stop nodes id] ************************************************************************************************************************
+2022-03-28 16:08:45,709 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after stop] **********************************************************************************************************************
+2022-03-28 16:08:45,716 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,718 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : start nodes id] ***********************************************************************************************************************
+2022-03-28 16:08:45,748 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait after start] *********************************************************************************************************************
+2022-03-28 16:08:45,755 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,757 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : wait, b/c the ping often failed without a short break] ********************************************************************************
+2022-03-28 16:08:45,764 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,766 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : do ping test] *************************************************************************************************************************
+2022-03-28 16:08:45,779 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,784 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,791 p=58769 u=rob n=ansible | skipping: [central] => (item=10.0.2.100) 
+2022-03-28 16:08:45,795 p=58769 u=rob n=ansible | skipping: [branch] => (item=10.0.1.100) 
+2022-03-28 16:08:45,799 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : execute test commands] ****************************************************************************************************************
+2022-03-28 16:08:45,812 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,818 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,826 p=58769 u=rob n=ansible | skipping: [central] => (item={'desc': 'Test if IP is set to interface', 'command': "ip -4 addr show dev eth2 | grep inet | tr -s ' ' | cut -d' ' -f3 | head -n 1", 'wait_for': ['result[0] contains "10.0.1.254/24"']}) 
+2022-03-28 16:08:45,826 p=58769 u=rob n=ansible | skipping: [central] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.1/24                    u/u  VPN-to-Branch"']}) 
+2022-03-28 16:08:45,829 p=58769 u=rob n=ansible | skipping: [branch] => (item={'desc': 'show interfaces wireguard', 'command': 'show interfaces wireguard', 'wait_for': ['result[0] contains "S - State, L - Link, u - Up, D - Down, A - Admin Down"', 'result[0] contains "Interface        IP Address                        S/L  Description"', 'result[0] contains "---------        ----------                        ---  -----------"', 'result[0] contains "wg01             192.168.0.2/24                    u/u  VPN-to-central"']}) 
+2022-03-28 16:08:45,832 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : register stdout commands] *************************************************************************************************************
+2022-03-28 16:08:45,844 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,849 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,857 p=58769 u=rob n=ansible | skipping: [central] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
+2022-03-28 16:08:45,858 p=58769 u=rob n=ansible | skipping: [central] => (item={'name': 'ping_branch_pc', 'command': 'ping 10.0.2.100 count 4'}) 
+2022-03-28 16:08:45,861 p=58769 u=rob n=ansible | skipping: [branch] => (item={'name': 'show_interfaces_wireguard', 'command': 'show interfaces wireguard'}) 
+2022-03-28 16:08:45,864 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************
+2022-03-28 16:08:45,876 p=58769 u=rob n=ansible | skipping: [eveng]
+2022-03-28 16:08:45,882 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,884 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,887 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:45,890 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : make sure output dir exist] ***********************************************************************************************************
+2022-03-28 16:08:45,911 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:45,912 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:45,916 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:46,079 p=58769 u=rob n=ansible | ok: [eveng -> localhost]
+2022-03-28 16:08:46,082 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : make sure output include dir exist] ***************************************************************************************************
+2022-03-28 16:08:46,105 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:46,106 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:46,110 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:46,211 p=58769 u=rob n=ansible | ok: [eveng -> localhost]
+2022-03-28 16:08:46,213 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Get timestamp from the system] ********************************************************************************************************
+2022-03-28 16:08:46,231 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:46,232 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:46,237 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:46,640 p=58769 u=rob n=ansible | changed: [eveng]
+2022-03-28 16:08:46,645 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : Set variables] ************************************************************************************************************************
+2022-03-28 16:08:46,672 p=58769 u=rob n=ansible | ok: [eveng]
+2022-03-28 16:08:46,674 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:46,674 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:46,679 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:46,683 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : generate lab rst file] ****************************************************************************************************************
+2022-03-28 16:08:46,707 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:46,708 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:46,712 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:46,924 p=58769 u=rob n=ansible | changed: [eveng -> localhost]
+2022-03-28 16:08:46,927 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : find all *.conf files in Lab] *********************************************************************************************************
+2022-03-28 16:08:46,948 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:46,949 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:46,953 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:47,112 p=58769 u=rob n=ansible | ok: [eveng -> localhost]
+2022-03-28 16:08:47,120 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : copy all *.conf files] ****************************************************************************************************************
+2022-03-28 16:08:47,144 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:47,145 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:47,150 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:47,359 p=58769 u=rob n=ansible | changed: [eveng -> localhost] => (item={'path': 'labs/Wireguard/branch.conf', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 736, 'inode': 43810360, 'dev': 16777234, 'nlink': 1, 'atime': 1648476161.0878496, 'mtime': 1648476158.9426005, 'ctime': 1648476158.9426005, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
+2022-03-28 16:08:47,574 p=58769 u=rob n=ansible | changed: [eveng -> localhost] => (item={'path': 'labs/Wireguard/central.conf', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 730, 'inode': 43810361, 'dev': 16777234, 'nlink': 1, 'atime': 1648476011.390948, 'mtime': 1648476009.029482, 'ctime': 1648476009.029482, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
+2022-03-28 16:08:47,578 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : find all *.png files in Lab] **********************************************************************************************************
+2022-03-28 16:08:47,605 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:47,606 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:47,611 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:47,708 p=58769 u=rob n=ansible | ok: [eveng -> localhost]
+2022-03-28 16:08:47,713 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : copy all *.png files] *****************************************************************************************************************
+2022-03-28 16:08:47,737 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:47,738 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:47,743 p=58769 u=rob n=ansible | skipping: [branch]
+2022-03-28 16:08:47,994 p=58769 u=rob n=ansible | ok: [eveng -> localhost] => (item={'path': 'labs/Wireguard/topology.png', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 501, 'gid': 20, 'size': 158227, 'inode': 43214258, 'dev': 16777234, 'nlink': 1, 'atime': 1648155124.1537304, 'mtime': 1648155110.802489, 'ctime': 1648155110.802489, 'gr_name': 'staff', 'pw_name': 'rob', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False})
+2022-03-28 16:08:47,997 p=58769 u=rob n=ansible | TASK [eve-ng-lab-test : copy ansible log files] ***************************************************************************************************************
+2022-03-28 16:08:48,020 p=58769 u=rob n=ansible | skipping: [vyos-oobm]
+2022-03-28 16:08:48,020 p=58769 u=rob n=ansible | skipping: [central]
+2022-03-28 16:08:48,024 p=58769 u=rob n=ansible | skipping: [branch]
diff --git a/docs/configexamples/autotest/Wireguard/Wireguard.rst b/docs/configexamples/autotest/Wireguard/Wireguard.rst
index 73539e2f..3b0db0f3 100644
--- a/docs/configexamples/autotest/Wireguard/Wireguard.rst
+++ b/docs/configexamples/autotest/Wireguard/Wireguard.rst
@@ -3,8 +3,8 @@ Wireguard
 #########
 
 
-| Testdate: 2021-11-30
-| Version: 1.4-rolling-202104132216
+| Testdate: 2022-03-28
+| Version: 1.4-rolling-202203280217
 
 
 This simple structure show how to connect two offices. One remote branch and the
@@ -44,9 +44,9 @@ After this, the public key can be displayed, to save for later.
 
 .. code-block:: none
 
-   vyos@central:~$ generate wireguard default-keypair
-   vyos@central:~$ show wireguard keypairs pubkey default
-   P9y9TTRzIOVl27Ij9n/BXjZUdQFADZ5WnHV0kQr1ulQ=
+   vyos@central:~$ generate pki wireguard
+   Private key: 2BmTwXO1NpakOsa2ynnIqW3c1s3aT/gVtCUJnecefXY=
+   Public key: BU+4Dyr3VldI2DJiBji50Egqr58071puYdXhoyRvuH8=
 
 
 After you have each public key. The wireguard interfaces can be setup.
@@ -56,13 +56,13 @@ Central
 
 .. literalinclude:: _include/central.conf
    :language: none
-   :lines: 4-11
+   :lines: 4-12
 
 Branch
 
 .. literalinclude:: _include/branch.conf
    :language: none
-   :lines: 4-11
+   :lines: 4-12
 
 
 To reach the network, a route must be set on each VyOS host.
@@ -72,13 +72,13 @@ Central
 
 .. literalinclude:: _include/central.conf
    :language: none
-   :lines: 13
+   :lines: 14
 
 Branch
 
 .. literalinclude:: _include/branch.conf
    :language: none
-   :lines: 13
+   :lines: 14
 
 *********************
 Testing and debugging
@@ -102,11 +102,11 @@ And ping the Branch PC from your central router to check the response.
 
    vyos@central:~$ ping 10.0.2.100 count 4
    PING 10.0.2.100 (10.0.2.100) 56(84) bytes of data.
-   64 bytes from 10.0.2.100: icmp_seq=1 ttl=63 time=0.526 ms
-   64 bytes from 10.0.2.100: icmp_seq=2 ttl=63 time=0.583 ms
-   64 bytes from 10.0.2.100: icmp_seq=3 ttl=63 time=0.873 ms
-   64 bytes from 10.0.2.100: icmp_seq=4 ttl=63 time=0.753 ms
+   64 bytes from 10.0.2.100: icmp_seq=1 ttl=63 time=0.580 ms
+   64 bytes from 10.0.2.100: icmp_seq=2 ttl=63 time=0.862 ms
+   64 bytes from 10.0.2.100: icmp_seq=3 ttl=63 time=0.754 ms
+   64 bytes from 10.0.2.100: icmp_seq=4 ttl=63 time=0.669 ms
    
    --- 10.0.2.100 ping statistics ---
-   4 packets transmitted, 4 received, 0% packet loss, time 48ms
-   rtt min/avg/max/mdev = 0.526/0.683/0.873/0.141 ms
+   4 packets transmitted, 4 received, 0% packet loss, time 3094ms
+   rtt min/avg/max/mdev = 0.580/0.716/0.862/0.104 ms
diff --git a/docs/configexamples/autotest/Wireguard/_include/branch.conf b/docs/configexamples/autotest/Wireguard/_include/branch.conf
index 3faea398..e1c25904 100644
--- a/docs/configexamples/autotest/Wireguard/_include/branch.conf
+++ b/docs/configexamples/autotest/Wireguard/_include/branch.conf
@@ -1,13 +1,14 @@
 set interface ethernet eth2 address 10.0.2.254/24
 set interface ethernet eth1 address 198.51.100.2/24
 
+set interfaces wireguard wg01 private-key 'uNz9h7kM5t1Bz5NMk1WscVbtzY1URwm6qK2gnkslp08='
 set interfaces wireguard wg01 address 192.168.0.2/24
 set interfaces wireguard wg01 description 'VPN-to-central'
 set interfaces wireguard wg01 peer central allowed-ips 10.0.1.0/24
 set interfaces wireguard wg01 peer central allowed-ips 192.168.0.0/24
 set interfaces wireguard wg01 peer central address 198.51.100.1
 set interfaces wireguard wg01 peer central port 51820
-set interfaces wireguard wg01 peer central pubkey "P9y9TTRzIOVl27Ij9n/BXjZUdQFADZ5WnHV0kQr1ulQ="
+set interfaces wireguard wg01 peer central public-key 'BU+4Dyr3VldI2DJiBji50Egqr58071puYdXhoyRvuH8='
 set interfaces wireguard wg01 port 51820
 
 set protocols static route 10.0.1.0/24 interface wg01
\ No newline at end of file
diff --git a/docs/configexamples/autotest/Wireguard/_include/central.conf b/docs/configexamples/autotest/Wireguard/_include/central.conf
index 99041d89..c86af343 100644
--- a/docs/configexamples/autotest/Wireguard/_include/central.conf
+++ b/docs/configexamples/autotest/Wireguard/_include/central.conf
@@ -1,13 +1,14 @@
 set interface ethernet eth2 address 10.0.1.254/24
 set interface ethernet eth1 address 198.51.100.1/24
 
+set interfaces wireguard wg01 private-key '2BmTwXO1NpakOsa2ynnIqW3c1s3aT/gVtCUJnecefXY='
 set interfaces wireguard wg01 address 192.168.0.1/24
 set interfaces wireguard wg01 description 'VPN-to-Branch'
 set interfaces wireguard wg01 peer branch allowed-ips 10.0.2.0/24
 set interfaces wireguard wg01 peer branch allowed-ips 192.168.0.0/24
 set interfaces wireguard wg01 peer branch address 198.51.100.2
 set interfaces wireguard wg01 peer branch port 51820
-set interfaces wireguard wg01 peer branch pubkey "iUUItk5zA22azMltN+Kpp7Bh4g2mf1ea3liSEp9eQEs="
+set interfaces wireguard wg01 peer branch public-key 'wgCmJKRpV4bm9VtQWc1ScKSojTSIVIkrqhYKUPxIgSA='
 set interfaces wireguard wg01 port 51820
 
 set protocols static route 10.0.2.0/24 interface wg01
\ No newline at end of file