2024-11-18 23:31:30,908 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpbc_afm4p 2024-11-18 23:31:30,909 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/benchmark-160/loadtest-20241118222359689" -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/tmpbc_afm4p/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/tmpbc_afm4p/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 --- 23:31:32,520 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 23:31:32,521 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 23:31:32,521 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 23:31:32,521 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 23:31:32,526 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 23:31:32,527 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 23:31:32,534 |-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 23:31:32,534 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 23:31:32,534 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 23:31:32,534 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 23:31:32,537 |-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] 23:31:32,541 |-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 23:31:32,579 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 23:31:32,579 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 23:31:32,613 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 23:31:32,613 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 23:31:32,618 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 23:31:32,638 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 23:31:32,638 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 23:31:32,639 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 23:31:32,639 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 23:31:32,639 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 105 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 37s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 5192694 (OK=4886317 KO=306377) > min response time 36 (OK=36 KO=37 ) > max response time 26670 (OK=26670 KO=10001 ) > mean response time 66 (OK=65 KO=89 ) > std deviation 35 (OK=35 KO=22 ) > response time 50th percentile 54 (OK=53 KO=86 ) > response time 75th percentile 80 (OK=67 KO=97 ) > response time 95th percentile 133 (OK=134 KO=112 ) > response time 99th percentile 154 (OK=155 KO=122 ) > mean requests/sec 1442.41 (OK=1357.31 KO=85.1 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 4886285 ( 94.1%) > 800 ms <= t < 1200 ms 21 ( 0%) > t >= 1200 ms 11 ( 0%) > failed 306377 ( 5.9%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 401 305965 (96.42%) > tokenUserinfo: No attribute named 'access_token' is defined 10471 ( 3.30%) > status.find.in([200, 209], 304), found 401 402 ( 0.13%) > RootUserinfo: No attribute named 'access_token' is defined 270 ( 0.09%) > CreatePolicy: No attribute named 'oauth2_uuId' is defined 134 ( 0.04%) > createOrganization: No attribute named 'access_token' is defin 28 ( 0.01%) ed > queryOrganization: No attribute named 'organization_id' is def 28 ( 0.01%) ined > deleteOrganization: No attribute named 'organization_id' is de 28 ( 0.01%) fined > status.find.in([200, 209], 304), found 502 4 ( 0.00%) > status.find.is(200), but actually found 502 2 ( 0.00%) > status.find.is(302), but actually found 502 1 ( 0.00%) > status.find.in([200, 209], 304), found 400 1 ( 0.00%) > UI AM revoke2: No attribute named 'access_token_2' is defined 1 ( 0.00%) > status.find.in([200, 209], 304), found 500 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-160/loadtest-20241118222359689/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 39.340 s [INFO] Finished at: 2024-11-18T23:32:11Z [INFO] ------------------------------------------------------------------------ 2024-11-18 23:32:11,045 INFO Gatling simulation run ended successfully 2024-11-18 23:32:11,045 INFO Creating archive benchmark-160.tar.gz with report files 2024-11-18 23:32:11,592 INFO Archive /results/gatling/benchmark-160/benchmark-160.tar.gz successfully created