2025-06-14 05:27:44,296 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmppwdxtwot 2025-06-14 05:27:44,298 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/benchmark-550/loadtest-20250614030739048" -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/tmppwdxtwot/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/tmppwdxtwot/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 --- 05:27:46,852 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 05:27:46,854 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 05:27:46,854 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 05:27:46,855 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 05:27:46,861 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 05:27:46,862 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 05:27:46,871 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 7 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 05:27:46,871 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 05:27:46,871 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 05:27:46,872 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 05:27:46,875 |-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] 05:27:46,882 |-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 05:27:46,940 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 05:27:46,940 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 05:27:46,992 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 05:27:46,992 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 05:27:47,001 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 05:27:47,030 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 05:27:47,030 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 05:27:47,030 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 05:27:47,031 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 05:27:47,031 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 160 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 301s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 19733200 (OK=19508413 KO=224787) > min response time 5 (OK=86 KO=5 ) > max response time 60011 (OK=59737 KO=60011 ) > mean response time 332 (OK=332 KO=362 ) > std deviation 1937 (OK=1938 KO=1904 ) > response time 50th percentile 105 (OK=105 KO=187 ) > response time 75th percentile 133 (OK=132 KO=219 ) > response time 95th percentile 484 (OK=488 KO=361 ) > response time 99th percentile 3310 (OK=3310 KO=3179 ) > mean requests/sec 5481.44 (OK=5419 KO=62.44 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 18708159 ( 94.81%) > 800 ms <= t < 1200 ms 160079 ( 0.81%) > t >= 1200 ms 640175 ( 3.24%) > failed 224787 ( 1.14%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 401 185661 (79.46%) > status.find.in([200, 209], 304), found 401 18524 ( 7.93%) > j.n.ConnectException: connect(..) failed: Cannot assign reques 14500 ( 6.21%) ted address > status.find.in([200, 209], 304), found 500 3172 ( 1.36%) > RootUserinfo: No attribute named 'access_token' is defined 2285 ( 0.98%) > EvalPolicy: No attribute named 'userTokenId' is defined 1374 ( 0.59%) > userinfo: No attribute named 'access_token' is defined 1127 ( 0.48%) > UI AM revoke1: No attribute named 'access_token' is defined 813 ( 0.35%) > UI AM endsession: No attribute named 'id_token_2' is defined 747 ( 0.32%) > status.find.in([200, 209], 304), found 404 740 ( 0.32%) > deleteOrganization: No attribute named 'organization_id' is de 734 ( 0.31%) fined > queryOrganization: No attribute named 'organization_id' is def 734 ( 0.31%) ined > headerRegex((location,#id_token=(.*))).find.exists, found noth 708 ( 0.30%) ing > headerRegex((Location,(?<=code=)(.+?)(?=&))).find.exists, foun 622 ( 0.27%) d nothing > UI AM revoke2: No attribute named 'access_token_2' is defined 604 ( 0.26%) > status.find.in([200, 209], 304), found 503 507 ( 0.22%) > status.find.in([200, 209], 304), found 502 310 ( 0.13%) > createOrganization: No attribute named 'access_token' is defin 226 ( 0.10%) ed > tokenUserinfo: No attribute named 'access_token' is defined 216 ( 0.09%) > Request timeout to openam-tof-10.forgeblocks.com/34.98.119.82: 30 ( 0.01%) 443 after 60000 ms > status.find.in([200, 209], 304), found 405 10 ( 0.00%) > i.n.c.ConnectTimeoutException: connection timed out after 1000 1 ( 0.00%) 0 ms: openam-tof-10.forgeblocks.com/34.98.119.82:443 > status.find.is(200), but actually found 403 1 ( 0.00%) > i.n.h.s.SslHandshakeTimeoutException: handshake timed out afte 1 ( 0.00%) r 10000ms ================================================================================ Reports generated, please open the following file: file:///results/gatling/benchmark-550/loadtest-20250614030739048/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 05:05 min [INFO] Finished at: 2025-06-14T05:32:50+01:00 [INFO] ------------------------------------------------------------------------ 2025-06-14 05:32:50,933 INFO Gatling simulation run ended successfully 2025-06-14 05:32:50,934 INFO Creating archive benchmark-550.tar.gz with report files 2025-06-14 05:32:51,812 INFO Archive /results/gatling/benchmark-550/benchmark-550.tar.gz successfully created