See <https://builds.apache.org/job/JMeter%20Windows/933/display/redirect>
------------------------------------------ [...truncated 195.76 KB...] batchtest: [echo] Starting SlowCharsFeature_HttpClient4 with file SlowCharsFeature.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx [jmeter] Starting the test @ Sat Dec 09 00:30:45 UTC 2017 (1512779445884) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] Dec 09, 2017 12:30:45 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] summary + 3 in 00:00:19 = 0.2/s Avg: 6108 Min: 764 Max: 11528 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary = 3 in 00:00:19 = 0.2/s Avg: 6108 Min: 764 Max: 11528 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:31:05 UTC 2017 (1512779465745) [jmeter] ... end of run [echo] SlowCharsFeature_HttpClient4 output files compared OK batchtest: [echo] Starting SlowCharsFeature_Java with file SlowCharsFeature.jmx using -X -Jjmeter.httpsampler=Java [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:31:10 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/SlowCharsFeature.jmx [jmeter] Starting the test @ Sat Dec 09 00:31:10 UTC 2017 (1512779470483) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 2 in 00:00:14 = 0.1/s Avg: 6535 Min: 885 Max: 12186 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:31:25 UTC 2017 (1512779485190) [jmeter] ... end of run [echo] SlowCharsFeature_Java output files compared OK batchtest: [echo] Starting Http4ImplPreemptiveBasicAuth with file Http4ImplPreemptiveBasicAuth.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/Http4ImplPreemptiveBasicAuth.jmx [jmeter] Dec 09, 2017 12:31:31 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Starting the test @ Sat Dec 09 00:31:31 UTC 2017 (1512779491093) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary + 1 in 00:00:02 = 0.5/s Avg: 566 Min: 566 Max: 566 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary + 11 in 00:00:07 = 1.5/s Avg: 453 Min: 150 Max: 1720 Err: 0 (0.00%) Active: 0 Started: 6 Finished: 6 [jmeter] summary = 12 in 00:00:10 = 1.3/s Avg: 463 Min: 150 Max: 1720 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:31:43 UTC 2017 (1512779503099) [jmeter] ... end of run [echo] Http4ImplPreemptiveBasicAuth output files compared OK batchtest: [echo] Starting Http4ImplPreemptiveBasicAuth with file Http4ImplPreemptiveBasicAuth.jmx using -X -Jjmeter.httpsampler=Java [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:31:47 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/Http4ImplPreemptiveBasicAuth.jmx [jmeter] Starting the test @ Sat Dec 09 00:31:47 UTC 2017 (1512779507299) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 12 in 00:00:07 = 1.7/s Avg: 271 Min: 149 Max: 1328 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:31:56 UTC 2017 (1512779516284) [jmeter] ... end of run [echo] Http4ImplPreemptiveBasicAuth output files compared OK batchtest: [echo] Starting TestKeepAlive with file TestKeepAlive.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TestKeepAlive.jmx [jmeter] Starting the test @ Sat Dec 09 00:32:01 UTC 2017 (1512779521006) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] Dec 09, 2017 12:32:00 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] summary + 1 in 00:00:01 = 1.1/s Avg: 869 Min: 869 Max: 869 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary + 5 in 00:00:32 = 0.2/s Avg: 264 Min: 152 Max: 560 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary = 6 in 00:00:33 = 0.2/s Avg: 365 Min: 152 Max: 869 Err: 0 (0.00%) [jmeter] summary + 1 in 00:00:30 = 0.0/s Avg: 303 Min: 303 Max: 303 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary = 7 in 00:01:03 = 0.1/s Avg: 356 Min: 152 Max: 869 Err: 0 (0.00%) [jmeter] summary = 7 in 00:01:03 = 0.1/s Avg: 356 Min: 152 Max: 869 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:05 UTC 2017 (1512779585850) [jmeter] ... end of run [echo] TestKeepAlive output files compared OK batchtest: [echo] Starting ResponseDecompression with file ResponseDecompression.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:33:09 AM java.util.prefs.WindowsPreferences <init> [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/ResponseDecompression.jmx [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Starting the test @ Sat Dec 09 00:33:09 UTC 2017 (1512779589736) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 6 in 00:00:04 = 1.6/s Avg: 539 Min: 109 Max: 1328 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:14 UTC 2017 (1512779594589) [jmeter] ... end of run [echo] ResponseDecompression output files compared OK batchtest: [echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx [jmeter] Starting the test @ Sat Dec 09 00:33:18 UTC 2017 (1512779598364) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] Dec 09, 2017 12:33:18 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] summary = 3 in 00:00:07 = 0.5/s Avg: 2051 Min: 2004 Max: 2143 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:25 UTC 2017 (1512779605955) [jmeter] ... end of run [echo] TestHeaderManager output files compared OK batchtest: [echo] Starting TestHeaderManager with file TestHeaderManager.jmx using -X -Jjmeter.httpsampler=Java [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TestHeaderManager.jmx [jmeter] Starting the test @ Sat Dec 09 00:33:29 UTC 2017 (1512779609608) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] Dec 09, 2017 12:33:29 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] summary + 1 in 00:00:01 = 0.8/s Avg: 1027 Min: 1027 Max: 1027 Err: 0 (0.00%) Active: 1 Started: 1 Finished: 0 [jmeter] summary + 2 in 00:00:02 = 1.0/s Avg: 1002 Min: 1000 Max: 1004 Err: 0 (0.00%) Active: 0 Started: 2 Finished: 2 [jmeter] summary = 3 in 00:00:03 = 0.9/s Avg: 1010 Min: 1000 Max: 1027 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:33 UTC 2017 (1512779613965) [jmeter] ... end of run [echo] TestHeaderManager output files compared OK batchtest: [echo] Starting TEST_HTTP_HttpClient4 with file TEST_HTTP.jmx using -X -Jjmeter.httpsampler=HttpClient4 [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:33:38 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx [jmeter] Starting the test @ Sat Dec 09 00:33:38 UTC 2017 (1512779618530) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 22 in 00:00:02 = 9.3/s Avg: 73 Min: 1 Max: 856 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:41 UTC 2017 (1512779621790) [jmeter] ... end of run [echo] TEST_HTTP_HttpClient4 output files compared OK batchtest: [echo] Starting TEST_HTTP_Java with file TEST_HTTP.jmx using -X -Jjmeter.httpsampler=Java [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:33:47 AM java.util.prefs.WindowsPreferences <init> [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TEST_HTTP.jmx [jmeter] Starting the test @ Sat Dec 09 00:33:47 UTC 2017 (1512779627532) [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary = 20 in 00:00:02 = 10.3/s Avg: 69 Min: 1 Max: 777 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:33:50 UTC 2017 (1512779630352) [jmeter] ... end of run [concat] 2017-12-09 00:33:50,155 ERROR o.a.j.p.h.s.HTTPJavaImpl: readResponse: java.net.ProtocolException: Server redirected too many times (20) [concat] 2017-12-09 00:33:50,160 ERROR o.a.j.p.h.s.HTTPJavaImpl: Cause: java.net.ProtocolException: Server redirected too many times (20) [concat] 2017-12-09 00:33:50,161 ERROR o.a.j.p.h.c.HttpMirrorThread: Invalid request received:'' [echo] TEST_HTTP_Java output files compared OK batchtest: [echo] Starting TestSchedulerWithTimer with file TestSchedulerWithTimer.jmx using -X -Jdummy=dummy [jmeter] SLF4J: Class path contains multiple SLF4J bindings. [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/log4j-slf4j-impl-2.8.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: Found binding in [jar:file:/F:/jenkins/jenkins-slave/workspace/JMeter%20Windows/trunk/lib/opt/activemq-all-5.15.2.jar!/org/slf4j/impl/StaticLoggerBinder.class] [jmeter] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [jmeter] SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [jmeter] Dec 09, 2017 12:33:54 AM java.util.prefs.WindowsPreferences <init> [jmeter] WARNING: Could not open/create prefs root node Software\JavaSoft\Prefs at root 0x80000002. Windows RegCreateKeyEx(...) returned error code 5. [jmeter] Creating summariser <summary> [jmeter] Created the tree successfully using testfiles/TestSchedulerWithTimer.jmx [jmeter] Starting the test @ Sat Dec 09 00:33:54 UTC 2017 (1512779634879) [jmeter] Waiting for possible Shutdown/StopTestNow/Heapdump message on port 4445 [jmeter] summary + 5 in 00:00:06 = 0.9/s Avg: 139 Min: 0 Max: 691 Err: 0 (0.00%) Active: 1 Started: 3 Finished: 2 [jmeter] summary + 1 in 00:00:00 = 6.0/s Avg: 135 Min: 135 Max: 135 Err: 0 (0.00%) Active: 0 Started: 1 Finished: 1 [jmeter] summary = 6 in 00:00:06 = 1.0/s Avg: 139 Min: 0 Max: 691 Err: 0 (0.00%) [jmeter] Tidying up ... @ Sat Dec 09 00:34:02 UTC 2017 (1512779642376) [jmeter] ... end of run [echo] TestSchedulerWithTimer output files compared OK _allbatchtests: Cannot execute 'test' - '_test' failed or was not executed. download_checkstyle: _process_checkstyle_jars: _check_exists: _check_jarfile: [echo] Checking checkstyle-8.5-all.jar [echo] Deleting checkstyle-8.5-all.jar (excluding checkstyle-8.5-all.jar) setproxy: _get_jarfile: setproxy: _get_zipfile: checkstyle: _process_checkstyle_jars: _check_exists: _check_jarfile: [checkstyle] Running Checkstyle 8.5 on 1447 files BUILD FAILED <https://builds.apache.org/job/JMeter%20Windows/ws/trunk\build.xml>:2938: Java returned: 1 Total time: 11 minutes 51 seconds Build step 'Invoke Ant' marked build as failure