jmeter-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: JMeter Windows #1566
Date Tue, 05 Nov 2019 12:23:16 GMT
See <https://builds.apache.org/job/JMeter%20Windows/1566/display/redirect?page=changes>

Changes:

[Milamber] Copy the JMeter DOAP (Description Of A Project) file from SVN repo to

[Milamber] Update DOAP file with git repo, fixes some urls and add the 5.2 release


------------------------------------------
[...truncated 203.59 KB...]
> Task :src:dist-check:batchHttp4ImplDigestAuth
Nov 05, 2019 4:20: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\Http4ImplDigestAuth.jmx
Starting standalone test @ Tue Nov 05 04:20:58 PST 2019 (1572956458211)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary +      1 in 00:00:01 =    0.7/s Avg:   983 Min:   983 Max:   983 Err:     0 (0.00%)
Active: 1 Started: 1 Finished: 0
summary +      1 in 00:00:01 =    1.9/s Avg:   264 Min:   264 Max:   264 Err:     0 (0.00%)
Active: 0 Started: 1 Finished: 1
summary =      2 in 00:00:02 =    1.0/s Avg:   623 Min:   264 Max:   983 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:00 PST 2019 (1572956460707)
... end of run
No errors present in the logfile F:\jenkins\jenkins-slave\workspace\JMeter Windows\bin\Http4ImplDigestAuth.log
(the file is empty)

> Task :src:dist-check:batchHttp4ImplPreemptiveBasicAuth
Nov 05, 2019 4:21:02 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 @ Tue Nov 05 04:21:02 PST 2019 (1572956462825)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary +      1 in 00:00:01 =    1.0/s Avg:   103 Min:   103 Max:   103 Err:     0 (0.00%)
Active: 1 Started: 1 Finished: 0
summary +     11 in 00:00:03 =    3.2/s Avg:   100 Min:    26 Max:   540 Err:     0 (0.00%)
Active: 0 Started: 6 Finished: 6
summary =     12 in 00:00:04 =    2.7/s Avg:   100 Min:    26 Max:   540 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:07 PST 2019 (1572956467978)
... 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
Nov 05, 2019 4:21:09 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 @ Tue Nov 05 04:21:09 PST 2019 (1572956469906)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary =     12 in 00:00:04 =    3.0/s Avg:    71 Min:    26 Max:   505 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:14 PST 2019 (1572956474745)
... 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 05, 2019 4:21: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\JDBC_TESTS.jmx
Starting standalone test @ Tue Nov 05 04:21:16 PST 2019 (1572956476863)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary =     27 in 00:00:01 =   32.8/s Avg:    11 Min:     0 Max:   282 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:18 PST 2019 (1572956478865)
... 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-05 04:21:18,834 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-05 04:21:18,842 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-05 04:21:18,843 WARN o.a.j.p.j.p.AbstractJDBCProcessor: SQL Problem in JDBC PreProcessor:
java.sql.SQLSyntaxErrorException: unexpected token: USERS
2019-11-05 04:21:18,848 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 05, 2019 4:21:21 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 @ Tue Nov 05 04:21:21 PST 2019 (1572956481057)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary +     14 in 00:00:09 =    1.6/s Avg:   267 Min:     1 Max:  2003 Err:     0 (0.00%)
Active: 1 Started: 1 Finished: 0
summary +     13 in 00:00:20 =    0.6/s Avg:   850 Min:     0 Max:  3001 Err:     0 (0.00%)
Active: 0 Started: 1 Finished: 1
summary =     27 in 00:00:29 =    0.9/s Avg:   548 Min:     0 Max:  3001 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:50 PST 2019 (1572956510816)
... 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 05, 2019 4:21:53 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 @ Tue Nov 05 04:21:53 PST 2019 (1572956513889)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary =      3 in 00:00:02 =    1.6/s Avg:   385 Min:    62 Max:  1032 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:21:55 PST 2019 (1572956515963)
... 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 05, 2019 4:21: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\ResponseDecompression.jmx
Starting standalone test @ Tue Nov 05 04:21:57 PST 2019 (1572956517883)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary +      2 in 00:00:02 =    1.1/s Avg:   494 Min:   399 Max:   589 Err:     0 (0.00%)
Active: 1 Started: 1 Finished: 0
summary =      2 in 00:00:02 =    1.1/s Avg:   494 Min:   399 Max:   589 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:22:00 PST 2019 (1572956520270)
... 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:49161,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:[-25ac6fea:16e3b83c589:-7fff, -5886223821368802482]]][server]


> Task :src:dist-check:batchServerBatchTestLocal
Nov 05, 2019 4:22: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\BatchTestLocal.jmx
Configuring remote engine: jenkins-win-he-de-5.apache.org:49158
Starting distributed test with remote engines: [jenkins-win-he-de-5.apache.org:49158] @ Tue
Nov 05 04:22:05 PST 2019 (1572956525073)

[server] Starting the test on host jenkins-win-he-de-5.apache.org:49158 @ Tue Nov 05 04:22:07
PST 2019 (1572956527475)

> Task :src:dist-check:batchServerBatchTestLocal
Remote engines have been started:[jenkins-win-he-de-5.apache.org:49158]
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445

[server] Nov 05, 2019 4:22:07 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:49158 @ Tue Nov 05 04:22:14
PST 2019 (1572956534880) - exit requested.

> Task :src:dist-check:batchServerBatchTestLocal
summary =    132 in 00:00:07 =   19.1/s Avg:     4 Min:     0 Max:    89 Err:    16 (12.12%)
Tidying up remote @ Tue Nov 05 04:22:14 PST 2019 (1572956534880)
... 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 05, 2019 4:22: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\SlowCharsFeature.jmx
Starting standalone test @ Tue Nov 05 04:22:22 PST 2019 (1572956542279)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary =      5 in 00:00:34 =    0.1/s Avg:  6695 Min:   416 Max: 13933 Err:     0 (0.00%)
Tidying up ...    @ Tue Nov 05 04:22:56 PST 2019 (1572956576542)
... 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 05, 2019 4:22: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\SlowCharsFeature.jmx
Starting standalone test @ Tue Nov 05 04:22:58 PST 2019 (1572956578818)
Waiting for possible Shutdown/StopTestNow/HeapDump/ThreadDump message on port 4445
summary +      2 in 00:00:04 =    0.5/s Avg:  1838 Min:   415 Max:  3261 Err:     1 (50.00%)
Active: 1 Started: 1 Finished: 0
summary +      2 in 00:00:12 =    0.2/s Avg:  5686 Min:  5596 Max:  5777 Err:     0 (0.00%)
Active: 0 Started: 1 Finished: 1
summary =      4 in 00:00:15 =    0.3/s Avg:  3762 Min:   415 Max:  5777 Err:     1 (25.00%)
Tidying up ...    @ Tue Nov 05 04:23:14 PST 2019 (1572956594787)
... 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: 19283ms, configurations processed: 267 (add -PchecksumTimingsPrint
to print detailed timings)

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 7m 33s
290 actionable tasks: 169 executed, 121 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

Mime
View raw message