Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Propagate trace context in Block Steps #909

Draft
wants to merge 1 commit into
base: main
Choose a base branch
from

WIP

7fc9d64
Select commit
Loading
Failed to load commit list.
Draft

Propagate trace context in Block Steps #909

WIP
7fc9d64
Select commit
Loading
Failed to load commit list.
ci.jenkins.io / Tests / windows-11 / Build (windows-11) failed Jul 29, 2024 in 0s

failed: 7, skipped: 23, passed: 71

Send us feedback

Details

io.jenkins.plugins.opentelemetry.JenkinsOtelPluginIntegrationTest.testSpanContextPropagationSynchronousTestStep

No value present
Stack trace
java.util.NoSuchElementException: No value present
	at java.base/java.util.Optional.get(Optional.java:148)
	at io.jenkins.plugins.opentelemetry.BaseIntegrationTest.checkChainOfSpans(BaseIntegrationTest.java:146)
	at io.jenkins.plugins.opentelemetry.JenkinsOtelPluginIntegrationTest.testSpanContextPropagationSynchronousTestStep(JenkinsOtelPluginIntegrationTest.java:542)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:655)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.lang.Thread.run(Thread.java:829)
Standard error
0.095 [id=17]	INFO	o.jvnet.hudson.test.WarExploder#explode: Picking up existing exploded jenkins.war at C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\jenkins-for-test
   0.394 [id=17]	INFO	o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:50170/jenkins/
   1.210 [id=32]	INFO	jenkins.InitReactorRunner$1#onAttained: Started initialization
   2.189 [id=35]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\jenkins12068691405153736485\plugins\sshd.jpi
   2.229 [id=35]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\jenkins12068691405153736485\plugins\javax-mail-api.jpi
   4.147 [id=34]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\jenkins12068691405153736485\plugins\matrix-auth.jpi
   4.191 [id=34]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\jenkins12068691405153736485\plugins\command-launcher.jpi
   4.247 [id=34]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\jenkins12068691405153736485\plugins\jdk-tool.jpi
   7.375 [id=36]	INFO	jenkins.InitReactorRunner$1#onAttained: Listed all plugins
   7.395 [id=33]	INFO	j.b.api.BouncyCastlePlugin#start: C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\j h1941832754063125354\plugins\bouncycastle-api\WEB-INF\optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
  19.538 [id=32]	INFO	jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
  19.561 [id=35]	INFO	jenkins.InitReactorRunner$1#onAttained: Started all plugins
  19.566 [id=32]	INFO	jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
  19.927 [id=33]	INFO	i.j.p.o.a.ReconfigurableOpenTelemetry#init: OpenTelemetry initialized as NoOp
  21.149 [id=33]	INFO	jenkins.InitReactorRunner$1#onAttained: System config loaded
  21.250 [id=33]	INFO	jenkins.InitReactorRunner$1#onAttained: System config adapted
  21.555 [id=33]	INFO	i.j.p.o.a.ReconfigurableOpenTelemetry#configure: OpenTelemetry initialized: SDK [config: otel.traces.exporter=testing, otel.metrics.exporter=testing, resource: service.name=jenkins, service.namespace=jenkins, service.version=2.440.3]
  21.722 [id=33]	INFO	i.j.p.o.s.TraceContextServletFilter#afterConfiguration: Jenkins trace context propagation disabled on inbound HTTP requests (eg. build triggers). To enable it, set the property otel.instrumentation.jenkins.remote.span.enabled to true.
  21.982 [id=35]	INFO	jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
  21.985 [id=35]	INFO	jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
  22.004 [id=36]	INFO	jenkins.InitReactorRunner$1#onAttained: Completed initialization
  22.585 [id=69]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  23.587 [id=69]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  23.977 [id=17]	INFO	i.j.p.o.BaseIntegrationTest#beforeClass: beforeClass()
  23.977 [id=17]	INFO	i.j.p.o.BaseIntegrationTest#beforeClass: Wait for jenkins to start...
  24.042 [id=17]	INFO	i.j.p.o.BaseIntegrationTest#beforeClass: Jenkins started
  24.044 [id=17]	INFO	i.j.p.o.BaseIntegrationTest#beforeClass: Initialize OTel with configuration {otel.traces.exporter=testing, otel.imr.export.interval=10ms, otel.metrics.exporter=testing}
  24.194 [id=69]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  24.200 [id=17]	INFO	i.j.p.o.a.ReconfigurableOpenTelemetry#configure: OpenTelemetry initialized: SDK [config: otel.traces.exporter=testing, otel.metrics.exporter=testing, resource: service.name=jenkins, service.namespace=jenkins]
  24.201 [id=17]	INFO	i.j.p.o.s.TraceContextServletFilter#afterConfiguration: Jenkins trace context propagation disabled on inbound HTTP requests (eg. build triggers). To enable it, set the property otel.instrumentation.jenkins.remote.span.enabled to true.
  24.201 [id=17]	INFO	i.j.p.o.BaseIntegrationTest#beforeClass: OTel plugin initialized
  24.245 [id=17]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: Launching slave0…
  25.112 [id=87]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  25.560 [id=75]	INFO	o.j.h.test.SimpleCommandLauncher#launch: agent launched for slave0
  25.562 [id=17]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: …finished launching slave0.
  25.842 [test-SpanContextPropagationSynchronousTestStep-1 #1] Started
  26.116 [id=87]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  26.314 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] Start of Pipeline
  26.524 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] node
  26.631 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepStartNode - node // Allocate node : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), Console Output, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, class org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$QueueItemActionImpl, Workspace, node.parent: FlowStartNode[id=2, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.636 [test-SpanContextPropagationSynchronousTestStep-1 #1] Running on slave0 in C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\j h1941832754063125354\agent-work-dirs\slave0\workspace\test-SpanContextPropagationSynchronousTestStep-1
  26.637 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] {
  26.684 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepStartNode - { // Allocate node : Body : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepStartNode[id=3, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.691 [id=94]	WARNING	i.j.p.o.j.j.GraphListenerAdapterToPipelineListener#fireOnAfterOtherBlockStepStartNode: Exception invoking `onAfterStepStartNode` on TracingPipelineListener{}
java.lang.IllegalStateException: scope to close not found: FlowNode[name: Allocate node : Body : Start, function: {, id: 4] in test-SpanContextPropagationSynchronousTestStep-1 #1
	at io.jenkins.plugins.opentelemetry.job.OtelTraceService.lambda$closeCurrentScope$2(OtelTraceService.java:167)
	at java.base/java.util.Optional.ifPresentOrElse(Optional.java:203)
	at io.jenkins.plugins.opentelemetry.job.OtelTraceService.closeCurrentScope(OtelTraceService.java:164)
	at io.jenkins.plugins.opentelemetry.job.MonitoringPipelineListener.onAfterOtherBlockStepStartNode(MonitoringPipelineListener.java:290)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.fireOnAfterOtherBlockStepStartNode(GraphListenerAdapterToPipelineListener.java:144)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.processPreviousNodes(GraphListenerAdapterToPipelineListener.java:71)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.onNewHead(GraphListenerAdapterToPipelineListener.java:48)
	at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.notifyListeners(CpsFlowExecution.java:1565)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup.notifyNewHead(CpsThreadGroup.java:495)
	at org.jenkinsci.plugins.workflow.cps.FlowHead.setNewHead(FlowHead.java:158)
	at org.jenkinsci.plugins.workflow.cps.DSL.invokeStep(DSL.java:289)
	at org.jenkinsci.plugins.workflow.cps.DSL.invokeMethod(DSL.java:196)
	at org.jenkinsci.plugins.workflow.cps.CpsScript.invokeMethod(CpsScript.java:124)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.codehaus.groovy.reflection.CachedMethod.invoke(CachedMethod.java:98)
	at groovy.lang.MetaMethod.doMethodInvoke(MetaMethod.java:325)
	at groovy.lang.MetaClassImpl.invokeMethod(MetaClassImpl.java:1225)
	at groovy.lang.MetaClassImpl.invokeMethod(MetaClassImpl.java:1034)
	at org.codehaus.groovy.runtime.callsite.PogoMetaClassSite.call(PogoMetaClassSite.java:41)
	at org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:47)
	at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:116)
	at org.kohsuke.groovy.sandbox.impl.Checker$1.call(Checker.java:180)
	at org.kohsuke.groovy.sandbox.GroovyInterceptor.onMethodCall(GroovyInterceptor.java:23)
	at org.jenkinsci.plugins.scriptsecurity.sandbox.groovy.SandboxInterceptor.onMethodCall(SandboxInterceptor.java:163)
	at org.kohsuke.groovy.sandbox.impl.Checker$1.call(Checker.java:178)
	at org.kohsuke.groovy.sandbox.impl.Checker.checkedCall(Checker.java:182)
	at org.kohsuke.groovy.sandbox.impl.Checker.checkedCall(Checker.java:152)
	at com.cloudbees.groovy.cps.sandbox.SandboxInvoker.methodCall(SandboxInvoker.java:17)
	at org.jenkinsci.plugins.workflow.cps.LoggingInvoker.methodCall(LoggingInvoker.java:105)
	at com.cloudbees.groovy.cps.impl.ContinuationGroup.methodCall(ContinuationGroup.java:90)
	at com.cloudbees.groovy.cps.impl.FunctionCallBlock$ContinuationImpl.dispatchOrArg(FunctionCallBlock.java:116)
	at com.cloudbees.groovy.cps.impl.FunctionCallBlock$ContinuationImpl.fixArg(FunctionCallBlock.java:85)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at com.cloudbees.groovy.cps.impl.ContinuationPtr$ContinuationImpl.receive(ContinuationPtr.java:72)
	at com.cloudbees.groovy.cps.impl.ClosureBlock.eval(ClosureBlock.java:46)
	at com.cloudbees.groovy.cps.Next.step(Next.java:83)
	at com.cloudbees.groovy.cps.Continuable.run0(Continuable.java:147)
	at org.jenkinsci.plugins.workflow.cps.SandboxContinuable.access$001(SandboxContinuable.java:17)
	at org.jenkinsci.plugins.workflow.cps.SandboxContinuable.run0(SandboxContinuable.java:49)
	at org.jenkinsci.plugins.workflow.cps.CpsThread.runNextChunk(CpsThread.java:180)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup.run(CpsThreadGroup.java:423)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup$2.call(CpsThreadGroup.java:331)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup$2.call(CpsThreadGroup.java:295)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService.lambda$wrap$4(CpsVmExecutorService.java:136)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at hudson.remoting.SingleLaneExecutorService$1.run(SingleLaneExecutorService.java:139)
	at jenkins.util.ContextResettingExecutorService$1.run(ContextResettingExecutorService.java:28)
	at jenkins.security.ImpersonatingExecutorService$1.run(ImpersonatingExecutorService.java:68)
	at jenkins.util.ErrorLoggingExecutorService.lambda$wrap$0(ErrorLoggingExecutorService.java:51)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService$1.call(CpsVmExecutorService.java:53)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService$1.call(CpsVmExecutorService.java:50)
	at org.codehaus.groovy.runtime.GroovyCategorySupport$ThreadCategoryInfo.use(GroovyCategorySupport.java:136)
	at org.codehaus.groovy.runtime.GroovyCategorySupport.use(GroovyCategorySupport.java:275)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService.lambda$categoryThreadFactory$0(CpsVmExecutorService.java:50)
	at java.base/java.lang.Thread.run(Thread.java:829)
  26.695 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.696 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] stage
  26.701 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.741 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.756 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] { (ze-stage1)
  26.775 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepStartNode - { (ze-stage1) // ze-stage1, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, ze-stage1, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=5, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.797 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOtherBlockStepEndNode - } // Stage : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepAtomNode[id=8, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.815 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] echo
  26.815 [test-SpanContextPropagationSynchronousTestStep-1 #1] hello
  26.815 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] spanContextPropagationSynchronousTestStep
  26.816 [test-SpanContextPropagationSynchronousTestStep-1 #1] io.jenkins.plugins.opentelemetry.job.step.SpanContextPropagationSynchronousTestStep$StepExecution
  26.816 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] }
  26.823 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, node.parent: StepEndNode[id=9, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.830 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, node.parent: StepEndNode[id=9, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.831 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOtherBlockStepEndNode - } // Allocate node : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepEndNode[id=10, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.851 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onAfterOtherBlockStepEndNode - } // Allocate node : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepEndNode[id=10, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.851 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-SpanContextPropagationSynchronousTestStep-1 #1 - onOtherBlockStepEndNode - // node // Allocate node : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), Timing, node.parent: StepEndNode[id=11, exec=CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]], thread: Running CpsFlowExecution[Owner[test-SpanContextPropagationSynchronousTestStep-1/1:test-SpanContextPropagationSynchronousTestStep-1 #1]]
  26.877 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] // stage
  26.877 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] }
  26.877 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] // node
  26.877 [test-SpanContextPropagationSynchronousTestStep-1 #1] [Pipeline] End of Pipeline
  27.004 [test-SpanContextPropagationSynchronousTestStep-1 #1] Finished: SUCCESS
Standard out
=== Starting io.jenkins.plugins.opentelemetry.JenkinsOtelPluginIntegrationTest
class io.jenkins.plugins.opentelemetry.job.step.SpanContextPropagationSynchronousTestStep -> []
class org.jenkinsci.plugins.workflow.steps.EchoStep -> []
class org.jenkinsci.plugins.workflow.steps.EchoStep$DescriptorImpl -> [org.jenkinsci.plugins.workflow.steps.EchoStep$DescriptorImpl@64f02e66]
$ "C:\tools\jdk-11/bin/java"  -Djava.awt.headless=true -Xmx512m -XX:+PrintCommandLineFlags -jar "C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\jenkins-for-test\WEB-INF\lib\remoting-3206.vb_15dcf73f6a_9.jar"
-XX:G1ConcRefinementThreads=4 -XX:GCDrainStackTargetSize=64 -XX:InitialHeapSize=268417088 -XX:MaxHeapSize=536870912 -XX:+PrintCommandLineFlags -XX:ReservedCodeCacheSize=251658240 -XX:+SegmentedCodeCache -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseLargePagesIndividualAllocation 
<===[JENKINS REMOTING CAPACITY]===>&amp#0;&amp#0;&amp#0;channel started
Remoting version: 3206.vb_15dcf73f6a_9
Launcher: SimpleCommandLauncher
Communication Protocol: Standard in/out
This is a Windows agent
## TREE VIEW OF SPANS ## 
Stage: ze-stage1, function: stage, name: ze-stage1, node.id: 6
   |
   |- spanContextPropagationSynchronousTestStep, function: spanContextPropagationSynchronousTestStep, name: spanContextPropagationSynchronousTestStep, node.id: 8
       |
       |- SpanContextPropagationTestStep.execution
BUILD test-SpanContextPropagationSynchronousTestStep-1
   |
   |- Phase: Start
   |
   |- Phase: Run
   |   |
   |   |- Agent, function: node, name: agent, node.id: 3
   |       |
   |       |- Agent Allocation, function: node, name: agent.allocate, node.id: 3
   |
   |- Phase: Finalise

io.jenkins.plugins.opentelemetry.JenkinsOtelPluginIntegrationTest.testPipelineWithError

No value present
Stack trace
java.util.NoSuchElementException: No value present
	at java.base/java.util.Optional.get(Optional.java:148)
	at io.jenkins.plugins.opentelemetry.BaseIntegrationTest.checkChainOfSpans(BaseIntegrationTest.java:146)
	at io.jenkins.plugins.opentelemetry.JenkinsOtelPluginIntegrationTest.testPipelineWithError(JenkinsOtelPluginIntegrationTest.java:292)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:655)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.lang.Thread.run(Thread.java:829)
Standard error
27.114 [id=17]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: Launching slave1…
  27.121 [id=87]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  28.054 [id=85]	INFO	o.j.h.test.SimpleCommandLauncher#launch: agent launched for slave1
  28.056 [id=17]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: …finished launching slave1.
  28.113 [test-pipeline-with-error-2 #1] Started
  28.125 [id=87]	WARNING	i.o.s.internal.ThrottlingLogger#doLog: Failed to export logs. Server responded with gRPC status code 2. Error message: Failed to connect to localhost/0:0:0:0:0:0:0:1:4317
  28.165 [test-pipeline-with-error-2 #1] [Pipeline] Start of Pipeline
  28.166 [test-pipeline-with-error-2 #1] [Pipeline] node
  28.183 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - node // Allocate node : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), Console Output, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, class org.jenkinsci.plugins.workflow.support.steps.ExecutorStepExecution$QueueItemActionImpl, Workspace, node.parent: FlowStartNode[id=2, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.206 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - { // Allocate node : Body : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepStartNode[id=3, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.207 [id=95]	WARNING	i.j.p.o.j.j.GraphListenerAdapterToPipelineListener#fireOnAfterOtherBlockStepStartNode: Exception invoking `onAfterStepStartNode` on TracingPipelineListener{}
java.lang.IllegalStateException: scope to close not found: FlowNode[name: Allocate node : Body : Start, function: {, id: 4] in test-pipeline-with-error-2 #1
	at io.jenkins.plugins.opentelemetry.job.OtelTraceService.lambda$closeCurrentScope$2(OtelTraceService.java:167)
	at java.base/java.util.Optional.ifPresentOrElse(Optional.java:203)
	at io.jenkins.plugins.opentelemetry.job.OtelTraceService.closeCurrentScope(OtelTraceService.java:164)
	at io.jenkins.plugins.opentelemetry.job.MonitoringPipelineListener.onAfterOtherBlockStepStartNode(MonitoringPipelineListener.java:290)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.fireOnAfterOtherBlockStepStartNode(GraphListenerAdapterToPipelineListener.java:144)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.processPreviousNodes(GraphListenerAdapterToPipelineListener.java:71)
	at io.jenkins.plugins.opentelemetry.job.jenkins.GraphListenerAdapterToPipelineListener.onNewHead(GraphListenerAdapterToPipelineListener.java:48)
	at org.jenkinsci.plugins.workflow.cps.CpsFlowExecution.notifyListeners(CpsFlowExecution.java:1565)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup.notifyNewHead(CpsThreadGroup.java:495)
	at org.jenkinsci.plugins.workflow.cps.FlowHead.setNewHead(FlowHead.java:158)
	at org.jenkinsci.plugins.workflow.cps.DSL.invokeStep(DSL.java:289)
	at org.jenkinsci.plugins.workflow.cps.DSL.invokeMethod(DSL.java:196)
	at org.jenkinsci.plugins.workflow.cps.CpsScript.invokeMethod(CpsScript.java:124)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.codehaus.groovy.reflection.CachedMethod.invoke(CachedMethod.java:98)
	at groovy.lang.MetaMethod.doMethodInvoke(MetaMethod.java:325)
	at groovy.lang.MetaClassImpl.invokeMethod(MetaClassImpl.java:1225)
	at groovy.lang.MetaClassImpl.invokeMethod(MetaClassImpl.java:1034)
	at org.codehaus.groovy.runtime.callsite.PogoMetaClassSite.call(PogoMetaClassSite.java:41)
	at org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:47)
	at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:116)
	at org.kohsuke.groovy.sandbox.impl.Checker$1.call(Checker.java:180)
	at org.kohsuke.groovy.sandbox.GroovyInterceptor.onMethodCall(GroovyInterceptor.java:23)
	at org.jenkinsci.plugins.scriptsecurity.sandbox.groovy.SandboxInterceptor.onMethodCall(SandboxInterceptor.java:163)
	at org.kohsuke.groovy.sandbox.impl.Checker$1.call(Checker.java:178)
	at org.kohsuke.groovy.sandbox.impl.Checker.checkedCall(Checker.java:182)
	at org.kohsuke.groovy.sandbox.impl.Checker.checkedCall(Checker.java:152)
	at com.cloudbees.groovy.cps.sandbox.SandboxInvoker.methodCall(SandboxInvoker.java:17)
	at org.jenkinsci.plugins.workflow.cps.LoggingInvoker.methodCall(LoggingInvoker.java:105)
	at com.cloudbees.groovy.cps.impl.ContinuationGroup.methodCall(ContinuationGroup.java:90)
	at com.cloudbees.groovy.cps.impl.FunctionCallBlock$ContinuationImpl.dispatchOrArg(FunctionCallBlock.java:116)
	at com.cloudbees.groovy.cps.impl.FunctionCallBlock$ContinuationImpl.fixArg(FunctionCallBlock.java:85)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at com.cloudbees.groovy.cps.impl.ContinuationPtr$ContinuationImpl.receive(ContinuationPtr.java:72)
	at com.cloudbees.groovy.cps.impl.ClosureBlock.eval(ClosureBlock.java:46)
	at com.cloudbees.groovy.cps.Next.step(Next.java:83)
	at com.cloudbees.groovy.cps.Continuable.run0(Continuable.java:147)
	at org.jenkinsci.plugins.workflow.cps.SandboxContinuable.access$001(SandboxContinuable.java:17)
	at org.jenkinsci.plugins.workflow.cps.SandboxContinuable.run0(SandboxContinuable.java:49)
	at org.jenkinsci.plugins.workflow.cps.CpsThread.runNextChunk(CpsThread.java:180)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup.run(CpsThreadGroup.java:423)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup$2.call(CpsThreadGroup.java:331)
	at org.jenkinsci.plugins.workflow.cps.CpsThreadGroup$2.call(CpsThreadGroup.java:295)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService.lambda$wrap$4(CpsVmExecutorService.java:136)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at hudson.remoting.SingleLaneExecutorService$1.run(SingleLaneExecutorService.java:139)
	at jenkins.util.ContextResettingExecutorService$1.run(ContextResettingExecutorService.java:28)
	at jenkins.security.ImpersonatingExecutorService$1.run(ImpersonatingExecutorService.java:68)
	at jenkins.util.ErrorLoggingExecutorService.lambda$wrap$0(ErrorLoggingExecutorService.java:51)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService$1.call(CpsVmExecutorService.java:53)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService$1.call(CpsVmExecutorService.java:50)
	at org.codehaus.groovy.runtime.GroovyCategorySupport$ThreadCategoryInfo.use(GroovyCategorySupport.java:136)
	at org.codehaus.groovy.runtime.GroovyCategorySupport.use(GroovyCategorySupport.java:275)
	at org.jenkinsci.plugins.workflow.cps.CpsVmExecutorService.lambda$categoryThreadFactory$0(CpsVmExecutorService.java:50)
	at java.base/java.lang.Thread.run(Thread.java:829)
  28.209 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.213 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.225 [test-pipeline-with-error-2 #1] Running on Jenkins in C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\j h1941832754063125354\workspace\test-pipeline-with-error-2
  28.225 [test-pipeline-with-error-2 #1] [Pipeline] {
  28.225 [test-pipeline-with-error-2 #1] [Pipeline] stage
  28.244 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=4, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.264 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - { (ze-stage1) // ze-stage1, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, ze-stage1, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=5, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.289 [test-pipeline-with-error-2 #1] [Pipeline] { (ze-stage1)
  28.289 [test-pipeline-with-error-2 #1] [Pipeline] isUnix
  28.350 [test-pipeline-with-error-2 #1] [Pipeline] bat
  28.435 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - } // Stage : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepAtomNode[id=8, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.450 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, node.parent: StepEndNode[id=9, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.462 [test-pipeline-with-error-2 #1] 
  28.462 [test-pipeline-with-error-2 #1] C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\j h1941832754063125354\workspace\test-pipeline-with-error-2>echo ze-echo-1 
  28.462 [test-pipeline-with-error-2 #1] ze-echo-1
  28.462 [test-pipeline-with-error-2 #1] [Pipeline] }
  28.462 [test-pipeline-with-error-2 #1] [Pipeline] // stage
  28.465 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, node.parent: StepEndNode[id=9, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.465 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, node.parent: StepEndNode[id=10, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.473 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOnOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepEndNode[id=10, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.478 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - stage // Stage : Start, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Console Output, class org.jenkinsci.plugins.workflow.cps.actions.ArgumentsActionImpl, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepEndNode[id=10, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.499 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepStartNode - { (ze-stage2) // ze-stage2, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, ze-stage2, Timing, class io.jenkins.plugins.opentelemetry.job.action.FlowNodeMonitoringAction, node.parent: StepStartNode[id=11, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.519 [test-pipeline-with-error-2 #1] [Pipeline] stage
  28.519 [test-pipeline-with-error-2 #1] [Pipeline] { (ze-stage2)
  28.519 [test-pipeline-with-error-2 #1] [Pipeline] isUnix
  28.519 [test-pipeline-with-error-2 #1] [Pipeline] bat
  28.659 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - } // Stage : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepAtomNode[id=15, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.676 [test-pipeline-with-error-2 #1] 
  28.676 [test-pipeline-with-error-2 #1] C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\tmp\j h1941832754063125354\workspace\test-pipeline-with-error-2>echo ze-echo-2 
  28.676 [test-pipeline-with-error-2 #1] ze-echo-2
  28.676 [test-pipeline-with-error-2 #1] [Pipeline] error
  28.676 [test-pipeline-with-error-2 #1] [Pipeline] }
  28.678 [id=95]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, node.parent: StepEndNode[id=16, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.688 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepEndNode - // stage // Stage : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.StageStep$DescriptorImpl, stage), Timing, ze-pipeline-error, node.parent: StepEndNode[id=16, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.688 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - } // Allocate node : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, node.parent: StepEndNode[id=17, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.711 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onAfterOtherBlockStepEndNode - } // Allocate node : Body : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), class org.jenkinsci.plugins.workflow.actions.BodyInvocationAction, Timing, ze-pipeline-error, node.parent: StepEndNode[id=17, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.712 [id=94]	INFO	i.j.p.o.j.MonitoringPipelineListener#debug: test-pipeline-with-error-2 #1 - onOtherBlockStepEndNode - // node // Allocate node : End, descriptor (class:org.jenkinsci.plugins.workflow.support.steps.ExecutorStep$DescriptorImpl, node), Timing, node.parent: StepEndNode[id=18, exec=CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]], thread: Running CpsFlowExecution[Owner[test-pipeline-with-error-2/1:test-pipeline-with-error-2 #1]]
  28.733 [test-pipeline-with-error-2 #1] [Pipeline] // stage
  28.734 [test-pipeline-with-error-2 #1] [Pipeline] }
  28.734 [test-pipeline-with-error-2 #1] [Pipeline] // node
  28.778 [test-pipeline-with-error-2 #1] [Pipeline] End of Pipeline
  28.779 [test-pipeline-with-error-2 #1] ERROR: ze-pipeline-error
  28.779 [test-pipeline-with-error-2 #1] Finished: FAILURE
Standard out
$ "C:\tools\jdk-11/bin/java"  -Djava.awt.headless=true -Xmx512m -XX:+PrintCommandLineFlags -jar "C:\Jenkins\agent\workspace\gins_opentelemetry-plugin_PR-909\target\jenkins-for-test\WEB-INF\lib\remoting-3206.vb_15dcf73f6a_9.jar"
-XX:G1ConcRefinementThreads=4 -XX:GCDrainStackTargetSize=64 -XX:InitialHeapSize=268417088 -XX:MaxHeapSize=536870912 -XX:+PrintCommandLineFlags -XX:ReservedCodeCacheSize=251658240 -XX:+SegmentedCodeCache -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC -XX:-UseLargePagesIndividualAllocation 
<===[JENKINS REMOTING CAPACITY]===>&amp#0;&amp#0;&amp#0;channel started
Remoting version: 3206.vb_15dcf73f6a_9
Launcher: SimpleCommandLauncher
Communication Protocol: Standard in/out
This is a Windows agent
## TREE VIEW OF SPANS ## 
Stage: ze-stage1, function: stage, name: ze-stage1, node.id: 6
   |
   |- shell-1, function: bat, name: Windows Batch Script, node.id: 8
Stage: ze-stage2, function: stage, name: ze-stage2, node.id: 12
   |
   |- shell-2, function: bat, name: Windows Batch Script, node.id: 14
   |
   |- error, function: error, name: Error signal, node.id: 15
BUILD test-pipeline-with-error-2
   |
   |- Phase: Start
   |
   |- Phase: Run
   |   |
   |   |- Agent, function: node, name: agent, node.id: 3
   |       |
   |       |- Agent Allocation, function: node, name: agent.allocate, node.id: 3
   |
   |- Phase: Finalise

more test results are not shown here, view them on Jenkins