This is a multi-part message in MIME format... ------------=_1505825504-19964-327 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit [ https://ovirt-jira.atlassian.net/browse/OVIRT-1655?page=com.atlassian.jir... ] Barak Korren commented on OVIRT-1655: ------------------------------------- That failure is just a post-build Groovy script that expects some files to be accessible in the job workspace. The real issues seems to be a few lines before: {code} 12:02:09 mount: /dev/loop2 is write-protected, mounting read-only 12:02:10 WARNING No operating system detected, VM performance may suffer. Specify an OS with --os-variant for optimal results. 12:02:10 12:02:10 Starting install... 12:02:10 Retrieving file vmlinuz... | 5.6 MB 00:00 12:02:11 Retrieving file initrd.img... | 46 MB 00:00 12:02:11 Allocating 'diskGJ7pWv.img' | 5.0 GB 00:00 12:02:12 Domain installation still in progress. You can reconnect to 12:02:12 the console to complete the installation process. 12:35:12 ......................................................................................................................................................................................................FATAL: command execution failed 12:35:12 hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:12 Caused: Command close created at 12:35:12 at hudson.remoting.Command.<init>(Command.java:60) 12:35:12 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1123) 12:35:12 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1121) 12:35:12 at hudson.remoting.Channel.close(Channel.java:1281) 12:35:12 at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:180) 12:35:12 at hudson.remoting.PingThread.ping(PingThread.java:130) 12:35:12 at hudson.remoting.PingThread.run(PingThread.java:86) 12:35:12 Caused: hudson.remoting.Channel$OrderlyShutdown: hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:12 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1129) 12:35:12 at hudson.remoting.Channel$1.handle(Channel.java:527) 12:35:12 at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:83) 12:35:12 Caused: java.io.IOException: Backing channel 'vm0090.workers-phx.ovirt.org' is disconnected. 12:35:12 at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocationHandler.java:192) 12:35:12 at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:257) 12:35:12 at com.sun.proxy.$Proxy89.isAlive(Unknown Source) 12:35:12 at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1043) 12:35:12 at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1035) 12:35:12 at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:155) 12:35:12 at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:109) 12:35:12 at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66) 12:35:12 at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) 12:35:12 at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:735) 12:35:12 at hudson.model.Build$BuildExecution.build(Build.java:206) 12:35:12 at hudson.model.Build$BuildExecution.doRun(Build.java:163) 12:35:12 at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:490) 12:35:12 at hudson.model.Run.execute(Run.java:1735) 12:35:12 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) 12:35:12 at hudson.model.ResourceController.execute(ResourceController.java:97) 12:35:12 at hudson.model.Executor.run(Executor.java:405) 12:35:12 Build step 'Execute shell' marked build as failure 12:35:12 FATAL: channel is already closed 12:35:12 hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:13 Caused: Command close created at 12:35:13 at hudson.remoting.Command.<init>(Command.java:60) 12:35:13 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1123) 12:35:13 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1121) 12:35:13 at hudson.remoting.Channel.close(Channel.java:1281) 12:35:13 at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:180) 12:35:13 at hudson.remoting.PingThread.ping(PingThread.java:130) 12:35:13 at hudson.remoting.PingThread.run(PingThread.java:86) 12:35:13 Caused: hudson.remoting.Channel$OrderlyShutdown: hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:13 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1129) 12:35:13 at hudson.remoting.Channel$1.handle(Channel.java:527) 12:35:13 at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:83) 12:35:13 Caused: hudson.remoting.ChannelClosedException: channel is already closed 12:35:13 at hudson.remoting.Channel.send(Channel.java:605) 12:35:13 at hudson.remoting.Request.call(Request.java:130) 12:35:13 at hudson.remoting.Channel.call(Channel.java:829) 12:35:13 at hudson.Launcher$RemoteLauncher.launch(Launcher.java:959) 12:35:13 at hudson.Launcher$ProcStarter.start(Launcher.java:384) 12:35:13 at com.cloudbees.jenkins.plugins.sshagent.exec.ExecRemoteAgent.stop(ExecRemoteAgent.java:126) 12:35:13 at com.cloudbees.jenkins.plugins.sshagent.SSHAgentBuildWrapper$SSHAgentEnvironment.tearDown(SSHAgentBuildWrapper.java:417) 12:35:13 at hudson.model.Build$BuildExecution.doRun(Build.java:174) 12:35:13 at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:490) 12:35:13 at hudson.model.Run.execute(Run.java:1735) 12:35:13 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) 12:35:13 at hudson.model.ResourceController.execute(ResourceController.java:97) 12:35:13 at hudson.model.Executor.run(Executor.java:405) {code} Looks like Jenkins is timing out while trying to talk to the slave. But this may be caused by the error seen in the actual VM build process. -- This message was sent by Atlassian {0} (v1001.0.0-SNAPSHOT#100060) ------------=_1505825504-19964-327 Content-Type: text/html; charset="UTF-8" Content-Disposition: inline Content-Transfer-Encoding: 7bit <html><body> <pre>[ https://ovirt-jira.atlassian.net/browse/OVIRT-1655?page=com.atlassian.jir... ]</pre> <h3>Barak Korren commented on OVIRT-1655:</h3> <p>That failure is just a post-build Groovy script that expects some files to be accessible in the job workspace. The real issues seems to be a few lines before: {code} 12:02:09 mount: /dev/loop2 is write-protected, mounting read-only 12:02:10 WARNING No operating system detected, VM performance may suffer. Specify an OS with --os-variant for optimal results. 12:02:10 12:02:10 Starting install&hellip; 12:02:10 Retrieving file vmlinuz&hellip; | 5.6 MB 00:00 12:02:11 Retrieving file initrd.img&hellip; | 46 MB 00:00 12:02:11 Allocating &lsquo;diskGJ7pWv.img&rsquo; | 5.0 GB 00:00 12:02:12 Domain installation still in progress. You can reconnect to 12:02:12 the console to complete the installation process. 12:35:12 ......................................................................................................................................................................................................FATAL: command execution failed 12:35:12 hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:12 Caused: Command close created at 12:35:12 at hudson.remoting.Command.&lt;init&gt;(Command.java:60) 12:35:12 at hudson.remoting.Channel$CloseCommand.&lt;init&gt;(Channel.java:1123) 12:35:12 at hudson.remoting.Channel$CloseCommand.&lt;init&gt;(Channel.java:1121) 12:35:12 at hudson.remoting.Channel.close(Channel.java:1281) 12:35:12 at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:180) 12:35:12 at hudson.remoting.PingThread.ping(PingThread.java:130) 12:35:12 at hudson.remoting.PingThread.run(PingThread.java:86) 12:35:12 Caused: hudson.remoting.Channel$OrderlyShutdown: hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:12 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1129) 12:35:12 at hudson.remoting.Channel$1.handle(Channel.java:527) 12:35:12 at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:83) 12:35:12 Caused: java.io.IOException: Backing channel &lsquo;vm0090.workers-phx.ovirt.org&rsquo; is disconnected. 12:35:12 at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocationHandler.java:192) 12:35:12 at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:257) 12:35:12 at com.sun.proxy.$Proxy89.isAlive(Unknown Source) 12:35:12 at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1043) 12:35:12 at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1035) 12:35:12 at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:155) 12:35:12 at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:109) 12:35:12 at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66) 12:35:12 at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) 12:35:12 at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:735) 12:35:12 at hudson.model.Build$BuildExecution.build(Build.java:206) 12:35:12 at hudson.model.Build$BuildExecution.doRun(Build.java:163) 12:35:12 at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:490) 12:35:12 at hudson.model.Run.execute(Run.java:1735) 12:35:12 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) 12:35:12 at hudson.model.ResourceController.execute(ResourceController.java:97) 12:35:12 at hudson.model.Executor.run(Executor.java:405) 12:35:12 Build step &lsquo;Execute shell&rsquo; marked build as failure 12:35:12 FATAL: channel is already closed 12:35:12 hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:13 Caused: Command close created at 12:35:13 at hudson.remoting.Command.&lt;init&gt;(Command.java:60) 12:35:13 at hudson.remoting.Channel$CloseCommand.&lt;init&gt;(Channel.java:1123) 12:35:13 at hudson.remoting.Channel$CloseCommand.&lt;init&gt;(Channel.java:1121) 12:35:13 at hudson.remoting.Channel.close(Channel.java:1281) 12:35:13 at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:180) 12:35:13 at hudson.remoting.PingThread.ping(PingThread.java:130) 12:35:13 at hudson.remoting.PingThread.run(PingThread.java:86) 12:35:13 Caused: hudson.remoting.Channel$OrderlyShutdown: hudson.remoting.ProxyException: java.util.concurrent.TimeoutException: Ping started at 1505824272773 hasn't completed by 1505824512775 12:35:13 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1129) 12:35:13 at hudson.remoting.Channel$1.handle(Channel.java:527) 12:35:13 at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:83) 12:35:13 Caused: hudson.remoting.ChannelClosedException: channel is already closed 12:35:13 at hudson.remoting.Channel.send(Channel.java:605) 12:35:13 at hudson.remoting.Request.call(Request.java:130) 12:35:13 at hudson.remoting.Channel.call(Channel.java:829) 12:35:13 at hudson.Launcher$RemoteLauncher.launch(Launcher.java:959) 12:35:13 at hudson.Launcher$ProcStarter.start(Launcher.java:384) 12:35:13 at com.cloudbees.jenkins.plugins.sshagent.exec.ExecRemoteAgent.stop(ExecRemoteAgent.java:126) 12:35:13 at com.cloudbees.jenkins.plugins.sshagent.SSHAgentBuildWrapper$SSHAgentEnvironment.tearDown(SSHAgentBuildWrapper.java:417) 12:35:13 at hudson.model.Build$BuildExecution.doRun(Build.java:174) 12:35:13 at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:490) 12:35:13 at hudson.model.Run.execute(Run.java:1735) 12:35:13 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) 12:35:13 at hudson.model.ResourceController.execute(ResourceController.java:97) 12:35:13 at hudson.model.Executor.run(Executor.java:405) {code}</p> <p>Looks like Jenkins is timing out while trying to talk to the slave. But this may be caused by the error seen in the actual VM build process.</p> <blockquote><h3>Groovy script failed</h3> <pre> Key: OVIRT-1655 URL: https://ovirt-jira.atlassian.net/browse/OVIRT-1655 Project: oVirt - virtualization made easy Issue Type: By-EMAIL Reporter: sbonazzo Assignee: infra</pre> <p>Hi, I had an ovirt-node-ng build failure and didn't get logs about what happened due to: <strong>Groovy script failed:</strong> java.lang.NullPointerException: Cannot invoke method child() on null object Failed job is <a href="http://jenkins.ovirt.org/job/ovirt-node-ng_ovirt-4.1_build-art... CAn you please check what happened? &mdash; SANDRO BONAZZOLA ASSOCIATE MANAGER, SOFTWARE ENGINEERING, EMEA ENG VIRTUALIZATION R&amp;D Red Hat EMEA &lt;<a href="https://www.redhat.com/">https://www.redhat.com/</a... &lt;<a href="https://red.ht/sig">https://red.ht/sig</a>&gt; TRIED. TESTED. TRUSTED. &lt;<a href="https://redhat.com/trusted">https://redhat.com/trusted... <p>&mdash; This message was sent by Atlassian {0} (v1001.0.0-SNAPSHOT#100060)</p> <img src="https://u4043402.ct.sendgrid.net/wf/open?upn=i5TMWGV99amJbNxJpS... alt="" width="1" height="1" border="0" style="height:1px !important;width:1px !important;border-width:0 !important;margin-top:0 !important;margin-bottom:0 !important;margin-right:0 !important;margin-left:0 !important;padding-top:0 !important;padding-bottom:0 !important;padding-right:0 !important;padding-left:0 !important;"/> </body></html> ------------=_1505825504-19964-327--