[JIRA] [remoting] (JENKINS-6817) FATAL: hudson.remoting.RequestAbortedException: java.io.IOException: Unexpected termination of the channel

742 views
Skip to first unread message

laurent@tourreau.fr (JIRA)

unread,
Nov 11, 2015, 7:41:04 AM11/11/15
to jenkinsc...@googlegroups.com
Laurent TOURREAU commented on Bug JENKINS-6817
 
Re: FATAL: hudson.remoting.RequestAbortedException: java.io.IOException: Unexpected termination of the channel

Sometimes I have this problem when running Jenkins 1.637 (Tomcat 8.0.28 / Windows 10)

[WARNING] Couldn't clean up oid=9 from null
hudson.remoting.ChannelClosedException: channel is already closed
	at hudson.remoting.Channel.send(Channel.java:575)
	at hudson.remoting.RemoteInvocationHandler$PhantomReferenceImpl.cleanup(RemoteInvocationHandler.java:360)
	at hudson.remoting.RemoteInvocationHandler$PhantomReferenceImpl.access$700(RemoteInvocationHandler.java:319)
	at hudson.remoting.RemoteInvocationHandler$Unexporter.run(RemoteInvocationHandler.java:420)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at hudson.remoting.AtmostOneThreadExecutor$Worker.run(AtmostOneThreadExecutor.java:110)
	at java.lang.Thread.run(Thread.java:745)
Caused by: hudson.remoting.Channel$OrderlyShutdown
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1077)
	at hudson.remoting.Channel$1.handle(Channel.java:498)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
Caused by: Command close created at
	at hudson.remoting.Command.<init>(Command.java:56)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1071)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1069)
	at hudson.remoting.Channel.close(Channel.java:1153)
	at hudson.remoting.Channel.close(Channel.java:1135)
	at hudson.maven.ProcessCache$MavenProcess.discard(ProcessCache.java:150)
	at hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:861)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:537)
	at hudson.model.Run.execute(Run.java:1741)
	at hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:531)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Finished: SUCCESS
Add Comment Add Comment
 
This message was sent by Atlassian JIRA (v6.4.2#64017-sha1:e244265)
Atlassian logo

johnstosh@gmail.com (JIRA)

unread,
Jan 8, 2016, 1:26:03 PM1/8/16
to jenkinsc...@googlegroups.com

In Jenkins ver. 1.625 this problem shows up as:

Slave went offline during the build
ERROR: Connection was broken: java.io.IOException: Connection aborted: org.jenkinsci.remoting.nio.NioChannelHub$MonoNioTransport@18bfcae9[name=Arnold]
	at org.jenkinsci.remoting.nio.NioChannelHub$NioTransport.abort(NioChannelHub.java:208)
	at org.jenkinsci.remoting.nio.NioChannelHub.run(NioChannelHub.java:628)
	at jenkins.util.ContextResettingExecutorService$1.run(ContextResettingExecutorService.java:28)
	at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
	at java.util.concurrent.FutureTask.run(Unknown Source)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
	at java.lang.Thread.run(Unknown Source)
Caused by: java.io.IOException: An existing connection was forcibly closed by the remote host
	at sun.nio.ch.SocketDispatcher.read0(Native Method)
	at sun.nio.ch.SocketDispatcher.read(Unknown Source)
	at sun.nio.ch.IOUtil.readIntoNativeBuffer(Unknown Source)
	at sun.nio.ch.IOUtil.read(Unknown Source)
	at sun.nio.ch.SocketChannelImpl.read(Unknown Source)
	at org.jenkinsci.remoting.nio.FifoBuffer$Pointer.receive(FifoBuffer.java:136)
	at org.jenkinsci.remoting.nio.FifoBuffer.receive(FifoBuffer.java:306)
	at org.jenkinsci.remoting.nio.NioChannelHub.run(NioChannelHub.java:561)
	... 6 more

gancona@libero.it (JIRA)

unread,
Jan 11, 2016, 4:22:04 AM1/11/16
to jenkinsc...@googlegroups.com

Hi John,
I had the same problem one year ago with an older version.
Try to launch the slave with a batch instead of a service and redirect the standard output to a file to check what happens.
Honestly I solved disabling the service and leaving the slave running with a scheduled batch.
Graz

krish3432@gmail.com (JIRA)

unread,
May 5, 2016, 4:54:03 PM5/5/16
to jenkinsc...@googlegroups.com

totoroliu1215@hotmail.com (JIRA)

unread,
Jun 3, 2016, 3:54:03 PM6/3/16
to jenkinsc...@googlegroups.com
Rick Liu commented on Bug JENKINS-6817

Ubuntu 14.04 server 64-bit
oracle-java7: 1.7.0_80
Jenkins: 1.651.1 LTS

In the post-build actions:
FATAL: channel is already closed


hudson.remoting.ChannelClosedException: channel is already closed

at hudson.remoting.Channel.send(Channel.java:578)
at hudson.remoting.Request.call(Request.java:130)
at hudson.remoting.Channel.call(Channel.java:780)
at hudson.Launcher$RemoteLauncher.kill(Launcher.java:953)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:540)
at hudson.model.Run.execute(Run.java:1738)
at hudson.matrix.MatrixBuild.run(MatrixBuild.java:313)


