Hung build after FatalRejectedExecutionException from handleExit
#455
ci.jenkins.io / Tests / windows-17 / Build (windows-17)
failed
Jun 23, 2025 in 0s
org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest.restartWhilePlaceholderTaskIsInQueue[watching=false] failed
org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest.restartWhilePlaceholderTaskIsInQueue[watching=false] failed
Details
org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest.restartWhilePlaceholderTaskIsInQueue[watching=false]
Expected: an empty collection
but: <[Thread[Executor #0 for custom-label : executing PlaceholderExecutable:ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1},5,]]>
Stack trace
java.lang.AssertionError:
Expected: an empty collection
but: <[Thread[Executor #0 for custom-label : executing PlaceholderExecutable:ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1},5,]]>
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:6)
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest.lambda$restartWhilePlaceholderTaskIsInQueue$45(ExecutorStepTest.java:1226)
at org.jvnet.hudson.test.JenkinsSessionRule$2.evaluate(JenkinsSessionRule.java:104)
at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:648)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at java.base/java.lang.Thread.run(Thread.java:840)
Standard error
0.274 [id=141] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer2: Running on http://localhost:50883/jenkins/
0.584 [id=154] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.586 [id=157] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.588 [id=159] INFO j.b.api.BouncyCastlePlugin#start: C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\j h9231278419891520585\plugins\bouncycastle-api\WEB-INF\optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.715 [id=158] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.717 [id=156] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.717 [id=159] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
1.089 [id=160] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
1.089 [id=160] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
1.090 [id=160] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
1.090 [id=155] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
1.107 [id=158] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.152 [id=141] INFO o.j.hudson.test.InboundAgentRule#start: Running: [C:\tools\jdk-17\bin\java.exe, -Xmx512m, -XX:+PrintCommandLineFlags, -Djava.awt.headless=true, -jar, C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\agent14603801353263294254.jar, -url, http://localhost:50883/jenkins/, -name, custom-label, -secret, f5e2faaee0c25f235282ac0c7fa4b6fac4082db301a53083dfb8cc6ff7c3235f, -workDir, C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835]
1.156 [id=141] INFO o.jvnet.hudson.test.JenkinsRule#waitOnline: Waiting for custom-label to come online…
-XX:ConcGCThreads=1 -XX:G1ConcRefinementThreads=4 -XX:GCDrainStackTargetSize=64 -XX:InitialHeapSize=268417088 -XX:MarkStackSize=4194304 -XX:MaxHeapSize=536870912 -XX:MinHeapSize=6815736 -XX:+PrintCommandLineFlags -XX:ReservedCodeCacheSize=251658240 -XX:+SegmentedCodeCache -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseLargePagesIndividualAllocation
Jun 23, 2025 7:27:12 PM org.jenkinsci.remoting.engine.WorkDirManager initializeWorkDir
INFO: Using C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\remoting as a remoting work directory
Jun 23, 2025 7:27:12 PM org.jenkinsci.remoting.engine.WorkDirManager setupLogging
INFO: Both error and output logs will be printed to C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\remoting
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher createEngine
INFO: Setting up agent: custom-label
Jun 23, 2025 7:27:12 PM hudson.remoting.Engine startEngine
INFO: Using Remoting version: 3261.v9c670a_4748a_9
Jun 23, 2025 7:27:12 PM org.jenkinsci.remoting.engine.WorkDirManager initializeWorkDir
INFO: Using C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\remoting as a remoting work directory
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Locating server among [http://localhost:50883/jenkins/]
Jun 23, 2025 7:27:12 PM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
1.710 [id=181] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #3 from /127.0.0.1:50891 failed: null
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Agent discovery successful
Agent address: localhost
Agent port: 50889
Identity: 4e:78:de:dc:a6:1e:91:29:94:3c:51:2f:66:3a:24:9b
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Handshaking
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Connecting to localhost:50889
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Server reports protocol JNLP4-connect-proxy not supported, skipping
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Trying protocol: JNLP4-connect
Jun 23, 2025 7:27:12 PM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
INFO: Waiting for ProtocolStack to start.
1.764 [id=182] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #4 from /127.0.0.1:50892
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Remote identity confirmed: 4e:78:de:dc:a6:1e:91:29:94:3c:51:2f:66:3a:24:9b
Jun 23, 2025 7:27:12 PM hudson.remoting.Launcher$CuiListener status
INFO: Connected
3.088 [id=141] INFO o.jvnet.hudson.test.JenkinsRule#waitOnline: …custom-label is now online.
3.117 [id=141] INFO o.j.p.w.t.s.SemaphoreStep$State#get: Initializing state in C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\j h9231278419891520585
3.255 [p #1] Started
3.255 [p #1] [Pipeline] Start of Pipeline
3.261 [id=89] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask#<init>: scheduling ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1}
3.353 [p #1] [Pipeline] node
3.525 [id=177] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$PlaceholderExecutable#lambda$run$4: waiting on CpsStepContext[3:node]:p#1
3.526 [id=89] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$PlaceholderExecutable#lambda$run$1: started CpsStepContext[3:node]:p#1
3.573 [p #1] Running on custom-label in C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\workspace\p
3.574 [p #1] [Pipeline] {
3.586 [id=88] INFO o.j.p.w.t.s.SemaphoreStep$Execution#start: Blocking wait/1
3.590 [id=141] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: Executing restartWhilePlaceholderTaskIsInQueue[watching=false](org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest) for custom-label terminated: java.nio.channels.ClosedChannelException
3.596 [id=141] WARNING o.j.h.t.RemainingActivityListener#onTearDown: p #1 still seems to be running, which could break deletion of log files or metadata
Jun 23, 2025 7:27:14 PM hudson.remoting.Launcher$CuiListener status
INFO: Terminated
3.602 [id=141] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
3.613 [id=141] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
3.710 [p #1] [Pipeline] semaphore
Jun 23, 2025 7:27:14 PM hudson.remoting.Request$2 run
INFO: Failed to send back a reply to the request UserRequest:jenkins.slaves.restarter.JnlpSlaveRestarterInstaller$FindEffectiveRestarters@5825f67e: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@3ab74b7:JNLP4-connect connection to localhost/127.0.0.1:50889": channel is already closed
0.324 [id=193] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer2: Running on http://localhost:50883/jenkins/
0.652 [id=205] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.654 [id=206] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.655 [id=208] INFO j.b.api.BouncyCastlePlugin#start: C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\j h9231278419891520585\plugins\bouncycastle-api\WEB-INF\optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.769 [id=209] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.771 [id=208] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.771 [id=206] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.917 [id=206] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.918 [id=206] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.937 [id=209] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.938 [id=208] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.947 [id=208] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
1.083 [id=213] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask#readResolve
java.lang.Exception: deserializing previously scheduled ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:null]:p#1}
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$PlaceholderTask.readResolve(ExecutorStepExecution.java:505)
at org.jboss.marshalling.reflect.SerMethods.callReadResolve(SerMethods.java:125)
at org.jboss.marshalling.reflect.SerializableClass.callReadResolve(SerializableClass.java:311)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1473)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadCollectionObject(RiverUnmarshaller.java:215)
at org.jboss.marshalling.river.RiverUnmarshaller.readCollectionData(RiverUnmarshaller.java:926)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:779)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.BlockUnmarshaller.readObject(BlockUnmarshaller.java:149)
at org.jboss.marshalling.river.BlockUnmarshaller.readObject(BlockUnmarshaller.java:135)
at org.jboss.marshalling.MarshallerObjectInputStream.readObjectOverride(MarshallerObjectInputStream.java:53)
at org.jboss.marshalling.river.RiverObjectInputStream.readObjectOverride(RiverObjectInputStream.java:307)
at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:500)
at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:467)
at java.base/java.util.HashMap.readObject(HashMap.java:1552)
at org.jboss.marshalling.reflect.SerMethods.callReadObject(SerMethods.java:83)
at org.jboss.marshalling.reflect.SerializableClass.callReadObject(SerializableClass.java:252)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1868)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:244)
at org.jboss.marshalling.AbstractObjectInput.readObject(AbstractObjectInput.java:41)
at org.jenkinsci.plugins.scriptsecurity.sandbox.groovy.GroovySandbox.runInSandbox(GroovySandbox.java:331)
at org.jenkinsci.plugins.workflow.support.pickles.serialization.RiverReader$SandboxedUnmarshaller.sandbox(RiverReader.java:250)
at org.jenkinsci.plugins.workflow.support.pickles.serialization.RiverReader$SandboxedUnmarshaller.readObject(RiverReader.java:263)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution$2.onSuccess(CpsFlowExecution.java:879)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution$2.onSuccess(CpsFlowExecution.java:872)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures$1.run(Futures.java:147)
at org.jenkinsci.plugins.workflow.support.concurrent.DirectExecutor.execute(DirectExecutor.java:33)
at com.google.common.util.concurrent.AbstractFuture.executeListener(AbstractFuture.java:1299)
at com.google.common.util.concurrent.AbstractFuture.addListener(AbstractFuture.java:763)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures.addCallback(Futures.java:157)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures.addCallback(Futures.java:97)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.loadProgramAsync(CpsFlowExecution.java:869)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.onLoad(CpsFlowExecution.java:836)
at org.jenkinsci.plugins.workflow.job.WorkflowRun.getExecution(WorkflowRun.java:718)
at org.jenkinsci.plugins.workflow.job.WorkflowRun.onLoad(WorkflowRun.java:582)
at hudson.model.RunMap.retrieve(RunMap.java:273)
at hudson.model.RunMap.retrieve(RunMap.java:65)
at jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:703)
at jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:685)
at jenkins.model.lazy.AbstractLazyLoadRunMap.getByNumber(AbstractLazyLoadRunMap.java:579)
at hudson.model.RunMap.getById(RunMap.java:237)
at org.jenkinsci.plugins.workflow.job.WorkflowRun$Owner.run(WorkflowRun.java:964)
at org.jenkinsci.plugins.workflow.job.WorkflowRun$Owner.get(WorkflowRun.java:976)
at org.jenkinsci.plugins.workflow.flow.FlowExecutionList$DefaultStorage.resume(FlowExecutionList.java:252)
at org.jenkinsci.plugins.workflow.flow.FlowExecutionList.resume(FlowExecutionList.java:127)
at jenkins.security.ImpersonatingScheduledExecutorService$1.run(ImpersonatingScheduledExecutorService.java:67)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539)
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)
1.123 [id=82] FINE o.j.p.w.s.s.ExecutorStepDynamicContext#resume: scheduled hudson.model.Queue$WaitingItem:ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1}:8 for C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\workspace\p on custom-label
1.138 [p #1] Resuming build at Mon Jun 23 19:27:15 UTC 2025 after Jenkins restart
1.138 [p #1] Waiting for reconnection of custom-label before proceeding with build
1.183 [id=193] WARNING o.j.h.t.RemainingActivityListener#onTearDown: p #1 still seems to be running, which could break deletion of log files or metadata
1.186 [id=193] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
1.206 [id=193] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
0.247 [id=239] INFO o.jvnet.hudson.test.JenkinsRule#createWebServer2: Running on http://localhost:50883/jenkins/
0.544 [id=251] INFO jenkins.InitReactorRunner$1#onAttained: Started initialization
0.546 [id=255] INFO jenkins.InitReactorRunner$1#onAttained: Listed all plugins
0.547 [id=253] INFO j.b.api.BouncyCastlePlugin#start: C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\j h9231278419891520585\plugins\bouncycastle-api\WEB-INF\optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
0.670 [id=257] INFO jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
0.671 [id=255] INFO jenkins.InitReactorRunner$1#onAttained: Started all plugins
0.672 [id=253] INFO jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
0.721 [id=256] INFO jenkins.InitReactorRunner$1#onAttained: System config loaded
0.722 [id=256] INFO jenkins.InitReactorRunner$1#onAttained: System config adapted
0.723 [id=251] INFO jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
0.724 [id=258] INFO jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
0.738 [id=258] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask#readResolve
java.lang.Exception: deserializing previously scheduled ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:null]:p#1}
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$PlaceholderTask.readResolve(ExecutorStepExecution.java:505)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:569)
at com.thoughtworks.xstream.core.util.SerializationMembers.callReadResolve(SerializationMembers.java:78)
at hudson.util.RobustReflectionConverter.unmarshal(RobustReflectionConverter.java:290)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convert(TreeUnmarshaller.java:74)
at com.thoughtworks.xstream.core.AbstractReferenceUnmarshaller.convert(AbstractReferenceUnmarshaller.java:72)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:68)
at hudson.util.RobustReflectionConverter.unmarshalField(RobustReflectionConverter.java:454)
at hudson.util.RobustReflectionConverter.doUnmarshal(RobustReflectionConverter.java:350)
at hudson.util.RobustReflectionConverter.unmarshal(RobustReflectionConverter.java:289)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convert(TreeUnmarshaller.java:74)
at com.thoughtworks.xstream.core.AbstractReferenceUnmarshaller.convert(AbstractReferenceUnmarshaller.java:72)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:68)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:52)
at com.thoughtworks.xstream.converters.collections.AbstractCollectionConverter.readBareItem(AbstractCollectionConverter.java:132)
at hudson.util.RobustCollectionConverter.populateCollection(RobustCollectionConverter.java:87)
at com.thoughtworks.xstream.converters.collections.CollectionConverter.unmarshal(CollectionConverter.java:81)
at hudson.util.RobustCollectionConverter.unmarshal(RobustCollectionConverter.java:78)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convert(TreeUnmarshaller.java:74)
at com.thoughtworks.xstream.core.AbstractReferenceUnmarshaller.convert(AbstractReferenceUnmarshaller.java:72)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:68)
at hudson.util.RobustReflectionConverter.unmarshalField(RobustReflectionConverter.java:454)
at hudson.util.RobustReflectionConverter.doUnmarshal(RobustReflectionConverter.java:350)
at hudson.util.RobustReflectionConverter.unmarshal(RobustReflectionConverter.java:289)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convert(TreeUnmarshaller.java:74)
at com.thoughtworks.xstream.core.AbstractReferenceUnmarshaller.convert(AbstractReferenceUnmarshaller.java:72)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:68)
at com.thoughtworks.xstream.core.TreeUnmarshaller.convertAnother(TreeUnmarshaller.java:52)
at com.thoughtworks.xstream.core.TreeUnmarshaller.start(TreeUnmarshaller.java:136)
at com.thoughtworks.xstream.core.AbstractTreeMarshallingStrategy.unmarshal(AbstractTreeMarshallingStrategy.java:32)
at com.thoughtworks.xstream.XStream.unmarshal(XStream.java:1464)
at hudson.util.XStream2.unmarshal(XStream2.java:230)
at hudson.util.XStream2.unmarshal(XStream2.java:201)
at com.thoughtworks.xstream.XStream.unmarshal(XStream.java:1441)
at com.thoughtworks.xstream.XStream.fromXML(XStream.java:1330)
at hudson.XmlFile.read(XmlFile.java:165)
at hudson.model.Queue.load(Queue.java:405)
at hudson.model.Queue.init(Queue.java:3108)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:569)
at hudson.init.TaskMethodFinder.invoke(TaskMethodFinder.java:109)
at hudson.init.TaskMethodFinder$TaskImpl.run(TaskMethodFinder.java:185)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:305)
at jenkins.model.Jenkins$5.runTask(Jenkins.java:1195)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:221)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:120)
at jenkins.security.ImpersonatingExecutorService$1.run(ImpersonatingExecutorService.java:68)
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.746 [id=253] INFO jenkins.InitReactorRunner$1#onAttained: Completed initialization
0.788 [id=272] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask#readResolve
java.lang.Exception: deserializing previously scheduled ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:null]:p#1}
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$PlaceholderTask.readResolve(ExecutorStepExecution.java:505)
at org.jboss.marshalling.reflect.SerMethods.callReadResolve(SerMethods.java:125)
at org.jboss.marshalling.reflect.SerializableClass.callReadResolve(SerializableClass.java:311)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1473)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadCollectionObject(RiverUnmarshaller.java:215)
at org.jboss.marshalling.river.RiverUnmarshaller.readCollectionData(RiverUnmarshaller.java:926)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:779)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.BlockUnmarshaller.readObject(BlockUnmarshaller.java:149)
at org.jboss.marshalling.river.BlockUnmarshaller.readObject(BlockUnmarshaller.java:135)
at org.jboss.marshalling.MarshallerObjectInputStream.readObjectOverride(MarshallerObjectInputStream.java:53)
at org.jboss.marshalling.river.RiverObjectInputStream.readObjectOverride(RiverObjectInputStream.java:307)
at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:500)
at java.base/java.io.ObjectInputStream.readObject(ObjectInputStream.java:467)
at java.base/java.util.HashMap.readObject(HashMap.java:1552)
at org.jboss.marshalling.reflect.SerMethods.callReadObject(SerMethods.java:83)
at org.jboss.marshalling.reflect.SerializableClass.callReadObject(SerializableClass.java:252)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1868)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:259)
at org.jboss.marshalling.river.RiverUnmarshaller.readFields(RiverUnmarshaller.java:1978)
at org.jboss.marshalling.river.RiverUnmarshaller.doInitSerializable(RiverUnmarshaller.java:1891)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadNewObject(RiverUnmarshaller.java:1472)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:312)
at org.jboss.marshalling.river.RiverUnmarshaller.doReadObject(RiverUnmarshaller.java:244)
at org.jboss.marshalling.AbstractObjectInput.readObject(AbstractObjectInput.java:41)
at org.jenkinsci.plugins.scriptsecurity.sandbox.groovy.GroovySandbox.runInSandbox(GroovySandbox.java:331)
at org.jenkinsci.plugins.workflow.support.pickles.serialization.RiverReader$SandboxedUnmarshaller.sandbox(RiverReader.java:250)
at org.jenkinsci.plugins.workflow.support.pickles.serialization.RiverReader$SandboxedUnmarshaller.readObject(RiverReader.java:263)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution$2.onSuccess(CpsFlowExecution.java:879)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution$2.onSuccess(CpsFlowExecution.java:872)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures$1.run(Futures.java:147)
at org.jenkinsci.plugins.workflow.support.concurrent.DirectExecutor.execute(DirectExecutor.java:33)
at com.google.common.util.concurrent.AbstractFuture.executeListener(AbstractFuture.java:1299)
at com.google.common.util.concurrent.AbstractFuture.addListener(AbstractFuture.java:763)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures.addCallback(Futures.java:157)
at org.jenkinsci.plugins.workflow.support.concurrent.Futures.addCallback(Futures.java:97)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.loadProgramAsync(CpsFlowExecution.java:869)
at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.onLoad(CpsFlowExecution.java:836)
at org.jenkinsci.plugins.workflow.job.WorkflowRun.getExecution(WorkflowRun.java:718)
at org.jenkinsci.plugins.workflow.job.WorkflowRun.onLoad(WorkflowRun.java:582)
at hudson.model.RunMap.retrieve(RunMap.java:273)
at hudson.model.RunMap.retrieve(RunMap.java:65)
at jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:703)
at jenkins.model.lazy.AbstractLazyLoadRunMap.load(AbstractLazyLoadRunMap.java:685)
at jenkins.model.lazy.AbstractLazyLoadRunMap.getByNumber(AbstractLazyLoadRunMap.java:579)
at jenkins.model.lazy.LazyBuildMixIn.getBuildByNumber(LazyBuildMixIn.java:239)
at org.jenkinsci.plugins.workflow.job.WorkflowJob.getBuildByNumber(WorkflowJob.java:233)
at org.jenkinsci.plugins.workflow.job.WorkflowJob.getBuildByNumber(WorkflowJob.java:104)
at hudson.model.Run.fromExternalizableId(Run.java:2463)
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$PlaceholderTask.runForDisplay(ExecutorStepExecution.java:733)
at org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$PlaceholderTask.getEstimatedDuration(ExecutorStepExecution.java:908)
at hudson.model.queue.MappingWorksheet.<init>(MappingWorksheet.java:337)
at hudson.model.queue.MappingWorksheet.<init>(MappingWorksheet.java:322)
at hudson.model.Queue.maintain(Queue.java:1666)
at hudson.model.Queue$1.call(Queue.java:335)
at hudson.model.Queue$1.call(Queue.java:332)
at jenkins.util.AtmostOneTaskExecutor$1.call(AtmostOneTaskExecutor.java:109)
at jenkins.util.AtmostOneTaskExecutor$1.call(AtmostOneTaskExecutor.java:99)
at jenkins.security.ImpersonatingExecutorService$2.call(ImpersonatingExecutorService.java:80)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at hudson.remoting.AtmostOneThreadExecutor$Worker.run(AtmostOneThreadExecutor.java:121)
at java.base/java.lang.Thread.run(Thread.java:840)
0.799 [id=81] FINE o.j.p.w.s.s.ExecutorStepDynamicContext#resume: using already-scheduled hudson.model.Queue$BuildableItem:ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1}:8 for C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\workspace\p on custom-label
0.806 [id=239] INFO o.j.p.w.test.steps.SemaphoreStep#success: Unblocking wait/1 as success
0.833 [p #1] Resuming build at Mon Jun 23 19:27:16 UTC 2025 after Jenkins restart
0.833 [p #1] Waiting for reconnection of custom-label before proceeding with build
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Performing onReconnect operation.
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: onReconnect operation completed.
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Locating server among [http://localhost:50883/jenkins/]
Jun 23, 2025 7:27:24 PM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Agent discovery successful
Agent address: localhost
Agent port: 50896
Identity: 4e:78:de:dc:a6:1e:91:29:94:3c:51:2f:66:3a:24:9b
8.784 [id=290] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #7 from /127.0.0.1:50900 failed: null
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Handshaking
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Connecting to localhost:50896
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Server reports protocol JNLP4-connect-proxy not supported, skipping
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Trying protocol: JNLP4-connect
Jun 23, 2025 7:27:24 PM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
INFO: Waiting for ProtocolStack to start.
8.788 [id=291] INFO h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #8 from /127.0.0.1:50901
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Remote identity confirmed: 4e:78:de:dc:a6:1e:91:29:94:3c:51:2f:66:3a:24:9b
Jun 23, 2025 7:27:24 PM hudson.remoting.Launcher$CuiListener status
INFO: Connected
9.097 [id=81] FINE o.j.p.w.s.s.ExecutorStepDynamicContext#resume: fully restored for C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835\workspace\p on custom-label ? custom-label
9.120 [id=267] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$PlaceholderExecutable#run: resuming CpsStepContext[3:node]:p#1
9.122 [id=267] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$PlaceholderExecutable#lambda$run$4: waiting on CpsStepContext[3:node]:p#1
9.122 [id=88] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$Callback#finished: finished CpsStepContext[3:node]:p#1
9.123 [id=88] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask#finish: no AsynchronousExecution associated with CpsStepContext[3:node]:p#1 (JENKINS-30759 maybe finished before asynch execution was even scheduled?)
9.123 [id=88] FINE o.j.p.w.s.s.ExecutorStepExecution$PlaceholderTask$Callback#finished: was unable to cancel any leftover task from CpsStepContext[3:node]:p#1
9.144 [p #1] Ready to run at Mon Jun 23 19:27:24 UTC 2025
9.144 [p #1] [Pipeline] }
9.218 [p #1] [Pipeline] // node
9.272 [p #1] [Pipeline] End of Pipeline
9.272 [p #1] Finished: SUCCESS
9.277 [id=239] INFO j.s.DefaultJnlpSlaveReceiver#channelClosed: Executing restartWhilePlaceholderTaskIsInQueue[watching=false](org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest) for custom-label terminated: java.nio.channels.ClosedChannelException
Jun 23, 2025 7:27:25 PM hudson.remoting.Launcher$CuiListener status
INFO: Terminated
9.285 [id=239] WARNING o.j.h.t.RemainingActivityListener#onTearDown: PlaceholderExecutable:ExecutorStepExecution.PlaceholderTask{label=custom-label,context=CpsStepContext[3:node]:p#1} still seems to be running, which could break deletion of log files or metadata
9.292 [id=239] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
9.306 [id=239] INFO hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
9.408 [id=1] INFO o.j.hudson.test.InboundAgentRule#after: Cleaning up custom-label agent JVM and/or any subprocesses
Jun 23, 2025 7:27:25 PM hudson.remoting.Request$2 run
INFO: Failed to send back a reply to the request UserRequest:jenkins.slaves.restarter.JnlpSlaveRestarterInstaller$FindEffectiveRestarters@7bacbb35: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@76b5dbe8:JNLP4-connect connection to localhost/127.0.0.1:50896": channel is already closed
9.854 [id=1] INFO o.j.hudson.test.InboundAgentRule#after: Deleting C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\custom-label-work3271632870490176835
9.868 [id=1] INFO o.j.hudson.test.InboundAgentRule#after: Deleting C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\agent14603801353263294254.jar
9.870 [id=1] INFO o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting C:\Jenkins\agent\workspace\_durable-task-step-plugin_PR-455\target\tmp\j h9231278419891520585
Standard out
=== Starting restartWhilePlaceholderTaskIsInQueue[watching=false](org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest)
=== Starting restartWhilePlaceholderTaskIsInQueue[watching=false](org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest)
=== Starting restartWhilePlaceholderTaskIsInQueue[watching=false](org.jenkinsci.plugins.workflow.support.steps.ExecutorStepTest)
Loading