Unable to start slave on macosx, solaris and netbsd after upgrading to jenkins 1.520

[crb...@gmail.com]

These slaves were using java 1.5.  So I upgraded them all to 1.6.  But slaves cannot start using the same old method (launch slave agents on Unix machines using ssh) as before the upgrade.  I tried to debug by switching to launch slave vis execution of command on Master.  ssh <slave-machine> scp <master>:/jenkins/data/plugins/maven-plugin/WEB-INF/lib/maven-agent-1.3.jar /jenkins_home/maven-agent.jar worked fine but ssh <slave-machine> cd /jenkins/home && java -jar slave.jar failed. There is no permission problem. Why did the copy fail? (My other slaves e.g. linux, linux ia64, freebsd etc that have been using java 1.6 all came up without any problems.)

...

[07/01/13 16:14:52] [SSH] Checking java version of java
[07/01/13 16:14:52] [SSH] java -version returned 1.6.0_27.
[07/01/13 16:14:52] [SSH] Starting sftp client.
[07/01/13 16:14:52] [SSH] Copying latest slave.jar...
[07/01/13 16:14:52] [SSH] Copied 326,006 bytes.
Expanded the channel window size to 4MB
[07/01/13 16:14:52] [SSH] Starting slave process: cd '/jenkins_home' && java  -jar slave.jar
<===[JENKINS REMOTING CAPACITY]===>channel started
Slave.jar version: 2.24
This is a Unix slave
hudson.util.IOException2: Failed to copy /jenkins/data/plugins/maven-plugin/WEB-INF/lib/maven-agent-1.3.jar to /jenkins_home/maven-agent.jar
	at hudson.FilePath.copyTo(FilePath.java:1731)
	at hudson.maven.MavenComputerListener.copyJar(MavenComputerListener.java:90)
	at hudson.maven.MavenComputerListener.preOnline(MavenComputerListener.java:57)
	at hudson.slaves.SlaveComputer.setChannel(SlaveComputer.java:473)
	at hudson.slaves.SlaveComputer.setChannel(SlaveComputer.java:347)
	at hudson.plugins.sshslaves.SSHLauncher.startSlave(SSHLauncher.java:712)
	at hudson.plugins.sshslaves.SSHLauncher.launch(SSHLauncher.java:498)
	at hudson.slaves.SlaveComputer$1.call(SlaveComputer.java:230)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
	at java.util.concurrent.FutureTask.run(FutureTask.java:138)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
Caused by: java.io.IOException: Remote call on b-solarisx86-02 failed
	at hudson.remoting.Channel.call(Channel.java:731)
	at hudson.FilePath.write(FilePath.java:1625)
	at hudson.FilePath.copyTo(FilePath.java:1724)
	... 12 more
Caused by: java.lang.NoClassDefFoundError: org/apache/commons/io/input/ProxyInputStream
	at java.lang.ClassLoader.defineClass1(Native Method)
	at java.lang.ClassLoader.defineClassCond(ClassLoader.java:631)
	at java.lang.ClassLoader.defineClass(ClassLoader.java:615)
	at java.lang.ClassLoader.defineClass(ClassLoader.java:465)
	at hudson.remoting.RemoteClassLoader.loadClassFile(RemoteClassLoader.java:289)
	at hudson.remoting.RemoteClassLoader.findClass(RemoteClassLoader.java:229)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	at java.lang.Class.getDeclaredFields0(Native Method)
	at java.lang.Class.privateGetDeclaredFields(Class.java:2291)
	at java.lang.Class.getDeclaredField(Class.java:1880)
	at java.io.ObjectStreamClass.getDeclaredSUID(ObjectStreamClass.java:1610)
	at java.io.ObjectStreamClass.access$700(ObjectStreamClass.java:52)
	at java.io.ObjectStreamClass$2.run(ObjectStreamClass.java:425)
	at java.security.AccessController.doPrivileged(Native Method)
	at java.io.ObjectStreamClass.<init>(ObjectStreamClass.java:413)
	at java.io.ObjectStreamClass.lookup(ObjectStreamClass.java:310)
	at java.io.ObjectStreamClass.initNonProxy(ObjectStreamClass.java:547)
	at java.io.ObjectInputStream.readNonProxyDesc(ObjectInputStream.java:1582)
	at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1495)
	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1731)
	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1328)
	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:1946)
	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:1870)
	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1752)
	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1328)
	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:350)
	at hudson.remoting.UserRequest.deserialize(UserRequest.java:182)
	at hudson.remoting.UserRequest.perform(UserRequest.java:98)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
	... 5 more
Caused by: java.lang.ClassNotFoundException: org.apache.commons.io.input.ProxyInputStream
	at hudson.remoting.RemoteClassLoader.findClass(RemoteClassLoader.java:237)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
	at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
	... 37 more
