Stop testing Java 11 #390
Closed
Stop testing Java 11 #390
ci.jenkins.io / Tests / linux-17 / Build (linux-17)
failed
Jan 10, 2025
failed: 3, skipped: 3, passed: 167
Send us feedback
Details
jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest.terminateNodeWithShutoffServer
expected:<1> but was:<2>
Stack trace
java.lang.AssertionError: expected:<1> but was:<2>
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:633)
at jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest.terminateNodeWithShutoffServer(JCloudsCleanupThreadTest.java:205)
at java.base/java.lang.reflect.Method.invoke(Method.java:569)
at jenkins.plugins.openstack.PluginTestRule$3.evaluate(PluginTestRule.java:579)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:607)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.lang.Thread.run(Thread.java:840)
Standard error
0.007 [id=278] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:44137/jenkins/
0.067 [id=291] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.068 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.069 [id=293] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h5468955520175524015/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.161 [id=292] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.163 [id=296] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.163 [id=297] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.760 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.769 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.769 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.770 [id=291] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.772 [id=294] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.773 [id=302] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
1.774 [id=77] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-5 with options jenkins.plugins.openstack.compute.SlaveOptions@49278437[bootSource=<null>,hardwareId=<null>,networkId=<null>,userDataId=<null>,instanceCap=10,instancesMin=0,floatingIpPool=<null>,securityGroups=default,availabilityZone=<null>,startTimeout=600000,keyPairName=<null>,numExecutors=1,jvmOptions=<null>,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=30,configDrive=false]
1.774 [id=77] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
1.775 [id=77] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1699965447
1.775 [id=77] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-5
Autolaunching agent for slave: template0-5
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main createEngine
template0-5 err: INFO: Setting up agent: template0-5
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.Engine startEngine
template0-5 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.Engine startEngine
template0-5 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Locating server among [http://localhost:44137/jenkins/]
template0-5 err: Jan 10, 2025 10:05:53 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-5 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
2.371 [id=320] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #10 from /127.0.0.1:50516 failed: null
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Agent discovery successful
template0-5 err: Agent address: localhost
template0-5 err: Agent port: 33561
template0-5 err: Identity: d4:db:c7:a3:b4:f7:15:c9:b8:a0:bb:8a:af:26:3d:8b
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Handshaking
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Connecting to localhost:33561
template0-5 err: Jan 10, 2025 10:05:53 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Trying protocol: JNLP4-connect
template0-5 err: Jan 10, 2025 10:05:53 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-5 err: INFO: Waiting for ProtocolStack to start.
2.409 [id=321] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #11 from /127.0.0.1:50520
template0-5 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Remote identity confirmed: d4:db:c7:a3:b4:f7:15:c9:b8:a0:bb:8a:af:26:3d:8b
template0-5 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Connected
2.772 [id=304] INFO hudson.slaves.NodeProvisioner#update: template0 provisioning successfully completed. We have now 2 computer(s)
2.773 [id=304] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
2.774 [id=79] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-6 with options jenkins.plugins.openstack.compute.SlaveOptions@37df6271[bootSource=<null>,hardwareId=<null>,networkId=<null>,userDataId=<null>,instanceCap=10,instancesMin=0,floatingIpPool=<null>,securityGroups=default,availabilityZone=<null>,startTimeout=600000,keyPairName=<null>,numExecutors=1,jvmOptions=<null>,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=30,configDrive=false]
2.774 [id=79] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
2.775 [id=79] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1998192024
2.775 [id=79] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-6
Autolaunching agent for slave: template0-6
template0-6 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main createEngine
template0-6 err: INFO: Setting up agent: template0-6
template0-6 err: Jan 10, 2025 10:05:54 AM hudson.remoting.Engine startEngine
template0-6 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-6 err: Jan 10, 2025 10:05:54 AM hudson.remoting.Engine startEngine
template0-6 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
3.069 [id=278] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: Executing terminateNodeWithShutoffServer(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest) for template0-5 terminated: java.nio.channels.ClosedChannelException
3.070 [id=278] WARNING o.j.h.t.RemainingActivityListener#onTearDown: test0 #1 still seems to be running, which could break deletion of log files or metadata
3.071 [id=278] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
template0-5 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Terminated
3.074 [id=313] INFO hudson.model.Run#execute: test0 #1 aborted
java.lang.InterruptedException
at java.base/java.lang.Object.wait(Native Method)
at java.base/java.lang.Object.wait(Object.java:338)
at hudson.util.OneShotEvent.block(OneShotEvent.java:73)
at jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest$BuildBlocker.perform(JCloudsCleanupThreadTest.java:248)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:526)
at hudson.model.Run.execute(Run.java:1900)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:442)
3.102 [id=278] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
template0-6 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main$CuiListener status
template0-6 err: INFO: Locating server among [http://localhost:44137/jenkins/]
template0-6 err: Jan 10, 2025 10:05:54 AM hudson.remoting.jnlp.Main$CuiListener error
template0-6 err: SEVERE: Connection refused
template0-6 err: java.net.ConnectException: Connection refused
template0-6 err: at java.base/sun.nio.ch.Net.connect0(Native Method)
template0-6 err: at java.base/sun.nio.ch.Net.connect(Net.java:579)
template0-6 err: at java.base/sun.nio.ch.Net.connect(Net.java:568)
template0-6 err: at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:593)
template0-6 err: at java.base/java.net.Socket.connect(Socket.java:633)
template0-6 err: at java.base/java.net.Socket.connect(Socket.java:583)
template0-6 err: at java.base/sun.net.NetworkClient.doConnect(NetworkClient.java:183)
template0-6 err: at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:533)
template0-6 err: at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:638)
template0-6 err: at java.base/sun.net.www.http.HttpClient.parseHTTPHeader(HttpClient.java:947)
template0-6 err: at java.base/sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:761)
template0-6 err: at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1724)
template0-6 err: at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1625)
template0-6 err: at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:529)
template0-6 err: at org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver.resolve(JnlpAgentEndpointResolver.java:219)
template0-6 err: at hudson.remoting.Engine.innerRun(Engine.java:760)
template0-6 err: at hudson.remoting.Engine.run(Engine.java:543)
template0-6 err:
3.154 [id=278] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h5468955520175524015
3.161 [id=313] WARNING jenkins.util.Listeners#lambda$notify$0
java.lang.IllegalStateException: Jenkins.instance is missing. Read the documentation of Jenkins.getInstanceOrNull to see what you are doing wrong.
at jenkins.model.Jenkins.get(Jenkins.java:816)
at jenkins.triggers.ReverseBuildTrigger$RunListenerImpl.calculateCache(ReverseBuildTrigger.java:251)
at jenkins.triggers.ReverseBuildTrigger$RunListenerImpl.onCompleted(ReverseBuildTrigger.java:277)
at hudson.model.listeners.RunListener.lambda$fireCompleted$0(RunListener.java:207)
at jenkins.util.Listeners.lambda$notify$0(Listeners.java:59)
at jenkins.util.Listeners.notify(Listeners.java:67)
at hudson.model.listeners.RunListener.fireCompleted(RunListener.java:205)
at hudson.model.Run.execute(Run.java:1945)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:442)
3.164 [id=313] WARNING jenkins.util.Listeners#lambda$notify$0
java.lang.IllegalStateException: Expected 1 instance of jenkins.model.TransientActionFactory$Cache but got 0
at hudson.ExtensionList.lookupSingleton(ExtensionList.java:454)
at jenkins.model.TransientActionFactory.factoriesFor(TransientActionFactory.java:127)
at hudson.model.Actionable.getActions(Actionable.java:139)
at org.jenkinsci.plugins.configfiles.common.CleanTempFilesRunListener.onCompleted(CleanTempFilesRunListener.java:51)
at org.jenkinsci.plugins.configfiles.common.CleanTempFilesRunListener.onCompleted(CleanTempFilesRunListener.java:43)
at hudson.model.listeners.RunListener.lambda$fireCompleted$0(RunListener.java:207)
at jenkins.util.Listeners.lambda$notify$0(Listeners.java:59)
at jenkins.util.Listeners.notify(Listeners.java:67)
at hudson.model.listeners.RunListener.fireCompleted(RunListener.java:205)
at hudson.model.Run.execute(Run.java:1945)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:442)
Standard out
=== Starting terminateNodeWithShutoffServer(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest)
$ /opt/jdk-17/bin/java -jar -DstartedBy=terminateNodeWithShutoffServer(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:44137/jenkins/computer/template0-5/slave-agent.jnlp
$ /opt/jdk-17/bin/java -jar -DstartedBy=terminateNodeWithShutoffServer(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:44137/jenkins/computer/template0-6/slave-agent.jnlp
jenkins.plugins.openstack.compute.ProvisioningTest.timeoutLaunchingJnlp
Node failed to time out: jenkins.plugins.openstack.compute.JCloudsSlave[template0-2]
Stack trace
java.lang.AssertionError: Node failed to time out: jenkins.plugins.openstack.compute.JCloudsSlave[template0-2]
at org.junit.Assert.fail(Assert.java:89)
at jenkins.plugins.openstack.compute.ProvisioningTest.timeoutLaunchingJnlp(ProvisioningTest.java:341)
at java.base/java.lang.reflect.Method.invoke(Method.java:569)
at jenkins.plugins.openstack.PluginTestRule$3.evaluate(PluginTestRule.java:579)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:607)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.lang.Thread.run(Thread.java:840)
Standard error
0.010 [id=150] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:37451/jenkins/
0.088 [id=163] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.089 [id=169] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.090 [id=166] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h18184848679408778722/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.185 [id=166] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.187 [id=163] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.188 [id=167] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
1.621 [id=164] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
1.634 [id=168] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
1.634 [id=163] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
1.635 [id=169] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
1.637 [id=169] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.658 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-2 with options jenkins.plugins.openstack.compute.SlaveOptions@2e3d5225[bootSource=Image dummyImageId,hardwareId=dummyHardwareId,networkId=dummyNetworkId,userDataId=dummyUserDataId,instanceCap=10,instancesMin=0,floatingIpPool=dummyPoolName,securityGroups=default,availabilityZone=dummyAvailabilityZone,startTimeout=7000,keyPairName=dummyKeyPairName,numExecutors=1,jvmOptions=dummyJvmOptions,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=30,configDrive=false]
1.659 [id=74] INFO j.p.o.c.slaveopts.BootSource#selectIdFromListAndLogProblems: NO Images match name 'dummyImageId'.
1.669 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 795295200
1.669 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Amended server: Mock for Object, hashCode: 795295200
1.670 [id=74] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-2
1.671 [id=65] WARNING o.j.p.cloudstats.CloudStatistics#getActivityFor: No activity tracked for ProvisioningActivity for openstack/template0/null (1893716815)
java.lang.IllegalStateException
at org.jenkinsci.plugins.cloudstats.CloudStatistics.getActivityFor(CloudStatistics.java:255)
at org.jenkinsci.plugins.cloudstats.CloudStatistics$OperationListener.preLaunch(CloudStatistics.java:588)
at hudson.slaves.SlaveComputer.lambda$_connect$0(SlaveComputer.java:295)
at jenkins.util.ContextResettingExecutorService$2.call(ContextResettingExecutorService.java:46)
at jenkins.security.ImpersonatingExecutorService$2.call(ImpersonatingExecutorService.java:80)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:840)
1.671 [id=65] WARNING o.j.p.cloudstats.CloudStatistics#getActivityFor: No activity tracked for ProvisioningActivity for openstack/template0/null (1893716815)
java.lang.IllegalStateException
at org.jenkinsci.plugins.cloudstats.CloudStatistics.getActivityFor(CloudStatistics.java:255)
at org.jenkinsci.plugins.cloudstats.CloudStatistics$OperationListener.onLaunchFailure(CloudStatistics.java:606)
at hudson.slaves.SlaveComputer.lambda$_connect$0(SlaveComputer.java:320)
at jenkins.util.ContextResettingExecutorService$2.call(ContextResettingExecutorService.java:46)
at jenkins.security.ImpersonatingExecutorService$2.call(ImpersonatingExecutorService.java:80)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
at java.base/java.lang.Thread.run(Thread.java:840)
1.676 [id=150] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
1.682 [id=150] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
1.726 [id=150] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h18184848679408778722
Standard out
=== Starting timeoutLaunchingJnlp(jenkins.plugins.openstack.compute.ProvisioningTest)
jenkins.plugins.openstack.compute.SingleUseSlaveTest.preserveAgentOfflineByUser
Expected: an iterable with size <1>
but: iterable size was <2>
Stack trace
java.lang.AssertionError:
Expected: an iterable with size <1>
but: iterable size was <2>
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:6)
at jenkins.plugins.openstack.compute.SingleUseSlaveTest.preserveAgentOfflineByUser(SingleUseSlaveTest.java:154)
at java.base/java.lang.reflect.Method.invoke(Method.java:569)
at jenkins.plugins.openstack.PluginTestRule$3.evaluate(PluginTestRule.java:579)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:607)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.lang.Thread.run(Thread.java:840)
Standard error
0.008 [id=339] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:33433/jenkins/
0.069 [id=352] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.070 [id=356] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.071 [id=354] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h11261826315226223481/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.167 [id=356] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.169 [id=354] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.170 [id=351] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
1.469 [id=358] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
1.484 [id=358] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
1.484 [id=356] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
1.485 [id=356] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
1.491 [id=357] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.511 [id=339] WARNING o.j.r.u.AnonymousClassWarnings#warn: Attempt to (de-)serialize anonymous class jenkins.plugins.openstack.compute.SingleUseSlaveTest$1 in file:/home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/test-classes/; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/
2.492 [id=364] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
2.492 [id=65] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-8 with options jenkins.plugins.openstack.compute.SlaveOptions@32db30ac[bootSource=Image dummyImageId,hardwareId=dummyHardwareId,networkId=dummyNetworkId,userDataId=dummyUserDataId,instanceCap=10,instancesMin=1,floatingIpPool=dummyPoolName,securityGroups=default,availabilityZone=dummyAvailabilityZone,startTimeout=600000,keyPairName=dummyKeyPairName,numExecutors=1,jvmOptions=dummyJvmOptions,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=0,configDrive=false]
2.493 [id=65] INFO j.p.o.c.slaveopts.BootSource#selectIdFromListAndLogProblems: NO Images match name 'dummyImageId'.
2.494 [id=65] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1736568464
2.494 [id=65] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Amended server: Mock for Object, hashCode: 1736568464
2.494 [id=65] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-8
Autolaunching agent for slave: template0-8
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main createEngine
template0-8 err: INFO: Setting up agent: template0-8
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.Engine startEngine
template0-8 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.Engine startEngine
template0-8 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Locating server among [http://localhost:33433/jenkins/]
template0-8 err: Jan 10, 2025 10:13:41 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-8 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
3.093 [id=381] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #23 from /127.0.0.1:46506 failed: null
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Agent discovery successful
template0-8 err: Agent address: localhost
template0-8 err: Agent port: 41041
template0-8 err: Identity: ed:21:0b:28:9b:18:d7:06:9b:ba:4f:a1:28:f5:d0:28
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Handshaking
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Connecting to localhost:41041
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Trying protocol: JNLP4-connect
template0-8 err: Jan 10, 2025 10:13:41 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-8 err: INFO: Waiting for ProtocolStack to start.
3.128 [id=382] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #24 from /127.0.0.1:46516
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Remote identity confirmed: ed:21:0b:28:9b:18:d7:06:9b:ba:4f:a1:28:f5:d0:28
template0-8 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Connected
3.491 [id=366] INFO hudson.slaves.NodeProvisioner#update: template0 provisioning successfully completed. We have now 2 computer(s)
3.492 [id=366] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
3.492 [id=80] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-9 with options jenkins.plugins.openstack.compute.SlaveOptions@64ee79f0[bootSource=Image dummyImageId,hardwareId=dummyHardwareId,networkId=dummyNetworkId,userDataId=dummyUserDataId,instanceCap=10,instancesMin=1,floatingIpPool=dummyPoolName,securityGroups=default,availabilityZone=dummyAvailabilityZone,startTimeout=600000,keyPairName=dummyKeyPairName,numExecutors=1,jvmOptions=dummyJvmOptions,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=0,configDrive=false]
3.492 [id=80] INFO j.p.o.c.slaveopts.BootSource#selectIdFromListAndLogProblems: NO Images match name 'dummyImageId'.
3.494 [id=80] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 511317369
3.494 [id=80] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Amended server: Mock for Object, hashCode: 511317369
3.494 [id=80] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-9
Autolaunching agent for slave: template0-9
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main createEngine
template0-9 err: INFO: Setting up agent: template0-9
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.Engine startEngine
template0-9 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.Engine startEngine
template0-9 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Locating server among [http://localhost:33433/jenkins/]
template0-9 err: Jan 10, 2025 10:13:41 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-9 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
3.835 [id=393] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #25 from /127.0.0.1:42678 failed: null
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Agent discovery successful
template0-9 err: Agent address: localhost
template0-9 err: Agent port: 41041
template0-9 err: Identity: ed:21:0b:28:9b:18:d7:06:9b:ba:4f:a1:28:f5:d0:28
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Handshaking
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Connecting to localhost:41041
template0-9 err: Jan 10, 2025 10:13:41 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Trying protocol: JNLP4-connect
template0-9 err: Jan 10, 2025 10:13:41 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-9 err: INFO: Waiting for ProtocolStack to start.
3.907 [id=394] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #26 from /127.0.0.1:42694
3.955 [id=339] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: Executing preserveAgentOfflineByUser(jenkins.plugins.openstack.compute.SingleUseSlaveTest) for template0-8 terminated: java.nio.channels.ClosedChannelException
3.957 [id=339] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
template0-8 err: Jan 10, 2025 10:13:42 AM hudson.remoting.jnlp.Main$CuiListener status
template0-8 err: INFO: Terminated
3.963 [id=339] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
template0-9 err: Jan 10, 2025 10:13:42 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: Protocol JNLP4-connect encountered an unexpected exception
template0-9 err: java.util.concurrent.ExecutionException: org.jenkinsci.remoting.protocol.impl.ConnectionRefusalException: Connection closed before acknowledgement sent
template0-9 err: at org.jenkinsci.remoting.util.SettableFuture.get(SettableFuture.java:223)
template0-9 err: at hudson.remoting.Engine.innerRun(Engine.java:814)
template0-9 err: at hudson.remoting.Engine.run(Engine.java:543)
template0-9 err: Caused by: org.jenkinsci.remoting.protocol.impl.ConnectionRefusalException: Connection closed before acknowledgement sent
template0-9 err: at org.jenkinsci.remoting.protocol.impl.AckFilterLayer.onRecvClosed(AckFilterLayer.java:280)
template0-9 err: at org.jenkinsci.remoting.protocol.ProtocolStack$Ptr.onRecvClosed(ProtocolStack.java:825)
template0-9 err: at org.jenkinsci.remoting.protocol.NetworkLayer.onRecvClosed(NetworkLayer.java:155)
template0-9 err: at org.jenkinsci.remoting.protocol.impl.BIONetworkLayer.access$700(BIONetworkLayer.java:51)
template0-9 err: at org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader.run(BIONetworkLayer.java:257)
template0-9 err: at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
template0-9 err: at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
template0-9 err: at hudson.remoting.Engine$1.lambda$newThread$0(Engine.java:125)
template0-9 err: at java.base/java.lang.Thread.run(Thread.java:840)
template0-9 err:
template0-9 err: Jan 10, 2025 10:13:42 AM hudson.remoting.jnlp.Main$CuiListener status
template0-9 err: INFO: reconnect rejected, sleeping 10s:
template0-9 err: java.lang.Exception: The server rejected the connection: None of the protocols were accepted
template0-9 err: at hudson.remoting.Engine.onConnectionRejected(Engine.java:893)
template0-9 err: at hudson.remoting.Engine.innerRun(Engine.java:840)
template0-9 err: at hudson.remoting.Engine.run(Engine.java:543)
template0-9 err:
4.008 [id=339] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390/plugin/target/tmp/j h11261826315226223481
Standard out
=== Starting preserveAgentOfflineByUser(jenkins.plugins.openstack.compute.SingleUseSlaveTest)
$ /opt/jdk-17/bin/java -jar -DstartedBy=preserveAgentOfflineByUser(jenkins.plugins.openstack.compute.SingleUseSlaveTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:33433/jenkins/computer/template0-8/slave-agent.jnlp
$ /opt/jdk-17/bin/java -jar -DstartedBy=preserveAgentOfflineByUser(jenkins.plugins.openstack.compute.SingleUseSlaveTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-390@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:33433/jenkins/computer/template0-9/slave-agent.jnlp
Loading