at hudson.model.ResourceController.execute(ResourceController.java:98)
at hudson.model.Executor.run(Executor.java:410)

Caused by: java.io.IOException: Unexpected termination of the channel
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:50)
Caused by: java.io.EOFException
at java.io.ObjectInputStream$PeekInputStream.readFully(ObjectInputStream.java:2325)
at java.io.ObjectInputStream$BlockDataInputStream.readShort(ObjectInputStream.java:2794)
at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:801)
at java.io.ObjectInputStream.<init>(ObjectInputStream.java:299)
at hudson.remoting.ObjectInputStreamEx.<init>(ObjectInputStreamEx.java:48)
at hudson.remoting.AbstractSynchronousByteArrayCommandTransport.read(AbstractSynchronousByteArrayCommandTransport.java:34)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:48)

totoroliu1215@hotmail.com (JIRA)

unread,
Jun 3, 2016, 3:56:03 PM6/3/16
to jenkinsc...@googlegroups.com
Rick Liu edited a comment on Bug JENKINS-6817
Ubuntu 14.04 server 64-bit
oracle-java7:  1.7.0_80
Jenkins: 1.651.1 LTS

In The build sometimes randomly failed with this kind of error.

This time happened in
 the post-build actions:

prabs003@gmail.com (JIRA)

unread,
Jul 4, 2016, 7:04:04 AM7/4/16
to jenkinsc...@googlegroups.com

I got similar issues as below

FATAL: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1467229478054 hasn't completed at 1467229718378
hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1467229478054 hasn't completed at 1467229718378
	at hudson.remoting.Request.abort(Request.java:295)
	at hudson.remoting.Channel.terminate(Channel.java:814)
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1029)
	at hudson.remoting.Channel$2.handle(Channel.java:483)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
	at ......remote call to 10.79.17.177(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1356)
	at hudson.remoting.Request.call(Request.java:171)
	at hudson.remoting.Channel.call(Channel.java:751)
	at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:173)
	at $Proxy36.join(Unknown Source)
	at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:979)
	at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:137)
	at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:97)
	at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:770)
	at hudson.model.Build$BuildExecution.build(Build.java:199)
	at hudson.model.Build$BuildExecution.doRun(Build.java:160)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:533)
	at hudson.model.Run.execute(Run.java:1745)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:89)
	at hudson.model.Executor.run(Executor.java:240)
Caused by: hudson.remoting.Channel$OrderlyShutdown: java.util.concurrent.TimeoutException: Ping started on 1467229478054 hasn't completed at 1467229718378
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1029)
	at hudson.remoting.Channel$2.handle(Channel.java:483)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
Caused by: Command close created at
	at hudson.remoting.Command.<init>(Command.java:56)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1023)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1021)
	at hudson.remoting.Channel.close(Channel.java:1104)
	at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:110)
	at hudson.remoting.PingThread.ping(PingThread.java:125)
	at hudson.remoting.PingThread.run(PingThread.java:86)
Caused by: java.util.concurrent.TimeoutException: Ping started on 1467229478054 hasn't completed at 1467229718378
	... 2 more    

My environment:
jenkins master runs on CentOS release 6.4 (Final). jenkins version is : 1.580.3
jenkins slave in which am facing issue is a solaris vm. This started recently and I could'nt think of any environment changes happened. When, this happened initially, I thought that swap space is not enough and I have increased the swap space of the slave.

