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.

Sign up for GitHub

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

Overhaul of SlaveLaunchLogs #517

Merged
merged 25 commits into from
Mar 18, 2024

Setting a timestamp, switching category

154adca
Select commit
Loading
Failed to load commit list.
Merged

Overhaul of SlaveLaunchLogs #517

Setting a timestamp, switching category
154adca
Select commit
Loading
Failed to load commit list.
ci.jenkins.io / Tests / linux-11 / Build (linux-11) failed Mar 1, 2024 in 0s

failed: 2, skipped: 5, passed: 219

Send us feedback

Details

com.cloudbees.jenkins.support.Security2186Test.secretsFilterWhenSystemPropertyContainsPasswordThenValueRedacted

entry
Stack trace 
java.lang.NullPointerException: entry
	at java.base/java.util.Objects.requireNonNull(Objects.java:248)
	at java.base/java.util.zip.ZipFile.getInputStream(ZipFile.java:382)
	at com.cloudbees.jenkins.support.Security2186Test.verifyFileIfContainsPassword(Security2186Test.java:87)
	at com.cloudbees.jenkins.support.Security2186Test.secretsFilterWhenSystemPropertyContainsPasswordThenValueRedacted(Security2186Test.java:78)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:656)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.lang.Thread.run(Thread.java:829)
Standard error 
0.170 [id=19]	INFO	o.jvnet.hudson.test.WarExploder#explode: Picking up existing exploded jenkins.war at /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/jenkins-for-test
   0.595 [id=19]	INFO	o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:35405/jenkins/
   1.086 [id=33]	INFO	jenkins.InitReactorRunner$1#onAttained: Started initialization
   1.311 [id=38]	INFO	hudson.PluginManager#considerDetachedPlugin: Loading a detached plugin as a dependency: /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/jenkins5305901556931861020/plugins/javax-mail-api.jpi
   1.833 [id=33]	INFO	jenkins.InitReactorRunner$1#onAttained: Listed all plugins
   1.864 [id=35]	INFO	j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h12671995089874796175/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
   3.899 [id=37]	INFO	jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
   3.912 [id=34]	INFO	jenkins.InitReactorRunner$1#onAttained: Started all plugins
   3.914 [id=37]	INFO	jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
   5.131 [id=32]	INFO	jenkins.InitReactorRunner$1#onAttained: System config loaded
   5.549 [id=36]	INFO	jenkins.InitReactorRunner$1#onAttained: System config adapted
   5.549 [id=36]	INFO	jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
   5.562 [id=33]	INFO	jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
   5.849 [id=38]	INFO	jenkins.InitReactorRunner$1#onAttained: Completed initialization
   5.961 [id=19]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: Launching slave0…
   6.822 [id=54]	INFO	o.j.h.test.SimpleCommandLauncher#launch: agent launched for slave0
   6.823 [id=19]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: …finished launching slave0.
   7.598 [id=19]	INFO	hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
   7.954 [id=19]	INFO	hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
   8.013 [id=19]	INFO	o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h12671995089874796175
Standard out 
=== Starting secretsFilterWhenSystemPropertyContainsPasswordThenValueRedacted(com.cloudbees.jenkins.support.Security2186Test)
$ "/opt/jdk-11/bin/java" -Djava.awt.headless=true -Dtest2186.trustStoreAgentPassword=mySecret -jar "/home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/jenkins-for-test/WEB-INF/lib/remoting-3044.vb_940a_a_e4f72e.jar"
<===[JENKINS REMOTING CAPACITY]===>&amp#0;&amp#0;&amp#0;channel started
Remoting version: 3044.vb_940a_a_e4f72e
Launcher: SimpleCommandLauncher
Communication Protocol: Standard in/out
This is a Unix agent

com.cloudbees.jenkins.support.impl.SlaveLaunchLogsTest.onlineInboundAgent

reflects DefaultJnlpSlaveReceiver.beforeChannel & SlaveComputer.setChannel
Expected: (not null and a string containing "Inbound agent connected from" and a string containing "Communication Protocol: JNLP4-connect")
     but: a string containing "Inbound agent connected from" was ""
Stack trace 
java.lang.AssertionError: 
reflects DefaultJnlpSlaveReceiver.beforeChannel & SlaveComputer.setChannel
Expected: (not null and a string containing "Inbound agent connected from" and a string containing "Communication Protocol: JNLP4-connect")
     but: a string containing "Inbound agent connected from" was ""
	at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
	at com.cloudbees.jenkins.support.impl.SlaveLaunchLogsTest.onlineInboundAgent(SlaveLaunchLogsTest.java:56)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.jvnet.hudson.test.JenkinsRule$1.evaluate(JenkinsRule.java:656)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.lang.Thread.run(Thread.java:829)
