2025-09-16 00:40:12,629 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpzhk6s89t 2025-09-16 00:40:12,631 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/benchmark-100/loadtest-20250915183416559" -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" [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/tmpzhk6s89t/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/tmpzhk6s89t/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 --- 00:40:15,140 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 00:40:15,142 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 00:40:15,142 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 00:40:15,143 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 00:40:15,150 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 00:40:15,151 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 00:40:15,160 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 8 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 00:40:15,160 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 00:40:15,161 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 00:40:15,162 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 00:40:15,165 |-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] 00:40:15,172 |-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 00:40:15,234 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 00:40:15,234 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 00:40:15,290 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 00:40:15,290 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 00:40:15,299 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 00:40:15,328 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 00:40:15,329 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 00:40:15,329 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 00:40:15,330 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 00:40:15,330 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 169 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 56s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 4623268 (OK=4588784 KO=34484 ) > min response time 33 (OK=33 KO=34 ) > max response time 60000 (OK=39086 KO=60000 ) > mean response time 51 (OK=51 KO=85 ) > std deviation 89 (OK=42 KO=911 ) > response time 50th percentile 46 (OK=46 KO=43 ) > response time 75th percentile 54 (OK=54 KO=107 ) > response time 95th percentile 89 (OK=88 KO=120 ) > response time 99th percentile 110 (OK=108 KO=130 ) > mean requests/sec 1284.24 (OK=1274.66 KO=9.58 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 4588615 ( 99.25%) > 800 ms <= t < 1200 ms 67 ( 0%) > t >= 1200 ms 102 ( 0%) > failed 34484 ( 0.75%) ---- Errors -------------------------------------------------------------------- > headerRegex((location,#id_token=(.*))).find.exists, found noth 11485 (33.27%) ing > status.find.in([200, 209], 304), found 401 11485 (33.27%) > jsonPath($.tokenId).find.exists, found nothing 11482 (33.26%) > RootUserinfo: No attribute named 'access_token' is defined 20 ( 0.06%) > status.find.in([200, 209], 304), found 502 15 ( 0.04%) > i.n.c.ConnectTimeoutException: connection timed out after 1000 9 ( 0.03%) 0 ms: openam-perf-haproxy.forgeblocks.com/34.120.144.60:443 > tokenUserinfo: No attribute named 'access_token' is defined 6 ( 0.02%) > Request timeout to openam-perf-haproxy.forgeblocks.com/34.120. 4 ( 0.01%) 144.60:443 after 60000 ms > status.find.is(200), but actually found 502 3 ( 0.01%) > UI AM endsession: No attribute named 'id_token_2' is defined 2 ( 0.01%) > PatchManagedUser: No attribute named 'access_token' is defined 1 ( 0.00%) > status.find.is(302), but actually found 502 1 ( 0.00%) > UI AM revoke2: No attribute named 'access_token_2' is defined 1 ( 0.00%) > ReadManagedUser: No attribute named 'access_token' is defined 1 ( 0.00%) > userinfo: No attribute named 'access_token' is defined 1 ( 0.00%) > UI AM revoke1: No attribute named 'access_token' is defined 1 ( 0.00%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/benchmark-100/loadtest-20250915183416559/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 min [INFO] Finished at: 2025-09-16T00:41:14+01:00 [INFO] ------------------------------------------------------------------------ 2025-09-16 00:41:14,530 INFO Gatling simulation run ended successfully 2025-09-16 00:41:14,531 INFO Creating archive benchmark-100.tar.gz with report files 2025-09-16 00:41:15,894 INFO Archive /results/gatling/benchmark-100/benchmark-100.tar.gz successfully created