This message was sent by Atlassian JIRA (v7.1.7#71011-sha1:2526d7c)
Atlassian logo

prabs003@gmail.com (JIRA)

unread,
Jul 4, 2016, 7:06:03 AM7/4/16
to jenkinsc...@googlegroups.com
prabhakar shanmugam edited a comment on Bug JENKINS-6817
I got similar issues as below

{noformat}
{noformat}


My environment:
jenkins master runs on CentOS release 6.4 (Final). jenkins version is : 1.580.3
jenkins slave in which am facing issue is a solaris vm. This started recently and I could'nt think of any environment changes happened. When, this happened initially, I thought that swap space is not enough and I have increased the swap space of the slave. Any suggestions is much appreciated. When I hit this issue, I just reboot the slave and then one or two build works fine. Have not seen this problem after three builds, but not sure, when I will hit this.

jglick@cloudbees.com (JIRA)

unread,
Dec 12, 2016, 9:49:04 AM12/12/16
to jenkinsc...@googlegroups.com

o.v.nenashev@gmail.com (JIRA)

unread,
Dec 27, 2016, 8:22:02 AM12/27/16
to jenkinsc...@googlegroups.com

Remoting logic has improved gradually in this area (especially on diagnostics fronts), but likely the issue still exists. Not sure if there is a way to fix such generic issue

1214682008@qq.com (JIRA)

unread,
Jan 22, 2017, 4:57:04 AM1/22/17
to jenkinsc...@googlegroups.com
Xia Zhang commented on Bug JENKINS-6817

also encountered the same problems:

16:23:20 FATAL: hudson.remoting.Channel$OrderlyShutdown
16:23:20 hudson.remoting.RequestAbortedException: hudson.remoting.Channel$OrderlyShutdown
16:23:20 at hudson.remoting.Request.abort(Request.java:303)
16:23:20 at hudson.remoting.Channel.terminate(Channel.java:847)
16:23:20 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1080)
16:23:20 at hudson.remoting.Channel$1.handle(Channel.java:501)
16:23:20 at hudson.remoting.AbstractByteArrayCommandTransport$1.handle(AbstractByteArrayCommandTransport.java:61)
16:23:20 at org.jenkinsci.remoting.nio.NioChannelHub$2.run(NioChannelHub.java:594)
16:23:20 at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
16:23:20 at java.util.concurrent.FutureTask.run(FutureTask.java:262)
16:23:20 at hudson.remoting.SingleLaneExecutorService$1.run(SingleLaneExecutorService.java:112)
16:23:20 at jenkins.util.ContextResettingExecutorService$1.run(ContextResettingExecutorService.java:28)
16:23:20 at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
16:23:20 at java.util.concurrent.FutureTask.run(FutureTask.java:262)
16:23:20 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
16:23:20 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
16:23:20 at java.lang.Thread.run(Thread.java:745)
16:23:20 at ......remote call to mesos-jenkins-58207071568048808fbd9396283fe305-jenkins-slave-ru(Native Method)
16:23:20 at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
16:23:20 at hudson.remoting.Request.call(Request.java:172)
16:23:20 at hudson.remoting.Channel.call(Channel.java:780)
16:23:20 at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
16:23:20 at sun.reflect.GeneratedMethodAccessor756.invoke(Unknown Source)
16:23:20 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
16:23:20 at java.lang.reflect.Method.invoke(Method.java:606)
16:23:20 at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
16:23:20 at com.sun.proxy.$Proxy88.execute(Unknown Source)
16:23:20 at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1042)
16:23:20 at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1082)
16:23:20 at hudson.scm.SCM.checkout(SCM.java:495)
16:23:20 at hudson.model.AbstractProject.checkout(AbstractProject.java:1269)
16:23:20 at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:604)
16:23:20 at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
16:23:20 at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
16:23:20 at hudson.model.Run.execute(Run.java:1741)
16:23:20 at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
16:23:20 at hudson.model.ResourceController.execute(ResourceController.java:98)
16:23:20 at hudson.model.Executor.run(Executor.java:410)
16:23:20 Caused by: hudson.remoting.Channel$OrderlyShutdown
16:23:20 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1080)
16:23:20 at hudson.remoting.Channel$1.handle(Channel.java:501)
16:23:20 at hudson.remoting.AbstractByteArrayCommandTransport$1.handle(AbstractByteArrayCommandTransport.java:61)
16:23:20 at org.jenkinsci.remoting.nio.NioChannelHub$2.run(NioChannelHub.java:594)
16:23:20 at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
16:23:20 at java.util.concurrent.FutureTask.run(FutureTask.java:262)
16:23:20 at hudson.remoting.SingleLaneExecutorService$1.run(SingleLaneExecutorService.java:112)
16:23:20 at jenkins.util.ContextResettingExecutorService$1.run(ContextResettingExecutorService.java:28)
16:23:20 at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
16:23:20 at java.util.concurrent.FutureTask.run(FutureTask.java:262)
16:23:20 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
16:23:20 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
16:23:20 at java.lang.Thread.run(Thread.java:745)
16:23:20 Caused by: Command close created at
16:23:20 at hudson.remoting.Command.<init>(Command.java:56)
16:23:20 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1074)
16:23:20 at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1072)
16:23:20 at hudson.remoting.Channel.close(Channel.java:1156)
16:23:20 at hudson.remoting.Channel.close(Channel.java:1138)
16:23:20 at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1079)
16:23:20 at hudson.remoting.Channel$1.handle(Channel.java:501)
16:23:20 at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:83)

dbeck@cloudbees.com (JIRA)

unread,
Jan 22, 2017, 5:54:09 AM1/22/17
to jenkinsc...@googlegroups.com

also encountered the same problems

When commenting on a six years old issue, you need to mention what version of Jenkins you're running. If the problem was trivial to reproduce and fix, this wouldn't still be open after six years.

That said, no need to amend your comment: Based on line numbers, this is remoting 2.60 or older, a lot has changed since then, so you're on a Jenkins version nobody cares about anymore. Time to upgrade.

Reply all
Reply to author
Forward
0 new messages