You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@jmeter.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/12/04 13:44:14 UTC
Build failed in Jenkins: JMeter Windows #1592
See <https://builds.apache.org/job/JMeter%20Windows/1592/display/redirect?page=changes>
Changes:
[sitnikov.vladimir] GitHub Actions: actions/checkout@master -> v1.1.0 to avoid unexpected
[felix.schumacher] Update to jackson 2.10.1
[sitnikov.vladimir] Improve repeated checkstyle verifications by caching the state of the
------------------------------------------
[...truncated 204.49 KB...]
> Task :src:dist:assemble
> Task :src:dist-check:batchHttp4ImplPreemptiveBasicAuth
Dec 04, 2019 5:41:27 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\Http4ImplPreemptiveBasicAuth.jmx
Starting standalone test @ Wed Dec 04 05:41:27 PST 2019 (1575466887232)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 3 in 00:00:05 = 0.6/s Avg: 1270 Min: 27 Max: 3664 Err: 0 (0.00%) Active: 1 Started: 2 Finished: 1
summary + 8 in 00:00:27 = 0.3/s Avg: 3178 Min: 26 Max: 9582 Err: 0 (0.00%) Active: 1 Started: 6 Finished: 5
summary = 11 in 00:00:32 = 0.3/s Avg: 2658 Min: 26 Max: 9582 Err: 0 (0.00%)
summary + 1 in 00:00:01 = 0.8/s Avg: 1033 Min: 1033 Max: 1033 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6
summary = 12 in 00:00:34 = 0.4/s Avg: 2522 Min: 26 Max: 9582 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:01 PST 2019 (1575466921804)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\Http4ImplPreemptiveBasicAuth.log (the file is empty)
> Task :src:dist-check:batchHttp4ImplPreemptiveBasicAuthJava
Dec 04, 2019 5:42:03 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\Http4ImplPreemptiveBasicAuth.jmx
Starting standalone test @ Wed Dec 04 05:42:03 PST 2019 (1575466923509)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 1 in 00:00:01 = 1.1/s Avg: 74 Min: 74 Max: 74 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary + 11 in 00:00:03 = 3.5/s Avg: 74 Min: 26 Max: 550 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6
summary = 12 in 00:00:04 = 3.0/s Avg: 74 Min: 26 Max: 550 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:08 PST 2019 (1575466928323)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\Http4ImplPreemptiveBasicAuth.log (the file is empty)
> Task :src:dist-check:batchJDBC_TESTS
Dec 04, 2019 5:42:10 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\JDBC_TESTS.jmx
Starting standalone test @ Wed Dec 04 05:42:10 PST 2019 (1575466930425)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 27 in 00:00:01 = 26.1/s Avg: 11 Min: 0 Max: 263 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:12 PST 2019 (1575466932822)
... end of run
WARNING: the task was configured to ignore errors in the output log
Logfile contents (errors during the test, see F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\JDBC_TESTS.log):
2019-12-04 05:42:12,781 ERROR o.a.j.t.JMeterThread: Error while processing sampler: 'JDBC_With_Failing_PreProcessor'.
java.lang.IllegalArgumentException: Variable Name must not be null in JDBC PreProcessor
at org.apache.jmeter.protocol.jdbc.processor.AbstractJDBCProcessor.process(AbstractJDBCProcessor.java:45) ~[ApacheJMeter_jdbc.jar:5.3-SNAPSHOT]
at org.apache.jmeter.protocol.jdbc.processor.JDBCPreProcessor.process(JDBCPreProcessor.java:33) ~[ApacheJMeter_jdbc.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.runPreProcessors(JMeterThread.java:941) ~[ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:542) ~[ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490) [ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257) [ApacheJMeter_core.jar:5.3-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152]
2019-12-04 05:42:12,792 ERROR o.a.j.t.JMeterThread: Error while processing sampler: 'JDBC_With_Failing_PostProcessor'.
java.lang.IllegalArgumentException: Variable Name must not be null in JDBC PostProcessor
at org.apache.jmeter.protocol.jdbc.processor.AbstractJDBCProcessor.process(AbstractJDBCProcessor.java:45) ~[ApacheJMeter_jdbc.jar:5.3-SNAPSHOT]
at org.apache.jmeter.protocol.jdbc.processor.JDBCPostProcessor.process(JDBCPostProcessor.java:33) ~[ApacheJMeter_jdbc.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.runPostProcessors(JMeterThread.java:931) ~[ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:569) ~[ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490) [ApacheJMeter_core.jar:5.3-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257) [ApacheJMeter_core.jar:5.3-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152]
2019-12-04 05:42:12,793 WARN o.a.j.p.j.p.AbstractJDBCProcessor: SQL Problem in JDBC PreProcessor: java.sql.SQLSyntaxErrorException: unexpected token: USERS
2019-12-04 05:42:12,800 WARN o.a.j.p.j.p.AbstractJDBCProcessor: SQL Problem in JDBC PostProcessor: java.sql.SQLSyntaxErrorException: unexpected token: USERS
> Task :src:dist-check:batchJMS_TESTS
Dec 04, 2019 5:42:14 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\JMS_TESTS.jmx
Starting standalone test @ Wed Dec 04 05:42:14 PST 2019 (1575466934801)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 19 in 00:00:15 = 1.3/s Avg: 460 Min: 1 Max: 3000 Err: 0 (0.00%) Active: 1 Started: 3 Finished: 2
summary + 8 in 00:00:14 = 0.6/s Avg: 755 Min: 0 Max: 3000 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
summary = 27 in 00:00:29 = 0.9/s Avg: 547 Min: 0 Max: 3000 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:44 PST 2019 (1575466964552)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\JMS_TESTS.log (the file is empty)
> Task :src:dist-check:batchOS_TESTS
Dec 04, 2019 5:42:47 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\OS_TESTS.jmx
Starting standalone test @ Wed Dec 04 05:42:47 PST 2019 (1575466967477)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 3 in 00:00:02 = 1.5/s Avg: 414 Min: 91 Max: 1037 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:49 PST 2019 (1575466969647)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\OS_TESTS.log (the file is empty)
> Task :src:dist-check:batchResponseDecompression
Dec 04, 2019 5:42:51 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\ResponseDecompression.jmx
Starting standalone test @ Wed Dec 04 05:42:51 PST 2019 (1575466971709)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 2 in 00:00:02 = 1.1/s Avg: 426 Min: 352 Max: 501 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:42:54 PST 2019 (1575466974010)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\ResponseDecompression.log (the file is empty)
[server] Created remote object: UnicastServerRef2 [liveRef: [endpoint:[jenkins-win-he-de-5.apache.org:55259,SSLRMIServerSocketFactory(host=jenkins-win-he-de-5.apache.org/176.9.73.62, 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:[-36fd19e2:16ed126420d:-7fff, -7817484890845026627]]][server]
> Task :src:dist-check:batchServerBatchTestLocal
Dec 04, 2019 5:42:58 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\BatchTestLocal.jmx
Configuring remote engine: jenkins-win-he-de-5.apache.org:55254
Starting distributed test with remote engines: [jenkins-win-he-de-5.apache.org:55254] @ Wed Dec 04 05:42:59 PST 2019 (1575466979287)
[server] Starting the test on host jenkins-win-he-de-5.apache.org:55254 @ Wed Dec 04 05:43:01 PST 2019 (1575466981653)
> Task :src:dist-check:batchServerBatchTestLocal
Remote engines have been started:[jenkins-win-he-de-5.apache.org:55254]
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
[server] Dec 04, 2019 5:43:02 AM java.util.prefs.WindowsPreferences <init>
[server] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
> Task :src:dist-check:batchServerBatchTestLocal
summary + 1 in 00:00:00 = 8.3/s Avg: 3 Min: 3 Max: 3 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary + 131 in 00:00:07 = 19.2/s Avg: 4 Min: 0 Max: 107 Err: 16 (12.21%) Active: 0 Started: 11 Finished: 11
summary = 132 in 00:00:07 = 19.1/s Avg: 4 Min: 0 Max: 107 Err: 16 (12.12%)
Tidying up remote @ Wed Dec 04 05:43:09 PST 2019 (1575466989098)
[server] Finished the test on host jenkins-win-he-de-5.apache.org:55254 @ Wed Dec 04 05:43:09 PST 2019 (1575466989098) - exit requested.
> Task :src:dist-check:batchServerBatchTestLocal
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\BatchTestLocal.log (the file is empty)
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\BatchTestLocalServer.log (the file is empty)
> Task :src:dist-check:batchSlowCharsFeatureHttpClient4
Dec 04, 2019 5:43:16 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\SlowCharsFeature.jmx
Starting standalone test @ Wed Dec 04 05:43:16 PST 2019 (1575466996348)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 5 in 00:00:38 = 0.1/s Avg: 7571 Min: 432 Max: 13944 Err: 0 (0.00%)
Tidying up ... @ Wed Dec 04 05:43:55 PST 2019 (1575467035095)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\SlowCharsFeature.log (the file is empty)
> Task :src:dist-check:batchSlowCharsFeatureJava
Dec 04, 2019 5:43:57 AM java.util.prefs.WindowsPreferences <init>
WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Creating summariser <summary>
Created the tree successfully using F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\SlowCharsFeature.jmx
Starting standalone test @ Wed Dec 04 05:43:57 PST 2019 (1575467037470)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 2 in 00:00:04 = 0.5/s Avg: 1834 Min: 430 Max: 3239 Err: 1 (50.00%) Active: 1 Started: 1 Finished: 0
summary + 2 in 00:00:12 = 0.2/s Avg: 5687 Min: 5596 Max: 5778 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
summary = 4 in 00:00:15 = 0.3/s Avg: 3760 Min: 430 Max: 5778 Err: 1 (25.00%)
Tidying up ... @ Wed Dec 04 05:44:13 PST 2019 (1575467053391)
... end of run
ERROR: unexpected output for SlowCharsFeature_Java.csv:
- expected 332 bytes, F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\SlowCharsFeature_Java.csv
+ actual 414 bytes, F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\SlowCharsFeature_Java.csv
@@ -1,5 +1,5 @@
label,responseCode,responseMessage,threadName,dataType,success
JSS_setCPS,200,OK,setUp Thread Group 1-1,text,true
-ApacheJMeter-HP-Secure,206,Partial Content,Thread Group 1-1,text,true
+ApacheJMeter-HP-Secure,Non HTTP response code: java.net.SocketTimeoutException,Non HTTP response message: connect timed out,Thread Group 1-1,text,false
HTTPS-SNI-without-timeout,206,Partial Content,Thread Group 1-1,text,true
HTTPS-SNI-with-timeout,206,Partial Content,Thread Group 1-1,text,true
ERROR: unexpected output for SlowCharsFeature_Java.xml:
- expected 2834 bytes, F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\SlowCharsFeature_Java.xml
+ actual 3417 bytes, F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\SlowCharsFeature_Java.xml
@@ -1,31 +1,42 @@
<?xml version="1.0" encoding="UTF-8"?>
<testResults version="1.2">
<sample s="true" lb="JSS_setCPS" rc="200" rm="OK" tn="setUp Thread Group 1-1" dt="text"/>
-<httpSample s="true" lb="ApacheJMeter-HP-Secure" rc="206" rm="Partial Content" tn="Thread Group 1-1" dt="text">
+<httpSample s="false" lb="ApacheJMeter-HP-Secure" rc="Non HTTP response code: java.net.SocketTimeoutException" rm="Non HTTP response message: connect timed out" tn="Thread Group 1-1" dt="text">
<assertionResult>
<name>JSA-CheckResponseTimeHigherThan5s</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>Sampler should have taken more than 5 seconds</failureMessage>
</assertionResult>
<assertionResult>
<name>RA_Size</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>The result was the wrong size: It was 2,372 bytes, but should have been equal to 7,001 bytes.</failureMessage>
</assertionResult>
<assertionResult>
<name>RA_206</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>Test failed: code expected to equal /
+
+****** received : [[[Non HTTP response code: java.net.SocketTimeoutException]]]
+
+****** comparison: [[[206 ]]]
+
+/</failureMessage>
</assertionResult>
<assertionResult>
<name>RA_PartialContent</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>Response was null</failureMessage>
</assertionResult>
<assertionResult>
<name>RA</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>Test failed: text expected to contain /Apache JMeter/</failureMessage>
</assertionResult>
</httpSample>
<httpSample s="true" lb="HTTPS-SNI-without-timeout" rc="206" rm="Partial Content" tn="Thread Group 1-1" dt="text">
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\SlowCharsFeature.log (the file is empty)
> Task :src:dist-check:batchSlowCharsFeatureJava FAILED
checksum-dependency elapsed time: 33678ms, configurations processed: 272
SHA-512 computation time: 2247ms (goes in parallel, it might exceed wall-clock time), files processed: 37, processed: 5MiB, skipped: 3423MiB
PGP signature resolution time: 2302ms (wall-clock), resolution requests: 162, signatures resolved: 227
PGP key resolution time: 15963ms (wall-clock), resolution requests: 162, download time: 0ms (goes in parallel, it might exceed wall-clock time), keys downloaded: 0
PGP signature verification time: 31661ms (goes in parallel, it might exceed wall-clock time), files processed: 403, processed: 368MiB, skipped: 3032MiB
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':src:dist-check:batchSlowCharsFeatureJava'.
> Failures detected while testing F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\testfiles\SlowCharsFeature.jmx: [unexpected output SlowCharsFeature_Java.csv, unexpected output SlowCharsFeature_Java.xml]
* 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.0.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD FAILED in 8m 38s
290 actionable tasks: 235 executed, 55 up-to-date
Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5.
Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure
Jenkins build is back to normal : JMeter Windows #1593
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/JMeter%20Windows/1593/display/redirect?page=changes>