See <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/91/display/redirect?page=changes>
Changes: [Philippe Mouawad] fix failure due to jars check ------------------------------------------ [...truncated 326.35 KB...] Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 3 in 00:00:02 = 1.3/s Avg: 345 Min: 16 Max: 1002 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:31:44 UTC 2020 (1600810304064) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/OS_TESTS.log> (the file is empty) > Task :src:dist-check:batchResponseDecompression Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/ResponseDecompression.jmx> Starting standalone test @ Tue Sep 22 21:31:46 UTC 2020 (1600810306293) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 2 in 00:00:02 = 1.2/s Avg: 411 Min: 374 Max: 449 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:31:48 UTC 2020 (1600810308545) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/ResponseDecompression.log> (the file is empty) [server] Created remote object: UnicastServerRef2 [liveRef: [endpoint:[asf940.gq1.ygridcore.net:46723,SSLRMIServerSocketFactory(host=asf940.gq1.ygridcore.net/67.195.81.165, keyStoreLocation=rmi_keystore.jks, type=JKS, trustStoreLocation=rmi_keystore.jks, type=JKS, alias=rmi),SSLRMIClientSocketFactory(keyStoreLocation=rmi_keystore.jks, type=JKS, trustStoreLocation=rmi_keystore.jks, type=JKS, alias=rmi)](local),objID:[38c5a76f:174b7badaf9:-7fff, -4464281284563437914]]][server] > Task :src:dist-check:batchServerBatchTestLocal Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/BatchTestLocal.jmx> Configuring remote engine: asf940.gq1.ygridcore.net:37197 Starting distributed test with remote engines: [asf940.gq1.ygridcore.net:37197] @ Tue Sep 22 21:31:53 UTC 2020 (1600810313925) [server] Starting the test on host asf940.gq1.ygridcore.net:37197 @ Tue Sep 22 21:31:57 UTC 2020 (1600810317176) > Task :src:dist-check:batchServerBatchTestLocal Remote engines have been started:[asf940.gq1.ygridcore.net:37197] Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary + 55 in 00:00:05 = 10.4/s Avg: 4 Min: 1 Max: 8 Err: 8 (14.55%) Active: 1 Started: 3 Finished: 2 summary + 77 in 00:00:02 = 44.9/s Avg: 4 Min: 1 Max: 69 Err: 8 (10.39%) Active: 0 Started: 11 Finished: 11 summary = 132 in 00:00:07 = 18.9/s Avg: 4 Min: 1 Max: 69 Err: 16 (12.12%) Tidying up remote @ Tue Sep 22 21:32:04 UTC 2020 (1600810324770) [server] Finished the test on host asf940.gq1.ygridcore.net:37197 @ Tue Sep 22 21:32:04 UTC 2020 (1600810324771) - exit requested.[server] > Task :src:dist-check:batchServerBatchTestLocal ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/BatchTestLocal.log> (the file is empty) No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/BatchTestLocalServer.log> (the file is empty) > Task :src:dist-check:batchSlowCharsFeatureHttpClient4 SKIPPED > Task :src:dist-check:batchSlowCharsFeatureJava SKIPPED > Task :src:dist-check:batchTCP_TESTS SKIPPED > Task :src:dist-check:batchTEST_HTTPHttpClient4 Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TEST_HTTP.jmx> Starting standalone test @ Tue Sep 22 21:32:12 UTC 2020 (1600810332503) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 22 in 00:00:02 = 12.2/s Avg: 53 Min: 1 Max: 938 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:14 UTC 2020 (1600810334796) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TEST_HTTP.log> (the file is empty) > Task :src:dist-check:batchTEST_HTTPJava Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TEST_HTTP.jmx> Starting standalone test @ Tue Sep 22 21:32:18 UTC 2020 (1600810338485) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 20 in 00:00:02 = 11.5/s Avg: 60 Min: 1 Max: 1013 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:20 UTC 2020 (1600810340717) ... end of run WARNING: the task was configured to ignore errors in the output log Logfile contents (errors during the test, see <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TEST_HTTP.log)>: 2020-09-22 21:32:20,476 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException: Server redirected too many times (20) 2020-09-22 21:32:20,480 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException: Server redirected too many times (20) 2020-09-22 21:32:20,480 ERROR o.a.j.p.h.c.HttpMirrorThread: Invalid request received:'' > Task :src:dist-check:batchTEST_HTTPS Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TEST_HTTPS.jmx> Starting standalone test @ Tue Sep 22 21:32:23 UTC 2020 (1600810343964) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 2 in 00:00:02 = 0.9/s Avg: 907 Min: 764 Max: 1051 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:26 UTC 2020 (1600810346684) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TEST_HTTPS.log> (the file is empty) > Task :src:dist-check:batchTestCookieManager Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestCookieManager.jmx> Starting standalone test @ Tue Sep 22 21:32:29 UTC 2020 (1600810349092) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary + 1 in 00:00:01 = 0.9/s Avg: 1012 Min: 1012 Max: 1012 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 summary + 9 in 00:00:01 = 13.6/s Avg: 36 Min: 1 Max: 175 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1 summary = 10 in 00:00:02 = 5.8/s Avg: 134 Min: 1 Max: 1012 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:31 UTC 2020 (1600810351728) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestCookieManager.log> (the file is empty) > Task :src:dist-check:batchTestHeaderManagerHttpClient4 Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestHeaderManager.jmx> Starting standalone test @ Tue Sep 22 21:32:35 UTC 2020 (1600810355018) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary + 1 in 00:00:00 = 2.7/s Avg: 39 Min: 39 Max: 39 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 summary + 2 in 00:00:00 = 100.0/s Avg: 1 Min: 1 Max: 2 Err: 0 (0.00%) Active: 0 Started: 2 Finished: 2 summary = 3 in 00:00:00 = 7.6/s Avg: 14 Min: 1 Max: 39 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:36 UTC 2020 (1600810356016) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestHeaderManager.log> (the file is empty) > Task :src:dist-check:batchTestHeaderManagerJava Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestHeaderManager.jmx> Starting standalone test @ Tue Sep 22 21:32:38 UTC 2020 (1600810358379) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 3 in 00:00:00 = 14.5/s Avg: 5 Min: 1 Max: 13 Err: 0 (0.00%) Tidying up ... @ Tue Sep 22 21:32:39 UTC 2020 (1600810359149) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestHeaderManager.log> (the file is empty) > Task :src:dist-check:batchTestKeepAlive SKIPPED > Task :src:dist-check:batchTestRedirectionPolicies SKIPPED > Task :src:dist-check:batchTestResultStatusAction Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestResultStatusAction.jmx> Starting standalone test @ Tue Sep 22 21:32:41 UTC 2020 (1600810361485) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 135 in 00:00:01 = 104.7/s Avg: 1 Min: 0 Max: 181 Err: 18 (13.33%) Tidying up ... @ Tue Sep 22 21:32:43 UTC 2020 (1600810363686) ... end of run No errors present in the logfile <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestResultStatusAction.log> (the file is empty) > Task :src:dist-check:batchTestSchedulerWithTimer Creating summariser <summary> Created the tree successfully using <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestSchedulerWithTimer.jmx> Starting standalone test @ Tue Sep 22 21:32:46 UTC 2020 (1600810366023) Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445 summary = 5 in 00:00:07 = 0.7/s Avg: 442 Min: 2 Max: 1237 Err: 1 (20.00%) Tidying up ... @ Tue Sep 22 21:32:54 UTC 2020 (1600810374299) ... end of run ERROR: unexpected output for TestSchedulerWithTimer.csv: - expected 57 bytes, <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestSchedulerWithTimer.csv> + actual 58 bytes, <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestSchedulerWithTimer.csv> @@ -1 +1 @@ -JSRCheckDuration,200,tearDown Thread Group 1-1,text,true +JSRCheckDuration,200,tearDown Thread Group 1-1,text,false ERROR: unexpected output for TestSchedulerWithTimer.xml: - expected 143 bytes, <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestSchedulerWithTimer.xml> + actual 144 bytes, <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestSchedulerWithTimer.xml> @@ -1,5 +1,5 @@ <?xml version="1.0" encoding="UTF-8"?> <testResults version="1.2"> -<sample s="true" lb="JSRCheckDuration" rc="200" dt="text"/> +<sample s="false" lb="JSRCheckDuration" rc="200" dt="text"/> </testResults> Logfile contents (errors during the test, see <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/TestSchedulerWithTimer.log)>: 2020-09-22 21:32:54,247 WARN o.a.j.p.j.s.J.JSRCheckDuration: Duration 6140 exceeded expected duration of 6000 > Task :src:dist-check:batchTestSchedulerWithTimer FAILED checksum-dependency elapsed time: 119811ms, configurations processed: 387 SHA-512 computation time: 12010ms (goes in parallel, it might exceed wall-clock time), files processed: 40, processed: 11MiB, skipped: 3393MiB PGP signature resolution time: 14093ms (wall-clock), resolution requests: 231, signatures resolved: 265 PGP key resolution time: 83033ms (wall-clock), resolution requests: 231, download time: 0ms (goes in parallel, it might exceed wall-clock time), keys downloaded: 0 PGP signature verification time: 126798ms (goes in parallel, it might exceed wall-clock time), files processed: 770, processed: 836MiB, skipped: 2543MiB Build [0;1mjmeter [0;1;31mFAILURE[0;1m[0m reason: Execution [0;1;31mfailed[0m for task '[0;1m:src:dist-check:batchTestSchedulerWithTimer[0m': Failures detected while testing <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestSchedulerWithTimer.jmx>: [unexpected output TestSchedulerWithTimer.csv, unexpected output TestSchedulerWithTimer.xml, errors in TestSchedulerWithTimer.log] at org.apache.jmeter.buildtools.batchtest.BatchTest.exec(BatchTest.kt:184) [0;0;90mat org.gradle.internal.reflect.JavaMethod.invoke(JavaMethod.java:104) [0m [0;0;90mat org.gradle.api.internal.project.taskfactory.StandardTaskAction.doExecute(StandardTaskAction.java:58) [0m [0;0;90mat org.gradle.api.internal.project.taskfactory.StandardTaskAction.execute(StandardTaskAction.java:51) [0m [0;0;90mat org.gradle.api.internal.project.taskfactory.StandardTaskAction.execute(StandardTaskAction.java:29) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter$3.run(ExecuteActionsTaskExecuter.java:570) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor$RunnableBuildOperationWorker.execute(DefaultBuildOperationExecutor.java:395) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor$RunnableBuildOperationWorker.execute(DefaultBuildOperationExecutor.java:387) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor$1.execute(DefaultBuildOperationExecutor.java:157) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor.execute(DefaultBuildOperationExecutor.java:242) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor.execute(DefaultBuildOperationExecutor.java:150) [0m [0;0;90mat org.gradle.internal.operations.DefaultBuildOperationExecutor.run(DefaultBuildOperationExecutor.java:84) [0m [0;0;90mat org.gradle.internal.operations.DelegatingBuildOperationExecutor.run(DelegatingBuildOperationExecutor.java:31) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter.executeAction(ExecuteActionsTaskExecuter.java:555) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter.executeActions(ExecuteActionsTaskExecuter.java:538) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter.access$300(ExecuteActionsTaskExecuter.java:109) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter$TaskExecution.executeWithPreviousOutputFiles(ExecuteActionsTaskExecuter.java:279) [0m [0;0;90mat org.gradle.api.internal.tasks.execution.ExecuteActionsTaskExecuter$TaskExecution.execute(ExecuteActionsTaskExecuter.java:268) [0m [0;0;90mat org.gradle.internal.execution.steps.ExecuteStep.lambda$execute$1(ExecuteStep.java:33) [0m [0;0;90mat org.gradle.internal.execution.steps.ExecuteStep.execute(ExecuteStep.java:33) [0m [0;0;90mat org.gradle.internal.execution.steps.ExecuteStep.execute(ExecuteStep.java:26) [0m [0;0;90mat org.gradle.internal.execution.steps.CleanupOutputsStep.execute(CleanupOutputsStep.java:67) [0m [0;0;90mat org.gradle.internal.execution.steps.CleanupOutputsStep.execute(CleanupOutputsStep.java:36) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveInputChangesStep.execute(ResolveInputChangesStep.java:49) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveInputChangesStep.execute(ResolveInputChangesStep.java:34) [0m [0;0;90mat org.gradle.internal.execution.steps.CancelExecutionStep.execute(CancelExecutionStep.java:43) [0m [0;0;90mat org.gradle.internal.execution.steps.TimeoutStep.executeWithoutTimeout(TimeoutStep.java:73) [0m [0;0;90mat org.gradle.internal.execution.steps.TimeoutStep.execute(TimeoutStep.java:54) [0m [0;0;90mat org.gradle.internal.execution.steps.CatchExceptionStep.execute(CatchExceptionStep.java:34) [0m [0;0;90mat org.gradle.internal.execution.steps.CreateOutputsStep.execute(CreateOutputsStep.java:44) [0m [0;0;90mat org.gradle.internal.execution.steps.SnapshotOutputsStep.execute(SnapshotOutputsStep.java:54) [0m [0;0;90mat org.gradle.internal.execution.steps.SnapshotOutputsStep.execute(SnapshotOutputsStep.java:38) [0m [0;0;90mat org.gradle.internal.execution.steps.BroadcastChangingOutputsStep.execute(BroadcastChangingOutputsStep.java:49) [0m [0;0;90mat org.gradle.internal.execution.steps.CacheStep.executeWithoutCache(CacheStep.java:159) [0m [0;0;90mat org.gradle.internal.execution.steps.CacheStep.execute(CacheStep.java:72) [0m [0;0;90mat org.gradle.internal.execution.steps.CacheStep.execute(CacheStep.java:43) [0m [0;0;90mat org.gradle.internal.execution.steps.StoreExecutionStateStep.execute(StoreExecutionStateStep.java:44) [0m [0;0;90mat org.gradle.internal.execution.steps.StoreExecutionStateStep.execute(StoreExecutionStateStep.java:33) [0m [0;0;90mat org.gradle.internal.execution.steps.RecordOutputsStep.execute(RecordOutputsStep.java:38) [0m [0;0;90mat org.gradle.internal.execution.steps.RecordOutputsStep.execute(RecordOutputsStep.java:24) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipUpToDateStep.executeBecause(SkipUpToDateStep.java:92) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipUpToDateStep.lambda$execute$0(SkipUpToDateStep.java:85) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipUpToDateStep.execute(SkipUpToDateStep.java:55) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipUpToDateStep.execute(SkipUpToDateStep.java:39) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveChangesStep.execute(ResolveChangesStep.java:76) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveChangesStep.execute(ResolveChangesStep.java:37) [0m [0;0;90mat org.gradle.internal.execution.steps.legacy.MarkSnapshottingInputsFinishedStep.execute(MarkSnapshottingInputsFinishedStep.java:36) [0m [0;0;90mat org.gradle.internal.execution.steps.legacy.MarkSnapshottingInputsFinishedStep.execute(MarkSnapshottingInputsFinishedStep.java:26) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveCachingStateStep.execute(ResolveCachingStateStep.java:94) [0m [0;0;90mat org.gradle.internal.execution.steps.ResolveCachingStateStep.execute(ResolveCachingStateStep.java:49) [0m [0;0;90mat org.gradle.internal.execution.steps.CaptureStateBeforeExecutionStep.execute(CaptureStateBeforeExecutionStep.java:79) [0m [0;0;90mat org.gradle.internal.execution.steps.CaptureStateBeforeExecutionStep.execute(CaptureStateBeforeExecutionStep.java:53) [0m [0;0;90mat org.gradle.internal.execution.steps.ValidateStep.execute(ValidateStep.java:74) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipEmptyWorkStep.lambda$execute$2(SkipEmptyWorkStep.java:78) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipEmptyWorkStep.execute(SkipEmptyWorkStep.java:78) [0m [0;0;90mat org.gradle.internal.execution.steps.SkipEmptyWorkStep.execute(SkipEmptyWorkStep.java:34) [0m [0;0;90mat org.gradle.internal.execution.steps.legacy.MarkSnapshottingInputsStartedStep.execute(MarkSnapshottingInputsStartedStep.java:39) [0m [0;0;90mat org.gradle.internal.execution.steps.LoadExecutionStateStep.execute(LoadExecutionStateStep.java:40) [0m [0;0;90mat org.gradle.internal.execution.steps.LoadExecutionStateStep.execute(LoadExecutionStateStep.java:28) [0m FAILURE: Build failed with an exception. * What went wrong: Execution failed for task ':src:dist-check:batchTestSchedulerWithTimer'. > Failures detected while testing > <https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/bin/testfiles/TestSchedulerWithTimer.jmx>: > [unexpected output TestSchedulerWithTimer.csv, unexpected output > TestSchedulerWithTimer.xml, errors in TestSchedulerWithTimer.log] * Try: Run with --stacktrace option to get the stack trace. Run with --info or --debug option to get more log output. Run with --scan to get full insights. * Get more help at https://help.gradle.org Deprecated Gradle features were used in this build, making it incompatible with Gradle 7.0. Use '--warning-mode all' to show the individual deprecation warnings. See https://docs.gradle.org/6.6/userguide/command_line_interface.html#sec:command_line_warnings BUILD FAILED in 6m 52s 357 actionable tasks: 200 executed, 157 up-to-date See the profiling report at: file://<https://ci-builds.apache.org/job/JMeter/job/JMeter-trunk/ws/build/reports/profile/profile-2020-09-22-21-26-13.html> A fine-grained performance profile is available: use the --scan option. Build step 'Invoke Gradle script' changed build result to FAILURE Build step 'Invoke Gradle script' marked build as failure Xvfb stopping Archiving artifacts [Fast Archiver] Compressed 169.99 MB of artifacts by 51.3% relative to #89 Recording test results
