Error during start of Xvfb in jenkins

[Niels Berghen]

Dear,

At the start of our jenkins build, we sometimes receive the following error. This exception only occurs once every few builds, so it seems to appear randomly.

We currently run 

jenkins v1.570

xvfb jenkins plugin v1.0.16

xvfb v2:1.16.4-1

Kind regards,

Niels Berghen

Xvfb starting$ /usr/bin//Xvfb -displayfd 2 -screen 0 1920x3000x24 -fbdir /home/tomcat/jenkins/xvfb-2015-10-04_05-01-49-8696398926521309350.fbdir -noreset

0
ERROR: Processing failed due to a bug in the code. Please report this to jenkins...@googlegroups.com
hudson.remoting.RequestAbortedException: hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	at hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:41)
	at hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:34)
	at hudson.remoting.Request.call(Request.java:174)
	at hudson.remoting.Channel.call(Channel.java:739)
	at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:168)
	at com.sun.proxy.$Proxy69.isAlive(Unknown Source)
	at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:961)
	at org.jenkinsci.plugins.xvfb.XvfbBuildWrapper.launchXvfb(XvfbBuildWrapper.java:561)
	at org.jenkinsci.plugins.xvfb.XvfbBuildWrapper.setUp(XvfbBuildWrapper.java:622)
	at hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:653)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:535)
	at hudson.model.Run.execute(Run.java:1732)
	at hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:529)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:234)
Caused by: hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	at hudson.remoting.Request.abort(Request.java:299)
	at hudson.remoting.Channel.terminate(Channel.java:802)
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:951)
	at hudson.remoting.Channel$2.handle(Channel.java:475)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
Caused by: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	... 3 more
Caused by: Command close created at
	at hudson.remoting.Command.<init>(Command.java:56)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:945)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:943)
	at hudson.remoting.Channel.close(Channel.java:1026)
	at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:110)
	at hudson.remoting.PingThread.ping(PingThread.java:120)
	at hudson.remoting.PingThread.run(PingThread.java:81)
Caused by: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	... 2 more
project=hudson.maven.MavenModuleSet@748061a4[VABFS-Platform-EndToEndTests]
project.getModules()=[hudson.maven.MavenModule@6044aef6[VABFS-Platform-EndToEndTests/be.vabfs:e2e-tests][VABFS-Platform-EndToEndTests/be.vabfs:e2e-tests][relativePath:vabfs-parent/e2e-tests]]
project.getRootModule()=hudson.maven.MavenModule@6044aef6[VABFS-Platform-EndToEndTests/be.vabfs:e2e-tests][VABFS-Platform-EndToEndTests/be.vabfs:e2e-tests][relativePath:vabfs-parent/e2e-tests]
FATAL: hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
hudson.remoting.RequestAbortedException: hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	at hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:41)
	at hudson.remoting.RequestAbortedException.wrapForRethrow(RequestAbortedException.java:34)
	at hudson.remoting.Request.call(Request.java:174)
	at hudson.remoting.Channel.call(Channel.java:739)
	at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:168)
	at com.sun.proxy.$Proxy69.isAlive(Unknown Source)
	at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:961)
	at org.jenkinsci.plugins.xvfb.XvfbBuildWrapper.launchXvfb(XvfbBuildWrapper.java:561)
	at org.jenkinsci.plugins.xvfb.XvfbBuildWrapper.setUp(XvfbBuildWrapper.java:622)
	at hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:653)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:535)
	at hudson.model.Run.execute(Run.java:1732)
	at hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:529)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:234)
Caused by: hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	at hudson.remoting.Request.abort(Request.java:299)
	at hudson.remoting.Channel.terminate(Channel.java:802)
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:951)
	at hudson.remoting.Channel$2.handle(Channel.java:475)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
Caused by: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	... 3 more
Caused by: Command close created at
	at hudson.remoting.Command.<init>(Command.java:56)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:945)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:943)
	at hudson.remoting.Channel.close(Channel.java:1026)
	at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:110)
	at hudson.remoting.PingThread.ping(PingThread.java:120)
	at hudson.remoting.PingThread.run(PingThread.java:81)
Caused by: java.util.concurrent.TimeoutException: Ping started on 1443927763105 hasn't completed at 1443928003105
	... 2 more

--

Let's Develop Your Future Together: www.aca-it.be/jobs

niels....@aca-it.be Solution Engineer

ACA IT-Solutions NV  Ilgatlaan 5C | B-3500 Hasselt  Nijverheidsstraat 48 D | B-2260 Westerlo (Oevel)  T +32(0)11 26 50 10 | F +32(0)11 26 50 11  www.aca-it.be | Twitter | Facebook | Linkedin

[Victor Martinez]

Hi,

 Ping started on 1443927763105 hasn't completed at 1443928003105

It looks like some networking issue, doesn't it? Is your NTP server synchronized with those jenkins slaves? I'm not an expert on that matters, but it might be the root cause.

I hope it helps

Cheers