Caused by: java.util.concurrent.ExecutionException: java.util.zip.ZipException: error in opening zip file
	at hudson.remoting.ResourceImageInJar$1.adapt(ResourceImageInJar.java:48)
	at hudson.remoting.ResourceImageInJar$1.adapt(ResourceImageInJar.java:42)
	at hudson.remoting.FutureAdapter.get(FutureAdapter.java:55)
	at hudson.remoting.RemoteClassLoader.findClass(RemoteClassLoader.java:229)
	... 39 more
Caused by: java.util.zip.ZipException: error in opening zip file
	at java.util.zip.ZipFile.open(Native Method)
	at java.util.zip.ZipFile.<init>(ZipFile.java:127)
	at java.util.jar.JarFile.<init>(JarFile.java:135)
	at java.util.jar.JarFile.<init>(JarFile.java:72)
	at sun.net.www.protocol.jar.URLJarFile.<init>(URLJarFile.java:72)
	at sun.net.www.protocol.jar.URLJarFile.getJarFile(URLJarFile.java:48)
	at sun.net.www.protocol.jar.JarFileFactory.get(JarFileFactory.java:55)
	at sun.net.www.protocol.jar.JarURLConnection.connect(JarURLConnection.java:104)
	at sun.net.www.protocol.jar.JarURLConnection.getInputStream(JarURLConnection.java:132)
	at java.net.URL.openStream(URL.java:1010)
	at hudson.remoting.ResourceImageInJar$1.adapt(ResourceImageInJar.java:46)
	... 42 more
[07/01/13 16:14:54] [SSH] Connection closed.
ERROR: Connection terminated
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$BlockDataInputStream.peekByte(ObjectInputStream.java:2553)
	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1296)
	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:350)
	at hudson.remoting.Command.readFrom(Command.java:92)
	at hudson.remoting.ClassicCommandTransport.read(ClassicCommandTransport.java:59)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:48)
ERROR: [07/01/13 16:14:54] slave agent was terminated
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$BlockDataInputStream.peekByte(ObjectInputStream.java:2553)
	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1296)
	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:350)
	at hudson.remoting.Command.readFrom(Command.java:92)
	at hudson.remoting.ClassicCommandTransport.read(ClassicCommandTransport.java:59)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:48)

[crb...@gmail.com]

I tried a few times more and now it gives me "remote call ... failed".  And I can run java -jar slave.jar locally on the slave although it gives the expected complaint that I should not be starting the slave from the console.

[07/01/13 16:52:10] [SSH] Checking java version of java
[07/01/13 16:52:10] [SSH] java -version returned 1.6.0_27.
[07/01/13 16:52:10] [SSH] Starting sftp client.
[07/01/13 16:52:10] [SSH] Copying latest slave.jar...
[07/01/13 16:52:10] [SSH] Copied 326,006 bytes.
Expanded the channel window size to 4MB
[07/01/13 16:52:10] [SSH] Starting slave process: cd '/jenkins_home' && java  -jar slave.jar
<===[JENKINS REMOTING CAPACITY]===>channel started
java.io.IOException: Remote call on b-solarisx86-02 failed
	at hudson.remoting.Channel.call(Channel.java:731)
	at hudson.slaves.SlaveComputer.setChannel(SlaveComputer.java:451)
	at hudson.slaves.SlaveComputer.setChannel(SlaveComputer.java:347)
	at hudson.plugins.sshslaves.SSHLauncher.startSlave(SSHLauncher.java:712)
	at hudson.plugins.sshslaves.SSHLauncher.launch(SSHLauncher.java:498)
	at hudson.slaves.SlaveComputer$1.call(SlaveComputer.java:230)
	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
	at java.util.concurrent.FutureTask.run(FutureTask.java:138)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
...

builder@b-solarisx86-02:/jenkins_home$ java -jar slave.jar 

WARNING: Are you running slave agent from an interactive console?

If so, you are probably using it incorrectly.

See http://wiki.jenkins-ci.org/display/JENKINS/Launching+slave.jar+from+from+console

<===[JENKINS REMOTING CAPACITY]===>rO0ABXNyABpodWRzb24ucmVtb3RpbmcuQ2FwYWJpbGl0eQAAAAAAAAABAgABSgAEbWFza3hwAAAAAAAAAB4=??

[crbeng]

None unfortunately. Manual emulation of ssh commands i.e. ssh $slave then cd
$JENKINSHOME && java -jar slave.jar succeeded. Yet the slave connection
still fails with remote call on <slave> failed ... error in opening zip
file.



--
View this message in context: http://jenkins-ci.361315.n4.nabble.com/Unable-to-start-slave-on-macosx-solaris-and-netbsd-after-upgrading-to-jenkins-1-520-tp4671324p4673045.html
Sent from the Jenkins users mailing list archive at Nabble.com.