<div dir="ltr"><div class="gmail_extra"><div class="gmail_quote">On Wed, Jul 5, 2017 at 9:46 AM, Nadav Goldin <span dir="ltr">&lt;<a href="mailto:ngoldin@redhat.com" target="_blank">ngoldin@redhat.com</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">Hi,<br>
Did it happen more than once?<br></blockquote><div><br></div><div>No </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
<br>
Looking at the logs what happened was:<br>
1. Lago checked the engine was SSH reachable - this was true.<br>
2. Then it tried connecting via SSH and collect the logs and timed out.<br>
<br>
On (1) we have retries and guards, on (2) we don&#39;t, as we assume (1)<br>
just passed. I guess in some conditions that logic can be flawed. Can<br>
you open an issue[1]?<br></blockquote><div><br></div><div>Will do </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
<br>
I&#39;ll try to fix it as soon as possible.<br>
<br>
Thanks,<br>
<br>
<br>
[1] <a href="https://github.com/lago-project/lago/issues" rel="noreferrer" target="_blank">https://github.com/lago-<wbr>project/lago/issues</a><br>
<span class="HOEnZb"><font color="#888888">Nadav.<br>
</font></span><div class="HOEnZb"><div class="h5"><br>
On Wed, Jul 5, 2017 at 9:07 AM, Gil Shinar &lt;<a href="mailto:gshinar@redhat.com">gshinar@redhat.com</a>&gt; wrote:<br>
&gt; Hi Nadav/Gal,<br>
&gt;<br>
&gt; I see the folowing exceptions in lago log:<br>
&gt;<br>
&gt; 2017-07-04 14:24:39,254::log_utils.py::__<wbr>exit__::606::lago.prefix::<wbr>DEBUG::<br>
&gt; File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1476, in<br>
&gt; _collect_artifacts<br>
&gt;     vm.collect_artifacts(path, ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 624, in<br>
&gt; collect_artifacts<br>
&gt;     ignore_nopath=ignore_nopath<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 381, in<br>
&gt; extract_paths<br>
&gt;     return self.provider.extract_paths(<wbr>paths, *args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/providers/<wbr>libvirt/vm.py&quot;, line<br>
&gt; 297, in extract_paths<br>
&gt;     ignore_nopath=ignore_nopath,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 247, in<br>
&gt; extract_paths<br>
&gt;     self._extract_paths_scp(paths=<wbr>paths, ignore_nopath=ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 266, in<br>
&gt; _extract_paths_scp<br>
&gt;     propagate_fail=False<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 425, in<br>
&gt; copy_from<br>
&gt;     local_path=local_path,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 125, in get<br>
&gt;     self._recv_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 250, in _recv_all<br>
&gt;     msg = self.channel.recv(1024)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/paramiko/channel.py&quot;, line 615, in<br>
&gt; recv<br>
&gt;     raise socket.timeout()<br>
&gt;<br>
&gt; 2017-07-04<br>
&gt; 14:24:39,254::utils.py::_ret_<wbr>via_queue::60::lago.utils::<wbr>ERROR::Error while<br>
&gt; running thread<br>
&gt; Traceback (most recent call last):<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 58, in<br>
&gt; _ret_via_queue<br>
&gt;     queue.put({&#39;return&#39;: func()})<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1476, in<br>
&gt; _collect_artifacts<br>
&gt;     vm.collect_artifacts(path, ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 624, in<br>
&gt; collect_artifacts<br>
&gt;     ignore_nopath=ignore_nopath<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 381, in<br>
&gt; extract_paths<br>
&gt;     return self.provider.extract_paths(<wbr>paths, *args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/providers/<wbr>libvirt/vm.py&quot;, line<br>
&gt; 297, in extract_paths<br>
&gt;     ignore_nopath=ignore_nopath,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 247, in<br>
&gt; extract_paths<br>
&gt;     self._extract_paths_scp(paths=<wbr>paths, ignore_nopath=ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 266, in<br>
&gt; _extract_paths_scp<br>
&gt;     propagate_fail=False<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 425, in<br>
&gt; copy_from<br>
&gt;     local_path=local_path,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 125, in get<br>
&gt;     self._recv_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 250, in _recv_all<br>
&gt;     msg = self.channel.recv(1024)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/paramiko/channel.py&quot;, line 615, in<br>
&gt; recv<br>
&gt;     raise socket.timeout()<br>
&gt; timeout<br>
&gt; 2017-07-04 14:24:39,255::log_utils.py::<wbr>end_log_task::669::root::<wbr>ERROR::@<br>
&gt; Collect artifacts:  [31mERROR [0m (in 0:00:05)<br>
&gt; 2017-07-04 14:24:39,256::log_utils.py::__<wbr>exit__::606::lago.prefix::<wbr>DEBUG::<br>
&gt; File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/log_utils.py&quot;, line 635, in<br>
&gt; wrapper<br>
&gt;     return func(*args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1480, in<br>
&gt; collect_artifacts<br>
&gt;     self.virt_env.get_vms().<wbr>values(),<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 100, in<br>
&gt; invoke_in_parallel<br>
&gt;     return vt.join_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 58, in<br>
&gt; _ret_via_queue<br>
&gt;     queue.put({&#39;return&#39;: func()})<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1476, in<br>
&gt; _collect_artifacts<br>
&gt;     vm.collect_artifacts(path, ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 624, in<br>
&gt; collect_artifacts<br>
&gt;     ignore_nopath=ignore_nopath<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 381, in<br>
&gt; extract_paths<br>
&gt;     return self.provider.extract_paths(<wbr>paths, *args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/providers/<wbr>libvirt/vm.py&quot;, line<br>
&gt; 297, in extract_paths<br>
&gt;     ignore_nopath=ignore_nopath,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 247, in<br>
&gt; extract_paths<br>
&gt;     self._extract_paths_scp(paths=<wbr>paths, ignore_nopath=ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 266, in<br>
&gt; _extract_paths_scp<br>
&gt;     propagate_fail=False<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 425, in<br>
&gt; copy_from<br>
&gt;     local_path=local_path,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 125, in get<br>
&gt;     self._recv_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 250, in _recv_all<br>
&gt;     msg = self.channel.recv(1024)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/paramiko/channel.py&quot;, line 615, in<br>
&gt; recv<br>
&gt;     raise socket.timeout()<br>
&gt;<br>
&gt; 2017-07-04 14:24:39,256::cmd.py::main::<wbr>960::cli::ERROR::Error occured,<br>
&gt; aborting<br>
&gt; Traceback (most recent call last):<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/cmd.py&quot;, line 954, in main<br>
&gt;     cli_plugins[args.verb].do_run(<wbr>args)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/cli.py&quot;, line 184, in<br>
&gt; do_run<br>
&gt;     self._do_run(**vars(args))<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 501, in<br>
&gt; wrapper<br>
&gt;     return func(*args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 512, in<br>
&gt; wrapper<br>
&gt;     return func(*args, prefix=prefix, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/cmd.py&quot;, line 751, in<br>
&gt; do_collect<br>
&gt;     prefix.collect_artifacts(<wbr>output, ignore_nopath=not no_skip)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/sdk_utils.py&quot;, line 50, in<br>
&gt; wrapped<br>
&gt;     return func(*args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/log_utils.py&quot;, line 635, in<br>
&gt; wrapper<br>
&gt;     return func(*args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1480, in<br>
&gt; collect_artifacts<br>
&gt;     self.virt_env.get_vms().<wbr>values(),<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 100, in<br>
&gt; invoke_in_parallel<br>
&gt;     return vt.join_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/utils.py&quot;, line 58, in<br>
&gt; _ret_via_queue<br>
&gt;     queue.put({&#39;return&#39;: func()})<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/prefix.py&quot;, line 1476, in<br>
&gt; _collect_artifacts<br>
&gt;     vm.collect_artifacts(path, ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 624, in<br>
&gt; collect_artifacts<br>
&gt;     ignore_nopath=ignore_nopath<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 381, in<br>
&gt; extract_paths<br>
&gt;     return self.provider.extract_paths(<wbr>paths, *args, **kwargs)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/providers/<wbr>libvirt/vm.py&quot;, line<br>
&gt; 297, in extract_paths<br>
&gt;     ignore_nopath=ignore_nopath,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 247, in<br>
&gt; extract_paths<br>
&gt;     self._extract_paths_scp(paths=<wbr>paths, ignore_nopath=ignore_nopath)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 266, in<br>
&gt; _extract_paths_scp<br>
&gt;     propagate_fail=False<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/lago/plugins/vm.py&quot;, line 425, in<br>
&gt; copy_from<br>
&gt;     local_path=local_path,<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 125, in get<br>
&gt;     self._recv_all()<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/scp.py&quot;, line 250, in _recv_all<br>
&gt;     msg = self.channel.recv(1024)<br>
&gt;   File &quot;/usr/lib/python2.7/site-<wbr>packages/paramiko/channel.py&quot;, line 615, in<br>
&gt; recv<br>
&gt;     raise socket.timeout()<br>
&gt; timeout<br>
&gt;<br>
&gt;<br>
&gt; Link to build:<br>
&gt; <a href="http://jenkins.ovirt.org/job/test-repo_ovirt_experimental_master/7459" rel="noreferrer" target="_blank">http://jenkins.ovirt.org/job/<wbr>test-repo_ovirt_experimental_<wbr>master/7459</a><br>
&gt;<br>
&gt; Thanks<br>
&gt; Gil<br>
</div></div></blockquote></div><br></div></div>