Standard error 
0.009 [id=172]	INFO	o.jvnet.hudson.test.JenkinsRule#createWebServer: Running on http://localhost:46233/jenkins/
   0.024 [id=185]	INFO	jenkins.InitReactorRunner$1#onAttained: Started initialization
   0.024 [id=186]	INFO	jenkins.InitReactorRunner$1#onAttained: Listed all plugins
   0.026 [id=190]	INFO	j.b.api.BouncyCastlePlugin#start: /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/plugins/bouncycastle-api/WEB-INF/optional-lib not found; for non RealJenkinsRule this is fine and can be ignored.
   0.135 [id=190]	INFO	jenkins.InitReactorRunner$1#onAttained: Prepared all plugins
   0.137 [id=190]	INFO	jenkins.InitReactorRunner$1#onAttained: Started all plugins
   0.137 [id=187]	INFO	jenkins.InitReactorRunner$1#onAttained: Augmented all extensions
   0.621 [id=190]	INFO	jenkins.InitReactorRunner$1#onAttained: System config loaded
   0.637 [id=187]	INFO	jenkins.InitReactorRunner$1#onAttained: System config adapted
   0.638 [id=186]	INFO	jenkins.InitReactorRunner$1#onAttained: Loaded all jobs
   0.638 [id=189]	INFO	jenkins.InitReactorRunner$1#onAttained: Configuration for all jobs updated
   0.643 [id=186]	INFO	jenkins.InitReactorRunner$1#onAttained: Completed initialization
   0.670 [id=172]	INFO	o.j.hudson.test.InboundAgentRule#start: Running: [/opt/jdk-11/bin/java, -Xmx512m, -XX:+PrintCommandLineFlags, -Djava.awt.headless=true, -jar, /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/agent.jar, -jnlpUrl, http://localhost:46233/jenkins/computer/remote/slave-agent.jnlp, -workDir, /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/agent-work-dirs/remote]
   0.672 [id=172]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: Waiting for remote to come online…
-XX:G1ConcRefinementThreads=4 -XX:GCDrainStackTargetSize=64 -XX:InitialHeapSize=125000000 -XX:MaxHeapSize=536870912 -XX:+PrintCommandLineFlags -XX:ReservedCodeCacheSize=251658240 -XX:+SegmentedCodeCache -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseG1GC 
Mar 01, 2024 11:43:05 PM org.jenkinsci.remoting.engine.WorkDirManager initializeWorkDir
INFO: Using /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/agent-work-dirs/remote/remoting as a remoting work directory
Mar 01, 2024 11:43:05 PM org.jenkinsci.remoting.engine.WorkDirManager setupLogging
INFO: Both error and output logs will be printed to /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/agent-work-dirs/remote/remoting
Mar 01, 2024 11:43:05 PM hudson.remoting.jnlp.Main createEngine
INFO: Setting up agent: remote
Mar 01, 2024 11:43:05 PM hudson.remoting.Engine startEngine
INFO: Using Remoting version: 3044.vb_940a_a_e4f72e
Mar 01, 2024 11:43:05 PM org.jenkinsci.remoting.engine.WorkDirManager initializeWorkDir
INFO: Using /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616/agent-work-dirs/remote/remoting as a remoting work directory
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Locating server among [http://localhost:46233/jenkins/]
Mar 01, 2024 11:43:06 PM org.jenkinsci.remoting.engine.JnlpAgentEndpointResolver resolve
INFO: Remoting server accepts the following protocols: [JNLP4-connect, Ping]
   2.104 [id=211]	INFO	h.TcpSlaveAgentListener$ConnectionHandler#run: Connection #4 failed: java.io.EOFException
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Agent discovery successful
  Agent address: localhost
  Agent port:    33219
  Identity:      ee:e8:e6:dc:80:54:7a:1f:2a:0d:ff:64:c9:06:6a:f4
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Handshaking
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Connecting to localhost:33219
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Trying protocol: JNLP4-connect
Mar 01, 2024 11:43:06 PM org.jenkinsci.remoting.protocol.impl.BIONetworkLayer$Reader run
INFO: Waiting for ProtocolStack to start.
   2.140 [id=212]	INFO	h.TcpSlaveAgentListener$ConnectionHandler#run: Accepted JNLP4-connect connection #5 from /127.0.0.1:59872
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Remote identity confirmed: ee:e8:e6:dc:80:54:7a:1f:2a:0d:ff:64:c9:06:6a:f4
Mar 01, 2024 11:43:06 PM hudson.remoting.jnlp.Main$CuiListener status
INFO: Connected
   3.276 [id=172]	INFO	o.jvnet.hudson.test.JenkinsRule#waitOnline: …remote is now online.
   3.289 [id=76]	INFO	j.s.DefaultJnlpSlaveReceiver#channelClosed: IOHub#4: Worker[channel:java.nio.channels.SocketChannel[connected local=/127.0.0.1:33219 remote=localhost/127.0.0.1:59872]] / Computer.threadPoolForRemoting [#6] for remote terminated: java.nio.channels.ClosedChannelException
   3.292 [id=73]	INFO	hudson.remoting.Request$2#run: Failed to send back a reply to the request UserRequest:UserRPCRequest:hudson.remoting.JarLoader.writeJarTo[long,long,java.io.OutputStream](3): hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@5ed3fdf7:JNLP4-connect connection from localhost/127.0.0.1:59872": channel is already closed
   3.293 [id=172]	INFO	hudson.lifecycle.Lifecycle#onStatusUpdate: Stopping Jenkins
   3.303 [id=214]	INFO	hudson.remoting.Request$2#run: Failed to send back a reply to the request RPCRequest:hudson.remoting.RemoteClassLoader$IClassLoader.fetch3[java.lang.String](2): hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@5ed3fdf7:JNLP4-connect connection from localhost/127.0.0.1:59872": channel is already closed
   3.306 [id=172]	INFO	hudson.lifecycle.Lifecycle#onStatusUpdate: Jenkins stopped
   3.363 [id=172]	INFO	o.j.h.t.TemporaryDirectoryAllocator#dispose: deleting /home/jenkins/agent/workspace/ugins_support-core-plugin_PR-517/target/tmp/j h3350525728623599616
Standard out 
=== Starting onlineInboundAgent(com.cloudbees.jenkins.support.impl.SlaveLaunchLogsTest)
View more details on ci.jenkins.io