2025-03-19 21:22:22,439 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp65czeiqi 2025-03-19 21:22:22,441 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/pkce-access-token-900/loadtest-20250319201519303" -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp65czeiqi/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp65czeiqi/src/test/resources [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compile in 0.0 s [INFO] No sources to compile [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- 21:22:24,308 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 21:22:24,310 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 21:22:24,310 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 21:22:24,311 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 21:22:24,316 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 21:22:24,316 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 21:22:24,324 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 6 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 21:22:24,324 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 21:22:24,324 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 21:22:24,325 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 21:22:24,327 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] 21:22:24,332 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@240237d2 - URL [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] is not of type file 21:22:24,377 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 21:22:24,377 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 21:22:24,417 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 21:22:24,417 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 21:22:24,423 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 21:22:24,444 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 21:22:24,444 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 21:22:24,445 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 21:22:24,445 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 21:22:24,445 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 121 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 81s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 12899022 (OK=12898949 KO=73 ) > min response time 34 (OK=40 KO=34 ) > max response time 53340 (OK=53340 KO=10001 ) > mean response time 124 (OK=124 KO=2080 ) > std deviation 337 (OK=337 KO=3392 ) > response time 50th percentile 67 (OK=67 KO=179 ) > response time 75th percentile 100 (OK=100 KO=1745 ) > response time 95th percentile 299 (OK=299 KO=10000 ) > response time 99th percentile 878 (OK=875 KO=10000 ) > mean requests/sec 3583.06 (OK=3583.04 KO=0.02 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 12756147 ( 98.89%) > 800 ms <= t < 1200 ms 45671 ( 0.35%) > t >= 1200 ms 97131 ( 0.75%) > failed 73 ( 0%) ---- Errors -------------------------------------------------------------------- > headerRegex((Location,(?<=code=)(.+?)(?=&))).find.exists, foun 18 (24.66%) d nothing > status.find.in([200, 209], 304), found 500 16 (21.92%) > status.find.is(200), but actually found 502 10 (13.70%) > i.n.h.s.SslHandshakeTimeoutException: handshake timed out afte 7 ( 9.59%) r 10000ms > status.find.is(302), but actually found 400 6 ( 8.22%) > status.find.in([200, 209], 304), found 502 5 ( 6.85%) > status.find.is(200), but actually found 401 4 ( 5.48%) > status.find.is(302), but actually found 502 4 ( 5.48%) > status.find.is(200), but actually found 503 1 ( 1.37%) > i.n.c.ConnectTimeoutException: connection timed out after 1000 1 ( 1.37%) 0 ms: openam-perf-200m.forgeblocks.com/34.107.203.37:443 > status.find.in([200, 209], 304), found 503 1 ( 1.37%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/pkce-access-token-900/loadtest-20250319201519303/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:24 min [INFO] Finished at: 2025-03-19T21:23:47Z [INFO] ------------------------------------------------------------------------ 2025-03-19 21:23:47,409 INFO Gatling simulation run ended successfully 2025-03-19 21:23:47,410 INFO Creating archive pkce-access-token-900.tar.gz with report files 2025-03-19 21:23:47,520 INFO Archive /results/gatling/pkce-access-token-900/pkce-access-token-900.tar.gz successfully created