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/11/07 09:53:29 UTC
Build failed in Jenkins: JMeter Windows #1568
See <https://builds.apache.org/job/JMeter%20Windows/1568/display/redirect?page=changes>
Changes:
[sitnikov.vladimir] Update release plugins to 1.40.0: better properties validation and fix
[sitnikov.vladimir] Validate presence of signing.gnupg.keyName when useGpgCmd is used
------------------------------------------
[...truncated 203.91 KB...]
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 @ Thu Nov 07 01:51:11 PST 2019 (1573120271139)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 12 in 00:00:04 = 2.9/s Avg: 71 Min: 26 Max: 489 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:51:15 PST 2019 (1573120275929)
... 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
Nov 07, 2019 1:51:18 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 @ Thu Nov 07 01:51:18 PST 2019 (1573120278486)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 27 in 00:00:01 = 24.5/s Avg: 19 Min: 0 Max: 489 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:51:20 PST 2019 (1573120280688)
... 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-11-07 01:51:20,652 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.2-SNAPSHOT]
at org.apache.jmeter.protocol.jdbc.processor.JDBCPreProcessor.process(JDBCPreProcessor.java:33) ~[ApacheJMeter_jdbc.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.runPreProcessors(JMeterThread.java:941) ~[ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:542) ~[ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490) [ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257) [ApacheJMeter_core.jar:5.2-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152]
2019-11-07 01:51:20,664 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.2-SNAPSHOT]
at org.apache.jmeter.protocol.jdbc.processor.JDBCPostProcessor.process(JDBCPostProcessor.java:33) ~[ApacheJMeter_jdbc.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.runPostProcessors(JMeterThread.java:931) ~[ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.executeSamplePackage(JMeterThread.java:569) ~[ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.processSampler(JMeterThread.java:490) [ApacheJMeter_core.jar:5.2-SNAPSHOT]
at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257) [ApacheJMeter_core.jar:5.2-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152]
2019-11-07 01:51:20,665 WARN o.a.j.p.j.p.AbstractJDBCProcessor: SQL Problem in JDBC PreProcessor: java.sql.SQLSyntaxErrorException: unexpected token: USERS
2019-11-07 01:51:20,671 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
Nov 07, 2019 1:51:22 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 @ Thu Nov 07 01:51:22 PST 2019 (1573120282820)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 11 in 00:00:07 = 1.5/s Avg: 340 Min: 1 Max: 2003 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary + 16 in 00:00:22 = 0.7/s Avg: 698 Min: 0 Max: 3000 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
summary = 27 in 00:00:29 = 0.9/s Avg: 552 Min: 0 Max: 3000 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:51:52 PST 2019 (1573120312709)
... 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
Nov 07, 2019 1:51:55 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 @ Thu Nov 07 01:51:55 PST 2019 (1573120315649)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary = 3 in 00:00:02 = 1.7/s Avg: 389 Min: 67 Max: 1026 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:51:57 PST 2019 (1573120317637)
... 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
Nov 07, 2019 1:51:59 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 @ Thu Nov 07 01:51:59 PST 2019 (1573120319757)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 1 in 00:00:01 = 1.1/s Avg: 699 Min: 699 Max: 699 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary + 1 in 00:00:01 = 1.4/s Avg: 168 Min: 168 Max: 168 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1
summary = 2 in 00:00:02 = 1.2/s Avg: 433 Min: 168 Max: 699 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:52:02 PST 2019 (1573120322023)
... 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:50819,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:[2863a1ed:16e45473187:-7fff, 4503356810964598058]]][server]
> Task :src:dist-check:batchServerBatchTestLocal
Nov 07, 2019 1:52:07 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:50814
Starting distributed test with remote engines: [jenkins-win-he-de-5.apache.org:50814] @ Thu Nov 07 01:52:08 PST 2019 (1573120328023)
[server] Starting the test on host jenkins-win-he-de-5.apache.org:50814 @ Thu Nov 07 01:52:11 PST 2019 (1573120331189)
> Task :src:dist-check:batchServerBatchTestLocal
Remote engines have been started:[jenkins-win-he-de-5.apache.org:50814]
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
> Task :src:dist:javadocAggregate
9 warnings
[server] Nov 07, 2019 1:52:11 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.
[server] Finished the test on host jenkins-win-he-de-5.apache.org:50814 @ Thu Nov 07 01:52:18 PST 2019 (1573120338531) - exit requested.
> Task :src:dist-check:batchServerBatchTestLocal
summary = 132 in 00:00:07 = 19.4/s Avg: 4 Min: 0 Max: 86 Err: 16 (12.12%)
Tidying up remote @ Thu Nov 07 01:52:18 PST 2019 (1573120338531)
> Task :src:dist:distTar
> Task :src:dist:distTarSha512
> 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
Nov 07, 2019 1:52:25 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 @ Thu Nov 07 01:52:25 PST 2019 (1573120345777)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
> Task :src:dist:distZip
> Task :src:dist:distZipSha512
> Task :src:dist:distZipSourceSha512
> Task :src:dist-check:batchSlowCharsFeatureHttpClient4
summary + 2 in 00:00:06 = 0.3/s Avg: 2996 Min: 352 Max: 5640 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
> Task :src:dist:processSiteXslt
> Task :src:dist:previewSite UP-TO-DATE
> Task :src:dist:signDistTar SKIPPED
> Task :src:dist:signDistTarSource SKIPPED
> Task :src:dist:signDistZip SKIPPED
> Task :src:dist:signDistZipSource SKIPPED
> Task :src:dist:assemble
> Task :src:dist-check:batchSlowCharsFeatureHttpClient4
summary + 3 in 00:00:30 = 0.1/s Avg: 9982 Min: 5594 Max: 13949 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary = 5 in 00:00:36 = 0.1/s Avg: 7188 Min: 352 Max: 13949 Err: 0 (0.00%)
summary = 5 in 00:00:36 = 0.1/s Avg: 7188 Min: 352 Max: 13949 Err: 0 (0.00%)
Tidying up ... @ Thu Nov 07 01:53:02 PST 2019 (1573120382632)
... 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
Nov 07, 2019 1:53:04 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 @ Thu Nov 07 01:53:04 PST 2019 (1573120384983)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary + 1 in 00:00:00 = 2.2/s Avg: 422 Min: 422 Max: 422 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0
summary + 3 in 00:00:22 = 0.1/s Avg: 7210 Min: 5596 Max: 10280 Err: 1 (33.33%) Active: 0 Started: 1 Finished: 1
summary = 4 in 00:00:23 = 0.2/s Avg: 5513 Min: 422 Max: 10280 Err: 1 (25.00%)
Tidying up ... @ Thu Nov 07 01:53:27 PST 2019 (1573120407927)
... 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 411 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: Read 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 3332 bytes, F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\SlowCharsFeature_Java.xml
@@ -1,7 +1,7 @@
<?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: Read timed out" tn="Thread Group 1-1" dt="text">
<assertionResult>
<name>JSA-CheckResponseTimeHigherThan5s</name>
<failure>false</failure>
@@ -9,23 +9,33 @@
</assertionResult>
<assertionResult>
<name>RA_Size</name>
- <failure>false</failure>
+ <failure>true</failure>
<error>false</error>
+ <failureMessage>The result was the wrong size: It was 1,855 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: 115845ms, configurations processed: 269
SHA-512 computation time: 575ms (goes in parallel, it might exceed wall-clock time), files processed: 44, processed: 6MiB, skipped: 3421MiB
PGP signature resolution time: 33393ms (wall-clock), resolution requests: 160, signatures resolved: 225
PGP key resolution time: 13657ms (wall-clock), resolution requests: 160, download time: 1289ms (goes in parallel, it might exceed wall-clock time), keys downloaded: 1
PGP signature verification time: 16875ms (goes in parallel, it might exceed wall-clock time), files processed: 455, processed: 452MiB, skipped: 2946MiB
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 6.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/5.6.2/userguide/command_line_interface.html#sec:command_line_warnings
BUILD FAILED in 6m 56s
290 actionable tasks: 175 executed, 115 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 #1569
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/JMeter%20Windows/1569/display/redirect?page=changes>