Fix compatibility with Jenkins 2.482+ #385
Merged
ci.jenkins.io / Tests / linux-17 / Build (linux-17)
failed
Nov 5, 2024
failed: 5, skipped: 3, passed: 165
Send us feedback
Details
jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest.discardTemporarilyOfflineSlave
[] expected null, but was:<jenkins.plugins.openstack.compute.JCloudsComputer@7753114a>
Stack trace
java.lang.AssertionError: [] expected null, but was:<jenkins.plugins.openstack.compute.JCloudsComputer@7753114a>
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotNull(Assert.java:756)
at org.junit.Assert.assertNull(Assert.java:738)
at jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest.discardTemporarilyOfflineSlave(JCloudsCleanupThreadTest.java:66)
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.011 [id=145] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:43789/jenkins/
0.083 [id=158] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.084 [id=163] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.085 [id=159] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h10580711803668472244/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.175 [id=162] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.177 [id=163] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.178 [id=157] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.435 [id=158] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.446 [id=159] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.446 [id=162] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.446 [id=162] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.448 [id=161] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
0.459 [id=75] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-2 with options jenkins.plugins.openstack.compute.SlaveOptions@48c870a5[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]
0.459 [id=75] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
0.460 [id=75] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 602343466
0.460 [id=75] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-2
Autolaunching agent for slave: template0-2
0.468 [id=145] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
0.472 [id=145] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
0.507 [id=145] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h10580711803668472244
Standard out
=== Starting discardTemporarilyOfflineSlave(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest)
$ /opt/jdk-17/bin/java -jar -DstartedBy=discardTemporarilyOfflineSlave(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:43789/jenkins/computer/template0-2/slave-agent.jnlp
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)
Suppressed: java.io.IOException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h6565393740859800042/jobs
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.delete(TemporaryDirectoryAllocator.java:144)
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.dispose(TemporaryDirectoryAllocator.java:99)
at org.jvnet.hudson.test.TestEnvironment.dispose(TestEnvironment.java:84)
at org.jvnet.hudson.test.JenkinsRule.after(JenkinsRule.java:524)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:625)
... 2 more
Caused by: java.nio.file.DirectoryNotEmptyException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h6565393740859800042
at java.base/sun.nio.fs.UnixFileSystemProvider.implDelete(UnixFileSystemProvider.java:246)
at java.base/sun.nio.fs.AbstractFileSystemProvider.deleteIfExists(AbstractFileSystemProvider.java:110)
at java.base/java.nio.file.Files.deleteIfExists(Files.java:1191)
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.delete(TemporaryDirectoryAllocator.java:141)
... 6 more
Standard error
0.007 [id=278] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:41165/jenkins/
0.069 [id=291] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.070 [id=296] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.070 [id=295] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h6565393740859800042/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.159 [id=296] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.161 [id=291] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.161 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.414 [id=294] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.423 [id=294] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.423 [id=294] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.424 [id=293] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.427 [id=295] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.428 [id=303] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
1.428 [id=75] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-5 with options jenkins.plugins.openstack.compute.SlaveOptions@5947ee19[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.428 [id=75] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
1.429 [id=75] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 924098791
1.429 [id=75] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-5
Autolaunching agent for slave: template0-5
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main createEngine
template0-5 err: INFO: Setting up agent: template0-5
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.Engine startEngine
template0-5 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-5 err: Nov 05, 2024 8:28:58 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: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Locating server among [http://localhost:41165/jenkins/]
template0-5 err: Nov 05, 2024 8:28:58 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-5 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
2.033 [id=320] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #10 from /127.0.0.1:35056 failed: null
template0-5 err: Nov 05, 2024 8:28:58 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: 39637
template0-5 err: Identity: d4:83:d0:02:a7:cc:c3:3f:7d:44:06:ad:58:5e:01:b4
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Handshaking
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Connecting to localhost:39637
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Trying protocol: JNLP4-connect
template0-5 err: Nov 05, 2024 8:28:58 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-5 err: INFO: Waiting for ProtocolStack to start.
2.069 [id=321] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #11 from /127.0.0.1:35060
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Remote identity confirmed: d4:83:d0:02:a7:cc:c3:3f:7d:44:06:ad:58:5e:01:b4
template0-5 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Connected
2.427 [id=305] INFO hudson.slaves.NodeProvisioner#update: template0 provisioning successfully completed. We have now 2 computer(s)
2.428 [id=305] INFO h.s.NodeProvisioner$StandardStrategyImpl#apply: Started provisioning template0 from openstack with 1 executors. Remaining excess workload: 0
2.428 [id=80] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-6 with options jenkins.plugins.openstack.compute.SlaveOptions@1f749822[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.428 [id=80] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
2.429 [id=80] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1678394315
2.430 [id=80] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-6
Autolaunching agent for slave: template0-6
template0-6 err: Nov 05, 2024 8:28:58 AM hudson.remoting.jnlp.Main createEngine
template0-6 err: INFO: Setting up agent: template0-6
template0-6 err: Nov 05, 2024 8:28:58 AM hudson.remoting.Engine startEngine
template0-6 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-6 err: Nov 05, 2024 8:28:58 AM hudson.remoting.Engine startEngine
template0-6 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
2.732 [id=278] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: Executing terminateNodeWithShutoffServer(jenkins.plugins.openstack.compute.JCloudsCleanupThreadTest) for template0-5 terminated: java.nio.channels.ClosedChannelException
2.732 [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
2.734 [id=278] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
template0-5 err: Nov 05, 2024 8:28:59 AM hudson.remoting.jnlp.Main$CuiListener status
template0-5 err: INFO: Terminated
2.737 [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)
2.740 [id=278] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
template0-6 err: Nov 05, 2024 8:28:59 AM hudson.remoting.jnlp.Main$CuiListener status
template0-6 err: INFO: Locating server among [http://localhost:41165/jenkins/]
template0-6 err: Nov 05, 2024 8:28:59 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:
2.811 [id=278] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h6565393740859800042
2.816 [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)
2.818 [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-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:41165/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-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:41165/jenkins/computer/template0-6/slave-agent.jnlp
jenkins.plugins.openstack.compute.JCloudsCloudTest.doProvision
/home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/org.jenkinsci.plugins.cloudstats.CloudStatistics.xml
Stack trace
java.io.IOException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/org.jenkinsci.plugins.cloudstats.CloudStatistics.xml
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.delete(TemporaryDirectoryAllocator.java:144)
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.dispose(TemporaryDirectoryAllocator.java:99)
at org.jvnet.hudson.test.TestEnvironment.dispose(TestEnvironment.java:84)
at org.jvnet.hudson.test.JenkinsRule.after(JenkinsRule.java:524)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:625)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: java.nio.file.DirectoryNotEmptyException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518
at java.base/sun.nio.fs.UnixFileSystemProvider.implDelete(UnixFileSystemProvider.java:246)
at java.base/sun.nio.fs.AbstractFileSystemProvider.deleteIfExists(AbstractFileSystemProvider.java:110)
at java.base/java.nio.file.Files.deleteIfExists(Files.java:1191)
at org.jvnet.hudson.test.TemporaryDirectoryAllocator.delete(TemporaryDirectoryAllocator.java:141)
... 6 more
Standard error
0.006 [id=446] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:34913/jenkins/
0.066 [id=459] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.066 [id=463] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.067 [id=460] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.154 [id=459] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.155 [id=459] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.155 [id=462] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
1.755 [id=465] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
1.763 [id=464] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
1.763 [id=465] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
1.764 [id=462] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
1.767 [id=459] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.934 [id=469] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-0 with options jenkins.plugins.openstack.compute.SlaveOptions@1e98936b[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.935 [id=469] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
1.955 [id=469] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1872733108
1.957 [id=469] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-0
Autolaunching agent for slave: template0-0
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main createEngine
template0-0 err: INFO: Setting up agent: template0-0
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.Engine startEngine
template0-0 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.Engine startEngine
template0-0 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Locating server among [http://localhost:34913/jenkins/]
template0-0 err: Nov 05, 2024 8:29:49 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-0 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
2.434 [id=487] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #11 from /127.0.0.1:45026 failed: null
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Agent discovery successful
template0-0 err: Agent address: localhost
template0-0 err: Agent port: 35917
template0-0 err: Identity: 61:d6:f6:d1:a9:27:7a:01:93:88:1f:78:ed:d1:f3:71
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Handshaking
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Connecting to localhost:35917
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Trying protocol: JNLP4-connect
template0-0 err: Nov 05, 2024 8:29:49 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-0 err: INFO: Waiting for ProtocolStack to start.
2.481 [id=488] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #12 from /127.0.0.1:45030
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Remote identity confirmed: 61:d6:f6:d1:a9:27:7a:01:93:88:1f:78:ed:d1:f3:71
template0-0 err: Nov 05, 2024 8:29:49 AM hudson.remoting.jnlp.Main$CuiListener status
template0-0 err: INFO: Connected
4.938 [id=476] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-1 with options jenkins.plugins.openstack.compute.SlaveOptions@738c28b[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]
4.938 [id=476] WARNING j.p.o.c.JCloudsSlaveTemplate#provisionServer: No BootSource set for JCloudsSlaveTemplate with name='template0'.
4.939 [id=476] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 1550842820
4.939 [id=476] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-1
Autolaunching agent for slave: template0-1
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main createEngine
template0-1 err: INFO: Setting up agent: template0-1
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.Engine startEngine
template0-1 err: INFO: Using Remoting version: 3131.vf2b_b_798b_ce99
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.Engine startEngine
template0-1 err: WARNING: No Working Directory. Using the legacy JAR Cache location: /home/jenkins/.jenkins/cache/jars
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Locating server among [http://localhost:34913/jenkins/]
template0-1 err: Nov 05, 2024 8:29:52 AM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
template0-1 err: INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
5.217 [id=504] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #13 from /127.0.0.1:45034 failed: null
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Agent discovery successful
template0-1 err: Agent address: localhost
template0-1 err: Agent port: 35917
template0-1 err: Identity: 61:d6:f6:d1:a9:27:7a:01:93:88:1f:78:ed:d1:f3:71
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Handshaking
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Connecting to localhost:35917
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Trying protocol: JNLP4-connect
template0-1 err: Nov 05, 2024 8:29:52 AM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
template0-1 err: INFO: Waiting for ProtocolStack to start.
5.255 [id=505] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #14 from /127.0.0.1:45036
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Remote identity confirmed: 61:d6:f6:d1:a9:27:7a:01:93:88:1f:78:ed:d1:f3:71
template0-1 err: Nov 05, 2024 8:29:52 AM hudson.remoting.jnlp.Main$CuiListener status
template0-1 err: INFO: Connected
Killing agent hudson.Proc$LocalProc@4c99a77c for template0-0
8.279 [id=492] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: IOHub#11: Worker[channel:java.nio.channels.SocketChannel[connected local=/127.0.0.1:35917 remote=localhost/127.0.0.1:45030]] / Computer.threadPoolForRemoting [#5] for template0-0 terminated: java.nio.channels.ClosedChannelException
Killing agent hudson.Proc$LocalProc@48acb2d9 for template0-1
8.913 [id=492] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: IOHub#11: Worker[channel:java.nio.channels.SocketChannel[connected local=/127.0.0.1:35917 remote=localhost/127.0.0.1:45036]] / Computer.threadPoolForRemoting [#5] for template0-1 terminated: java.nio.channels.ClosedChannelException
9.248 [id=446] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
9.254 [id=446] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
9.340 [id=446] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518
9.344 [id=476] WARNING hudson.util.AtomicFileWriter#commit: Unable to move atomically, falling back to non-atomic move.
java.nio.file.NoSuchFileException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/atomic15165051936221690001tmp -> /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.xml
at java.base/sun.nio.fs.UnixException.translateToIOException(UnixException.java:92)
at java.base/sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:106)
at java.base/sun.nio.fs.UnixCopyFile.move(UnixCopyFile.java:416)
at java.base/sun.nio.fs.UnixFileSystemProvider.move(UnixFileSystemProvider.java:266)
at java.base/java.nio.file.Files.move(Files.java:1432)
at hudson.util.AtomicFileWriter.commit(AtomicFileWriter.java:195)
at hudson.XmlFile.write(XmlFile.java:218)
at org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.persist(AsyncResourceDisposer.java:206)
at org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.dispose(AsyncResourceDisposer.java:163)
at jenkins.plugins.openstack.compute.JCloudsSlave._terminate(JCloudsSlave.java:414)
at jenkins.plugins.openstack.compute.JCloudsSlaveTemplate.provisionSlave(JCloudsSlaveTemplate.java:260)
at jenkins.plugins.openstack.compute.JCloudsCloud.provisionSlaveExplicitly(JCloudsCloud.java:470)
at jenkins.plugins.openstack.compute.JCloudsCloud.lambda$provisionAsynchronouslyNotToBlockTheRequestThread$2(JCloudsCloud.java:432)
at jenkins.security.ImpersonatingScheduledExecutorService$2.call(ImpersonatingScheduledExecutorService.java:79)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304)
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)
9.345 [id=476] WARNING hudson.util.AtomicFileWriter#commit: Unable to move /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/atomic15165051936221690001tmp to /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.xml. Attempting to delete /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/atomic15165051936221690001tmp and abandoning.
9.345 [id=476] WARNING o.j.p.r.AsyncResourceDisposer#persist: Unable to store AsyncResourceDisposer history
Also: java.nio.file.NoSuchFileException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/atomic15165051936221690001tmp -> /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.xml
at java.base/sun.nio.fs.UnixException.translateToIOException(UnixException.java:92)
at java.base/sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:106)
at java.base/sun.nio.fs.UnixCopyFile.move(UnixCopyFile.java:416)
at java.base/sun.nio.fs.UnixFileSystemProvider.move(UnixFileSystemProvider.java:266)
at java.base/java.nio.file.Files.move(Files.java:1432)
at hudson.util.AtomicFileWriter.commit(AtomicFileWriter.java:195)
java.nio.file.NoSuchFileException: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9689562846198088518/atomic15165051936221690001tmp
at java.base/sun.nio.fs.UnixException.translateToIOException(UnixException.java:92)
at java.base/sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:106)
at java.base/sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:111)
at java.base/sun.nio.fs.UnixCopyFile.move(UnixCopyFile.java:429)
at java.base/sun.nio.fs.UnixFileSystemProvider.move(UnixFileSystemProvider.java:266)
at java.base/java.nio.file.Files.move(Files.java:1432)
at hudson.util.AtomicFileWriter.commit(AtomicFileWriter.java:210)
at hudson.XmlFile.write(XmlFile.java:218)
at org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.persist(AsyncResourceDisposer.java:206)
at org.jenkinsci.plugins.resourcedisposer.AsyncResourceDisposer.dispose(AsyncResourceDisposer.java:163)
at jenkins.plugins.openstack.compute.JCloudsSlave._terminate(JCloudsSlave.java:414)
at jenkins.plugins.openstack.compute.JCloudsSlaveTemplate.provisionSlave(JCloudsSlaveTemplate.java:260)
at jenkins.plugins.openstack.compute.JCloudsCloud.provisionSlaveExplicitly(JCloudsCloud.java:470)
at jenkins.plugins.openstack.compute.JCloudsCloud.lambda$provisionAsynchronouslyNotToBlockTheRequestThread$2(JCloudsCloud.java:432)
at jenkins.security.ImpersonatingScheduledExecutorService$2.call(ImpersonatingScheduledExecutorService.java:79)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304)
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)
9.345 [id=476] WARNING j.p.o.compute.JCloudsCloud#lambda$provisionAsynchronouslyNotToBlockTheRequestThread$2: Provisioning failed
java.lang.NullPointerException: Cannot read field "root" because the return value of "jenkins.model.Jenkins.getInstance()" is null
at org.jenkinsci.plugins.cloudstats.CloudStatistics.getConfigFile(CloudStatistics.java:441)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.save(CloudStatistics.java:334)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.persist(CloudStatistics.java:339)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.attach(CloudStatistics.java:325)
at org.jenkinsci.plugins.cloudstats.CloudStatistics$ProvisioningListener.onFailure(CloudStatistics.java:561)
at jenkins.plugins.openstack.compute.JCloudsCloud.provisionSlaveExplicitly(JCloudsCloud.java:473)
at jenkins.plugins.openstack.compute.JCloudsCloud.lambda$provisionAsynchronouslyNotToBlockTheRequestThread$2(JCloudsCloud.java:432)
at jenkins.security.ImpersonatingScheduledExecutorService$2.call(ImpersonatingScheduledExecutorService.java:79)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304)
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)
9.346 [id=476] WARNING j.u.ErrorLoggingScheduledThreadPoolExecutor#afterExecute: failure in task not wrapped in SafeTimerTask
java.lang.NullPointerException: Cannot read field "root" because the return value of "jenkins.model.Jenkins.getInstance()" is null
at org.jenkinsci.plugins.cloudstats.CloudStatistics.getConfigFile(CloudStatistics.java:441)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.save(CloudStatistics.java:334)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.persist(CloudStatistics.java:339)
at org.jenkinsci.plugins.cloudstats.CloudStatistics.attach(CloudStatistics.java:325)
at org.jenkinsci.plugins.cloudstats.CloudStatistics$ProvisioningListener.onFailure(CloudStatistics.java:561)
at jenkins.plugins.openstack.compute.JCloudsCloud.provisionSlaveExplicitly(JCloudsCloud.java:473)
at jenkins.plugins.openstack.compute.JCloudsCloud.lambda$provisionAsynchronouslyNotToBlockTheRequestThread$2(JCloudsCloud.java:432)
at jenkins.security.ImpersonatingScheduledExecutorService$2.call(ImpersonatingScheduledExecutorService.java:79)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304)
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)
Standard out
=== Starting doProvision(jenkins.plugins.openstack.compute.JCloudsCloudTest)
$ /opt/jdk-17/bin/java -jar -DstartedBy=doProvision(jenkins.plugins.openstack.compute.JCloudsCloudTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:34913/jenkins/computer/template0-0/slave-agent.jnlp
$ /opt/jdk-17/bin/java -jar -DstartedBy=doProvision(jenkins.plugins.openstack.compute.JCloudsCloudTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:34913/jenkins/computer/template0-1/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:340)
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=151] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:40385/jenkins/
0.068 [id=164] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.068 [id=164] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.069 [id=163] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9141548614002823267/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.152 [id=165] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.154 [id=167] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.154 [id=167] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.609 [id=170] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.619 [id=168] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.620 [id=170] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.620 [id=170] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.622 [id=164] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
0.635 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-2 with options jenkins.plugins.openstack.compute.SlaveOptions@1487915e[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]
0.635 [id=74] INFO j.p.o.c.slaveopts.BootSource#selectIdFromListAndLogProblems: NO Images match name 'dummyImageId'.
0.644 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 257732741
0.644 [id=74] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Amended server: Mock for Object, hashCode: 257732741
0.645 [id=74] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-2
0.646 [id=65] WARNING o.j.p.cloudstats.CloudStatistics#getActivityFor: No activity tracked for ProvisioningActivity for openstack/template0/null (-97094628)
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)
0.646 [id=65] WARNING o.j.p.cloudstats.CloudStatistics#getActivityFor: No activity tracked for ProvisioningActivity for openstack/template0/null (-97094628)
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)
0.649 [id=151] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
0.653 [id=151] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
0.685 [id=151] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h9141548614002823267
Standard out
=== Starting timeoutLaunchingJnlp(jenkins.plugins.openstack.compute.ProvisioningTest)
jenkins.plugins.openstack.compute.ProvisioningTest.reportOfflineCauseInCloudStats
Expected: an iterable with size <1>
but: iterable size was <0>
Stack trace
java.lang.AssertionError:
Expected: an iterable with size <1>
but: iterable size was <0>
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:6)
at jenkins.plugins.openstack.compute.ProvisioningTest.reportOfflineCauseInCloudStats(ProvisioningTest.java:408)
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=759] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:41097/jenkins/
0.067 [id=772] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.068 [id=776] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.068 [id=775] INFO j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h492640558700595784/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.169 [id=778] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.171 [id=773] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.172 [id=775] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.913 [id=775] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.921 [id=775] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.921 [id=776] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.922 [id=775] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.925 [id=778] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
0.936 [id=76] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioning new openstack server template0-18 with options jenkins.plugins.openstack.compute.SlaveOptions@24556a98[bootSource=Image dummyImageId,hardwareId=dummyHardwareId,networkId=dummyNetworkId,userDataId=dummyUserDataId,instanceCap=10,instancesMin=0,floatingIpPool=dummyPoolName,securityGroups=default,availabilityZone=dummyAvailabilityZone,startTimeout=100,keyPairName=dummyKeyPairName,numExecutors=1,jvmOptions=dummyJvmOptions,fsRoot=/tmp/jenkins,launcherFactory=jenkins.plugins.openstack.compute.slaveopts.LauncherFactory$JNLP@1f,nodeProperties=<null>,retentionTime=30,configDrive=false]
0.936 [id=76] INFO j.p.o.c.slaveopts.BootSource#selectIdFromListAndLogProblems: NO Images match name 'dummyImageId'.
0.937 [id=76] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Provisioned: Mock for Object, hashCode: 369555501
0.937 [id=76] INFO j.p.o.c.JCloudsSlaveTemplate#provisionServer: Amended server: Mock for Object, hashCode: 369555501
0.937 [id=76] INFO j.p.o.compute.JCloudsSlave#createComputer: Creating a new computer for template0-18
Autolaunching agent for slave: template0-18
0.944 [id=759] INFO j.p.o.compute.JCloudsComputer#deleteSlave: Deleting slave template0-18 after executing 0 builds
0.946 [id=759] INFO j.p.o.compute.JCloudsComputer#deleteSlave: Deleted slave template0-18
0.948 [id=759] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
0.952 [id=759] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
1.003 [id=759] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385/plugin/target/tmp/j h492640558700595784
Standard out
=== Starting reportOfflineCauseInCloudStats(jenkins.plugins.openstack.compute.ProvisioningTest)
$ /opt/jdk-17/bin/java -jar -DstartedBy=reportOfflineCauseInCloudStats(jenkins.plugins.openstack.compute.ProvisioningTest) /home/jenkins/agent/workspace/ns_openstack-cloud-plugin_PR-385@tmp/m2repo/org/jenkins-ci/main/remoting/3131.vf2b_b_798b_ce99/remoting-3131.vf2b_b_798b_ce99.jar -jnlpUrl http://localhost:41097/jenkins/computer/template0-18/slave-agent.jnlp
Loading