--Task-- name: benchmark-300 enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: am target_namespace: >default< start: 0.0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates below loop: False interval: None dependencies: [] wait_for: ['benchmark-200'] preceding_task: benchmark-200 options: {'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html', 'testCase': 'idc.benchmark.Mix2024', 'testMode': 'open', 'throughput': 300} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock 2025-09-16 19:16:49,049 INFO 2025-09-16 19:16:49,049 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 19:16:49,049 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 19:16:49,327 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 19:16:49,327 INFO [loop_until]: OK (rc = 0) 2025-09-16 19:16:49,327 DEBUG --- stdout --- 2025-09-16 19:16:49,327 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 19:16:49,327 DEBUG --- stderr --- 2025-09-16 19:16:49,327 DEBUG 2025-09-16 19:16:49,328 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-09-16 19:16:49 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-09-16 19:16:49 - INFO: timeout was calculated based on simulation duration parameter 2025-09-16 19:16:49 - INFO: Interval for this Task has changed to 2m (120 seconds) 2025-09-16 19:16:49 - INFO: interval was set to Task default because it was unset, based on self.timeout value because task is allowed to stop by itself Pod log file : /results/orders/benchmark-300/stdout.txt Pod log : /results/orders/benchmark-300 ________________________________________________________________________________ [2025-09-16 19:16:49] benchmark-300 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-haproxy" --results-folder="/results/gatling/benchmark-300" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2025-09-16 19:16:49] benchmark-300 create_order : Create order for overseer with the command to run ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/order.json { "name": "benchmark-300", "command": " /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idc.benchmark.Mix2024@perf-haproxy\" --results-folder=\"/results/gatling/benchmark-300\" --no-reports --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx4G\" --simulation-system-properties=\"-Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd\"", "out-dir": "/results/orders/benchmark-300" } ________________________________________________________________________________ [2025-09-16 19:16:49] benchmark-300 loop_until_ready : Wait for preceding task to finish if it uses same Overseer as a source, then loop for max_time until Overseer pod status is READY to accept order :param max_time: periodically check overseer status for this many seconds at maximum :param interval: interval between two periodical checks :return: ________________________________________________________________________________ 2025-09-16 19:16:49,336 INFO 2025-09-16 19:16:49,336 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-09-16 19:16:49,336 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-09-16 19:16:49,544 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 19:16:49,544 INFO [loop_until]: OK (rc = 0) 2025-09-16 19:16:49,544 DEBUG --- stdout --- 2025-09-16 19:16:49,544 DEBUG WAITING 2025-09-16 19:16:49,544 DEBUG --- stderr --- 2025-09-16 19:16:49,544 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 35 0 --:--:-- --:--:-- --:--:-- 35 ________________________________________________________________________________ [2025-09-16 19:16:49] benchmark-300 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-09-16 19:16:49,545 INFO 2025-09-16 19:16:49,545 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 19:16:49,545 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 19:16:49,830 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 19:16:49,831 INFO [loop_until]: OK (rc = 0) 2025-09-16 19:16:49,831 DEBUG --- stdout --- 2025-09-16 19:16:49,831 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 19:16:49,831 DEBUG --- stderr --- 2025-09-16 19:16:49,831 DEBUG 2025-09-16 19:16:49,831 INFO 2025-09-16 19:16:49,831 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/order.json overseer-0-57d79d468-khs5t:/results/orders/order.json 2025-09-16 19:16:49,831 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 19:16:50,760 INFO [loop_until]: OK (rc = 0) 2025-09-16 19:16:50,760 DEBUG --- stdout --- 2025-09-16 19:16:50,760 DEBUG 2025-09-16 19:16:50,761 DEBUG --- stderr --- 2025-09-16 19:16:50,761 DEBUG Order has been successfully forwarded to overseer 2025-09-16 19:16:50 - INFO: Check if Gatling simulation started successfully 2025-09-16 19:16:50,761 INFO 2025-09-16 19:16:50,761 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- head --lines 5000 /results/orders/benchmark-300/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-09-16 19:16:50,761 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-09-16 19:16:51,315 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-09-16 19:16:56,872 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-09-16 19:17:02,438 INFO [loop_until]: Function succeeded after 11s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-09-16 19:17:08,005 INFO [loop_until]: Function succeeded after 17s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-09-16 19:17:13,575 INFO [loop_until]: Function succeeded after 22s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-09-16 19:17:19,286 INFO [loop_until]: Function succeeded after 28s (rc=0) - expected pattern found 2025-09-16 19:17:19,286 INFO [loop_until]: OK (rc = 0) 2025-09-16 19:17:19,286 DEBUG --- stdout --- 2025-09-16 19:17:19,286 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input string (430 lines): 2025-09-16 19:17:19,286 DEBUG ----- output ----- 2025-09-16 20:16:53,166 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpajhhfz26 2025-09-16 20:16:53,170 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode --quiet -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-300" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd System property think_time_multiplier not set. No think time emulation will be done in the simulation. Simulation com.forgerock.pyrock.Loadtest started... 20:17:14.802 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'authAsPolicyAdmin' failed for user 1: status.find.in([200, 209], 304), found 401 20:17:14.815 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: authAsPolicyAdmin: KO status.find.in([200, 209], 304), found 401 ========================= Session: Session(getToken,1,Map(gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@60e57377, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@32cbef7c, gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, 607c1adb-ea30-44c5-bd47-b1534e1d666d -> 0),KO,List(ExitOnCompleteLoopBlock(607c1adb-ea30-44c5-bd47-b1534e1d666d)),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@52e7a2fa,io.netty.channel.epoll.EpollEventLoop@f79a760) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: X-OpenAM-Username: policyAdmin Content-Type: application/json Accept-API-Version: resource=2.0, protocol=1.0 X-OpenAM-Password: Pa_ssw0rd user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 401 Unauthorized headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache content-type: application/json Content-Length: 62 date: Tue, 16 Sep 2025 19:17:14 GMT x-forgerock-transactionid: 40410fe5-4739-4fce-b69d-a0868aadfb69 strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"code":401,"reason":"Unauthorized","message":"Login failure"} <<<<<<<<<<<<<<<<<<<<<<<<< 20:17:14.818 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-8' crashed with 'j.u.NoSuchElementException: No attribute named 'policyEvalTokenId' is defined', forwarding to the next one 20:17:15.013 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.014 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.167 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.214 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.414 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.415 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.629 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.630 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.740 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.748 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.749 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.803 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.815 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.816 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.881 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.882 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.885 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.016 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.017 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.017 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.083 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.083 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.144 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.149 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.150 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.216 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.217 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.283 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.283 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.349 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.350 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.396 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.417 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.417 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.469 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'userRestlogin' failed for user 18: jsonPath($.tokenId).find.exists, found nothing 20:17:16.471 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: userRestlogin: KO jsonPath($.tokenId).find.exists, found nothing [...] 20:17:18.581 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.582 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.602 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:18.609 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.610 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.632 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.632 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.654 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.654 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.655 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'userRestlogin' failed for user 79: jsonPath($.tokenId).find.exists, found nothing 20:17:18.656 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: userRestlogin: KO jsonPath($.tokenId).find.exists, found nothing ========================= Session: Session(idc.benchmark.Mix2024,79,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@593c9d5c, username -> user.1729347, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@135d6191, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758050238653))), password -> Pa_ssw0rd),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@4e28bdd1) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: Content-Type: apppliation/json Accept-API-Version: resource=2.0, protocol=1.0 user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 X-OpenAM-Username: user.1729347 X-OpenAM-Password: Pa_ssw0rd accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 200 OK headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache set-cookie: amlbcookie=01; Path=/; Domain=openam-perf-haproxy.forgeblocks.com; Secure; HttpOnly; SameSite=none content-type: application/json Content-Length: 5283 date: Tue, 16 Sep 2025 19:17:18 GMT x-forgerock-transactionid: 615e4abe-fa13-45d1-81d4-53f7d555f6d4 strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiI0YjBhYmI1NC0xZDZjLTRkNWItOTI4Mi04MjA3M2UwNmYxMDYiLCJvdGsiOiJtbW0ya2FtN3Nna3QyaTZqOG9vaXJsOHZzNSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1RlNFRjZaa1prT1ROWk4zZzFRbmhRVG10eFZUaFJMbkpZTUU4eldHSkVOblZLZG1KdFdDMXJVM2xRYzBoVWVuSkdWV2hTV1ZKM1lYWktjVGw1UjJWYVgwVjRjbFJXTTBab1UwUndZVk5sUVhwaFIxbHVUVVZIWmpOV2JHbEZSMnh5ZWxCSlVGZHFNemRJWmpoWmMwVldVMGhTZVdwaWFuWnhRemhmUTFKclVrd3lUVkJoYldjMlIzZG5ORE5LYzBKVWRFcHZiekF5VWpWRWRFTkljRkZ1TWtOSE1IUTFUbEppZG5WcVpGZExTR1pHZERSWGEyaEtMV3B2WDJWUE1sZFhTSGN6UVc5SVRqTkNaMDFITUdjMVdGbDJNR3RsYldWSFEwdE1XSEpCU0dWSFNYUm9OVXBQVlU5a1VuTm9hemx0ZFVOSFRtbGFSVlJhTnpWblZVWmpkVkJFUjJKSFVXTmFlRWh2ZGxSWVVIVTNUMkpOWDB0clJFdEhTM2xvUlhnemJFMUhjbnAyZFhvelNtUkJhbk5vYjNCV2NYVllVRGhJTFZCdFQwSnFaamRHYms1MWJGSlVWM1pUTFVKMGRrdEJNbWc1YTNjMGFVZzFSSHAwWW1aYVdXSk9aMjg0WW5veGJGUmZVMk0zY1VSTVoyZE1jM0JtVGtGMFpXeHRZazFxV0ZWaU1EZFBaa2xvV0VseFJHTkdORmRpUWpsSllXUTNVWGhtT1ZSUlpIWmFaa2xyYmxOMVZrSkJVR0pvVlhZMk5tTTBOMkY0TTJSSFgyMVhkM2Q1TlhGbU0ycEVYMkZLWjI1alFVcEpkRjlOTmtkdlkySk9UVXhrYkVJMFNEWXlZM28wVFRCNVNtbFZlRlY1VjNGVlpEZG9NR1UxUkV3M1RISmFjRTh6VTJWaVRERm1NV3RxUmtaeFJXWTVjVXgzUzA4MlZHOVNVV1psWVhGUWMzRnVjVzltTUVveUxWSnBSSFE0YkdKalVtOW5YMFZFT1ZsaE1ITmljMUV3V2kxMFFXNUtOR016UVhZeFVESmpXVXRMUVRCWFRsTTRUWGN0V21WT1EySjNXV3gyVGw5VU9YTm5USEZzTURZeFlrMXlZelJYZGxaU2RHOXlVMFp6TjBoNFFXMVhiR1JDZFdFelUzWkNOa2RLTXpKRVluZG1aMUYwTWxCZlQzTnNNVEJZWWxWVk5VVm9UVVkxTkZOaU9XUk9SRmh3UkRCdWFGODNlblZXY21OTFUyYzJUWGhLTUV0dFJtaFZUVFprVmtod1p6QnFiRloxVFVwYWVFbHZSVVZOTkVwWVUyVkpTVWwzTFdGdloyUTRWbEJ5TWpabVVFOWFkVVJvYnpOdVZXazFXVUZqUWtaaE5HcENlVVJHVUhWWE1IYzBhV1poYWpOclEzVk9jVm94TVRkVGRVYzVVVmRRZFRFdFZXWXhSakU1VUZReFZVUnZlRVJCUzNkR05UQlhVRWc1VmpKdVZXSmFlRFJ2UkdSb1dqVnVZa2h5WkhwbWNWaExYemxRYmxoMlNqUTNRVE5wVGtOWmJVd3dTVTFpTlhwNE5uRkxiRkpGTjFack9HVm5iWE5zWkVSamN6a3daM0ZEVURWUVYyVmlVRlF0ZDBGR2JuVk1UVkJ4ZHpoelltZEZZMHQ0Ym1WcFdtZzRiMGxSTWs5VlNETXlOVEJLVjJndFYzVXlaVFk1V0ZGa016RlNhMlZwYVhaMlEwYzVjVVEzY1dsblFuRXdSVXhmYzFkVGJFZzRka04wZG0xcldGSmxNVTF0U0RVeldXZEhhWEJFU3kxcmVVVlpZbVJ6WnpCM2IwZHRkSFpUVVd0Wk1saDZZVUZJUW5ONmIwUXlSRnBvWHpJd2RVTXRiSGRIUzJkVFYxTnlablY0YmsxMGFuRldiVWd3TlhWamJURktXbXhvVDA5QmFFdHBabkJHVVhwbFFVdEVXR2hCUVhNdE0wRkljVll3TWpSV00ydG9SV2RYVGs5dk1FVllRVEpRVEV0eVUwbGZZVmQ2TldsdlJGQnBUVFp4WWxaQlpWY3RNMmRrVlhBNVJVNXZaWFV0Wmswd2VrMWxRbVpJTldGc0xXZFRWMlE0WkdSTGVuY3RVWFJWWkVSclFVVlZWWEU1UjNkdFZqbEVNMVpwYUZWdlgwaGtWemhOUlU1Qlp6TmhhREV3YVRVek0yRjVkbTQ1TmkxaFJEbDRSVmhtTWtZMVVVSlBXQzFxYnpaamJYWlpkMUJpVkVVeWFHa3hTVTlHVUVOVVN5MVFTREJrWVhCWFpWcDJOV2RvVVdWQ1VXWmxUblpoWVV4bk5XNTNZakZYYzNkVWQyVmpOaTB5WlZkb05teExiWGsyZVd0RVJFczFSaTA0WXpJM1NFRndkV3RJWjJkRlZWSnpVVzAzTWxob2MydEpNR2RGZEhsR1puUlNNV2h1YkVsdFJuZE9PRVJhZERkYWVXZHpOblZ3VW1kRlFVSkhRMHRLVkRGQ1V6UkpZbGQ2Y3pSalVrTnNTMmhwYlMxc1JsUlRXWHBtT1RKU2FsbzFlV3R4ZUVkUVMzcG9jMEV6VVhWdVpYUnNSbXBqZWxWeGNYSnJlVXR6Y2tKTmRIUmhWSEJ5VHpSTFVuUXRURGQyUjBsWlVFeFpNMWRmUjNkbFh6TXRhV3BrYTNCaGQweGFWRFJPUTFkcmRUYzBTa1JxWlZONVZsa3pXSGRTUkRkalVWcEtiREJLY3poeFZrczVZVU16V21aNVkwSXdiWFJaZDBacWEweDJiRkU1TFdGUk9Wa3pkbU5mYVZGdk4yeFhUVlo0YkdadlNXWk1WbTVYVmxwaWRISXlkbXBMT1ZaTmFIZ3dZV3hKV0MxalEyNHpZMmRYUnpGVmEwdHRTalJtYWsxMU5XbHhORjlwV0ZoNWRuRXdha1ZCY0hkbVFUaERiVWhhUld4RlVWQjJRV3N3ZW5BMlRrMDRRVXMwVXpSVFlXMTVWakJ5UlhsdU4wRjNSbEprZDFjMGFGQnFSa3B0VXpkT1h6TjZWVFp3TTNWd2FIaHRSRGQxY0ZKQ2JEUjVSMjR6YWxBeWRGRXRRbGhmUWxBNUxVcGZSVXQ1YWtSRlNIVjBOMEV5Wkc4M2NXWTJYMDlXY0V0eVZIRk1OM2t6UTBKM1gyTk1hMHA0UVZkdFkzUTFjVVppUzNkUFYyTkxZMU5VUmpaWGNDMXZXbE5YUm5NM00zRk5SRUpUTlRnMlIxUk1RVWxWTUd0UVJuVXRjazR3TFhkU1J6UXpjV3AwVVVGR09GZDBaMXBRYmkwME9TMXJiVVJYYjJ0aGVVaHNTVWRYVTNkNmFYcE5lSFpJYmxKMVNubG1SWFZzYW1oSmMybEpVMGhtVlRGNFZ6UlJabEJ4ZVZwQ1NGTkdNVzAwTTFaYU5WODVPR2hHU21veFNXTklXSEpMWmxaQ1V6VXdRWGxqTlVjd2VYRlBWMjR3UlRGUGMyRTVTWG96V21ZdFUwd3RiMFpxWlZCbVNVbGhVVUpDVjBwQmF6bE9WeTF3ZW1VemIzQnZkWFl0U0dsRlYyWjVZV0Z4VG5kek5WZFNiMGRNZEZsWE4wTnpZMHRrWVdaaExTMWtabk14YW5acWNFSnVNRE40VEVSTFdHRkNYMVZWZUU5SlJFZzJNM1pHVVd0c2JtUldUVkF6V2t4NlZFNUVVMHhJVW5abmRESnRTRUZOTVdsbFlVVXpVUzV1U0RCb1pqRkxlVzEzWDNwNFEyOVpObWcxYWxKMy4ycl9SQlo1emZ1VmtGRjVRSzEyYnFwSVZUcDNmRDBPTTFxUTlwZkJ3ckJNIiwiZXhwIjoxNzU4MDUwNTM4LCJpYXQiOjE3NTgwNTAyMzh9.uXZzMCO_UthEZhvpXR7sh9dq_rUJndZ71MRXKET_EZw","callbacks":[{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/updates"},{"name":"prompt","value":"Send me news and updates"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken1","value":false},{"name":"IDToken1validateOnly","value":false}],"_id":2},{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/marketing"},{"name":"prompt","value":"Send me special offers and services"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken2","value":false},{"name":"IDToken2validateOnly","value":false}],"_id":3}],"header":"Please select your preferences"} <<<<<<<<<<<<<<<<<<<<<<<<< 20:17:18.656 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:18.676 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.676 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.698 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.698 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.721 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.721 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.743 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.743 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.765 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.765 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.787 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.787 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.810 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.810 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.832 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.832 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.854 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.854 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.876 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.876 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.898 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.898 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.917 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:18.921 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.921 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.943 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.943 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.965 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.965 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:18.987 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:18.987 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.010 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:19.010 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.032 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:19.033 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.034 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:19.054 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:19.054 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.076 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:19.077 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.098 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:19.098 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:19.106 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 2025-09-16 19:17:19,286 DEBUG --- stderr --- 2025-09-16 19:17:19,286 DEBUG ________________________________________________________________________________ [2025-09-16 19:17:19] benchmark-300 wait_stop_by_itself : Wait for the order to stop by itself ________________________________________________________________________________ Task may stop by itself (no stop defined in configuration file), wait until overseer ends the order - timeout is 1h 12m. Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 2m, retry Order is running since 4m, retry Order is running since 6m, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 01s, retry Order is running since 14m 01s, retry Order is running since 16m 02s, retry Order is running since 18m 02s, retry Order is running since 20m 02s, retry Order is running since 22m 03s, retry Order is running since 24m 03s, retry Order is running since 26m 03s, retry Order is running since 28m 03s, retry Order is running since 30m 04s, retry Order is running since 32m 04s, retry Order is running since 34m 04s, retry Order is running since 36m 04s, retry Order is running since 38m 05s, retry Order is running since 40m 05s, retry Order is running since 42m 05s, retry Order is running since 44m 06s, retry Order is running since 46m 06s, retry Order is running since 48m 06s, retry Order is running since 50m 06s, retry Order is running since 52m 07s, retry Order is running since 54m 07s, retry Order is running since 56m 07s, retry Order is running since 58m 07s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2025-09-16 20:17:27] benchmark-300 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-09-16 20:17:27,488 INFO 2025-09-16 20:17:27,488 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 20:17:27,488 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 20:17:27,804 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 20:17:27,804 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:27,804 DEBUG --- stdout --- 2025-09-16 20:17:27,804 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 20:17:27,804 DEBUG --- stderr --- 2025-09-16 20:17:27,804 DEBUG 2025-09-16 20:17:27,804 INFO 2025-09-16 20:17:27,804 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- rm -f /results/orders/order.json 2025-09-16 20:17:27,804 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 20:17:28,407 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:28,408 DEBUG --- stdout --- 2025-09-16 20:17:28,408 DEBUG 2025-09-16 20:17:28,408 DEBUG --- stderr --- 2025-09-16 20:17:28,408 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-09-16 20:17:28] benchmark-300 download_logs : Download individual order files ________________________________________________________________________________ 2025-09-16 20:17:28 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/order.json 2025-09-16 20:17:28,408 INFO 2025-09-16 20:17:28,408 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 20:17:28,408 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 20:17:28,705 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 20:17:28,705 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:28,705 DEBUG --- stdout --- 2025-09-16 20:17:28,705 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 20:17:28,705 DEBUG --- stderr --- 2025-09-16 20:17:28,705 DEBUG Checking if file exists on pod 'overseer-0-57d79d468-khs5t', wait max 3 minutes if not. 2025-09-16 20:17:28,706 INFO 2025-09-16 20:17:28,706 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- bash -c 'if [ -f "/results/orders/benchmark-300/rc.txt" ]; then echo "/results/orders/benchmark-300/rc.txt file found"; exit 0; else echo "/results/orders/benchmark-300/rc.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-300/rc.txt file found" 2025-09-16 20:17:28,706 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 20:17:29,266 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:29,267 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:29,267 DEBUG --- stdout --- 2025-09-16 20:17:29,267 DEBUG /results/orders/benchmark-300/rc.txt file found 2025-09-16 20:17:29,267 DEBUG --- stderr --- 2025-09-16 20:17:29,267 DEBUG 2025-09-16 20:17:29,267 INFO 2025-09-16 20:17:29,267 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- du -k /results/orders/benchmark-300/rc.txt | grep "^\d+ .+$" 2025-09-16 20:17:29,267 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-09-16 20:17:29,822 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:29,822 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:29,822 DEBUG --- stdout --- 2025-09-16 20:17:29,822 DEBUG 4 /results/orders/benchmark-300/rc.txt 2025-09-16 20:17:29,822 DEBUG --- stderr --- 2025-09-16 20:17:29,822 DEBUG - Download file (size 4kB) source : /results/orders/benchmark-300/rc.txt @ overseer-0-57d79d468-khs5t destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/rc.txt 2025-09-16 20:17:29,823 INFO 2025-09-16 20:17:29,823 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-57d79d468-khs5t:/results/orders/benchmark-300/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/rc.txt 2025-09-16 20:17:29,823 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-09-16 20:17:30,373 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:30,373 DEBUG --- stdout --- 2025-09-16 20:17:30,373 DEBUG tar: Removing leading `/' from member names 2025-09-16 20:17:30,373 DEBUG --- stderr --- 2025-09-16 20:17:30,373 DEBUG 2025-09-16 20:17:30,373 INFO 2025-09-16 20:17:30,373 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 20:17:30,373 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 20:17:30,657 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 20:17:30,657 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:30,657 DEBUG --- stdout --- 2025-09-16 20:17:30,657 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 20:17:30,657 DEBUG --- stderr --- 2025-09-16 20:17:30,657 DEBUG Checking if file exists on pod 'overseer-0-57d79d468-khs5t', wait max 3 minutes if not. 2025-09-16 20:17:30,658 INFO 2025-09-16 20:17:30,658 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- bash -c 'if [ -f "/results/orders/benchmark-300/stderr.txt" ]; then echo "/results/orders/benchmark-300/stderr.txt file found"; exit 0; else echo "/results/orders/benchmark-300/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-300/stderr.txt file found" 2025-09-16 20:17:30,658 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 20:17:31,218 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:31,218 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:31,218 DEBUG --- stdout --- 2025-09-16 20:17:31,218 DEBUG /results/orders/benchmark-300/stderr.txt file found 2025-09-16 20:17:31,218 DEBUG --- stderr --- 2025-09-16 20:17:31,218 DEBUG 2025-09-16 20:17:31,218 INFO 2025-09-16 20:17:31,219 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- du -k /results/orders/benchmark-300/stderr.txt | grep "^\d+ .+$" 2025-09-16 20:17:31,219 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-09-16 20:17:31,779 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:31,779 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:31,779 DEBUG --- stdout --- 2025-09-16 20:17:31,779 DEBUG 0 /results/orders/benchmark-300/stderr.txt 2025-09-16 20:17:31,779 DEBUG --- stderr --- 2025-09-16 20:17:31,779 DEBUG - Download file (size 0B) source : /results/orders/benchmark-300/stderr.txt @ overseer-0-57d79d468-khs5t destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/stderr.txt 2025-09-16 20:17:31,780 INFO 2025-09-16 20:17:31,780 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-57d79d468-khs5t:/results/orders/benchmark-300/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/stderr.txt 2025-09-16 20:17:31,780 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-09-16 20:17:32,327 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:32,327 DEBUG --- stdout --- 2025-09-16 20:17:32,327 DEBUG tar: Removing leading `/' from member names 2025-09-16 20:17:32,327 DEBUG --- stderr --- 2025-09-16 20:17:32,327 DEBUG 2025-09-16 20:17:32,327 INFO 2025-09-16 20:17:32,327 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 20:17:32,327 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 20:17:32,612 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 20:17:32,612 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:32,612 DEBUG --- stdout --- 2025-09-16 20:17:32,612 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 20:17:32,612 DEBUG --- stderr --- 2025-09-16 20:17:32,612 DEBUG Checking if file exists on pod 'overseer-0-57d79d468-khs5t', wait max 3 minutes if not. 2025-09-16 20:17:32,613 INFO 2025-09-16 20:17:32,613 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- bash -c 'if [ -f "/results/orders/benchmark-300/stdout.txt" ]; then echo "/results/orders/benchmark-300/stdout.txt file found"; exit 0; else echo "/results/orders/benchmark-300/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-300/stdout.txt file found" 2025-09-16 20:17:32,613 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 20:17:33,170 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:33,171 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:33,171 DEBUG --- stdout --- 2025-09-16 20:17:33,171 DEBUG /results/orders/benchmark-300/stdout.txt file found 2025-09-16 20:17:33,171 DEBUG --- stderr --- 2025-09-16 20:17:33,171 DEBUG 2025-09-16 20:17:33,171 INFO 2025-09-16 20:17:33,171 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- du -k /results/orders/benchmark-300/stdout.txt | grep "^\d+ .+$" 2025-09-16 20:17:33,171 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-09-16 20:17:33,731 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:33,731 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:33,731 DEBUG --- stdout --- 2025-09-16 20:17:33,731 DEBUG 621564 /results/orders/benchmark-300/stdout.txt 2025-09-16 20:17:33,731 DEBUG --- stderr --- 2025-09-16 20:17:33,731 DEBUG - Download file (size 621.564MB exceeds limit of 100MB, only first 1000 and last 1000 lines will be downloaded) source : /results/orders/benchmark-300/stdout.txt @ overseer-0-57d79d468-khs5t destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/stdout.txt 2025-09-16 20:17:33,731 INFO 2025-09-16 20:17:33,732 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- head -n 1000 /results/orders/benchmark-300/stdout.txt 2025-09-16 20:17:34,527 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-09-16 20:17:34,527 DEBUG --- stdout --- 2025-09-16 20:17:34,527 DEBUG [print_head_tail]: Print head (80 lines) and tail (80 lines) of input string (1000 lines): 2025-09-16 20:17:34,527 DEBUG ----- output ----- 2025-09-16 20:16:53,166 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpajhhfz26 2025-09-16 20:16:53,170 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode --quiet -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-300" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd System property think_time_multiplier not set. No think time emulation will be done in the simulation. Simulation com.forgerock.pyrock.Loadtest started... 20:17:14.802 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'authAsPolicyAdmin' failed for user 1: status.find.in([200, 209], 304), found 401 20:17:14.815 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: authAsPolicyAdmin: KO status.find.in([200, 209], 304), found 401 ========================= Session: Session(getToken,1,Map(gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@60e57377, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@32cbef7c, gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, 607c1adb-ea30-44c5-bd47-b1534e1d666d -> 0),KO,List(ExitOnCompleteLoopBlock(607c1adb-ea30-44c5-bd47-b1534e1d666d)),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@52e7a2fa,io.netty.channel.epoll.EpollEventLoop@f79a760) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: X-OpenAM-Username: policyAdmin Content-Type: application/json Accept-API-Version: resource=2.0, protocol=1.0 X-OpenAM-Password: Pa_ssw0rd user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 401 Unauthorized headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache content-type: application/json Content-Length: 62 date: Tue, 16 Sep 2025 19:17:14 GMT x-forgerock-transactionid: 40410fe5-4739-4fce-b69d-a0868aadfb69 strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"code":401,"reason":"Unauthorized","message":"Login failure"} <<<<<<<<<<<<<<<<<<<<<<<<< 20:17:14.818 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-8' crashed with 'j.u.NoSuchElementException: No attribute named 'policyEvalTokenId' is defined', forwarding to the next one 20:17:15.013 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.014 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.167 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.214 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.414 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.415 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.629 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.630 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.740 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.748 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.749 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.803 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.815 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.816 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.881 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.882 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.885 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.016 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.017 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined [...] 20:17:21.970 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:21.983 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:21.983 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:21.996 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:21.997 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.003 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'userRestlogin' failed for user 268: jsonPath($.tokenId).find.exists, found nothing 20:17:22.004 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: userRestlogin: KO jsonPath($.tokenId).find.exists, found nothing ========================= Session: Session(idc.benchmark.Mix2024,268,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@5bf3bdd9, username -> user.5420888, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@115986e, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758050242002))), password -> Pa_ssw0rd),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@30f5a68a) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: Content-Type: apppliation/json Accept-API-Version: resource=2.0, protocol=1.0 user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 X-OpenAM-Username: user.5420888 X-OpenAM-Password: Pa_ssw0rd accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 200 OK headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache set-cookie: amlbcookie=01; Path=/; Domain=openam-perf-haproxy.forgeblocks.com; Secure; HttpOnly; SameSite=none content-type: application/json Content-Length: 5283 date: Tue, 16 Sep 2025 19:17:21 GMT x-forgerock-transactionid: d4d7ff95-137e-4a57-ac81-98500ba32aac strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJiMzQ4ZmZhYS1iZjMzLTQ2OTItOWYzNC1mZmQwN2NmMzRiYWMiLCJvdGsiOiJibmR1aG44Z21pZTI4bnI2MjlqaTFpbmM4ZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1TVRscEtPRk53TTJkVlVGSXdhVXBtZFU1cVdtaG5MakZPYTFad1VYWm9jbEJ3VVhWTlRGbFZiSEJRT0VOTVkwYzRSVUozUm1wa01VcHRTV28xVVZwbVVYWTVhemxMWHpCalVYUnpjRWczVVZKRU1sUTRlVzFwTVVoTVVsUkdWblZpYTNSMGFXODRUR1JYWWxGTGFucFlZbnBrWm5Kb2FUZEZhRXBQYm1WTVZFWm9ZVU5uYW0xWFNUQlRWSGcxVldjdFdWcGpkbTlsZUdwRlpIVjNaV3Q1VlRKdVRYTmtaMEpXYTFSc2IzSk9TMGN6UlhKRk9WZHpiM1JNWTNOaldqbDZPRkYxVWxsZk5uWklWR3Q0TUhaWE1VZHhOMUZsU1VkdGVrOWtUa2hWWWtoMVkxZE9RbFJRZUhwNVdIcDFYMUZaYTA0dGRVVlRibXAyUW5ka2FVRjRTMmsyYm1waVVYZzFkSGN0VERKd2RrRnZUVXAyYnpab1VYZFpabDh5YjFsMFdXeHRSM0ZKUlhGbWVsOXJjSFZMUkc1NWJVOUJjMmN5VTFKSU5IQXhkV3QzUmtwMFh6WXdOekpKYm5wV1JpMU9aVTVVTlVWUU16WlNSemt4VnpGbVlqZ3paaTFWV2tOTFpHZDZha3BGYURGVVpXZHpkak40UVRKcFh6TmhOVWR1VFZGb1VIRlFWMVU0T0ZsdFptTlBTelpZU0hSQ1VrMWFjVWRYVFZJd2EwaFlhalJtUW05QldXcHhXRlEyUm5Vd1ZHcG5RMDVRWTNCRlVqTmFOakJZWjNjd2R6UlpTSEZoWTJjeWJWOWZUblZITWpOTVowbEtTek40TlZkb2FWVnZWRk5NTTNVd1dsWkVSelZZWVZwSWFEa3RUV05NUkhkUGJUTkdVMGR1WjFsWlJEUXpZVUYzTkU5R2NuZFRhRE5oZVhaU1JFaGFOV3BMTFVRMU1tSlJjVnBuY0dkV1JVZHdTSE55V0ZSamNIZzNNVzE1T1dwb2VIWjBkVzlwVXpSMmVXNVdaVXhUT1RsTWFuZGhURXhvZDFGSmFGWkpURzU2TVRoS1RVSndTSFJLYzJWNWFXdDRRV0V0U21NNGRYbEpWR2RNZFRBeVJEaGphVWsyYkVOeFJtY3hRVkJyWld0SlZrb3lOMkpEVkU5UWJHRkRhbTVwTkhGcGJHNDFWRVpwYmtwZk1XaFBSM0ZqVmxsSWRXNU1jR0ZKT0VaYWJqbExTaTFJUld0U2MxSmtWRkV5YVdsek5IRmtSRWRWYURFMldITktkR2hqZWtWNk9FRjJWM2c1T1VaUlluaGFOV2Q0VmtaVldrUkJhVFJTWVhkUFMzbG1jRFJhTWpsUWFqTlJiVU5VVjA1TGFHdDNYMDQ0YVZsWVZHTk9VVzlRUVc5U1YwaFpaSFp1WkhKMWVXZHhkVnBYUzB0emQxRlhSRVF6WW5vMWNTMVdSMVZKVm5NM1NrcENNblY0TVZWR1gzVTBWMnhRWWxCWGRFRnVSbm8yUjNOUmNHOVVjVTFUTlRGV1VVTldVWEZxT1hGWFZsZGFhemcxYzBWbWVETkZSWHBxU1hGNWNYQklZVFI2ZVZCWVMxOUpNRmQ1WkhsRFJtdGtPV3hvWVhacFEwVkZWelpEYVdaV1RqQmZhMFE0U1dnMlkwZG5ibnA1VVU1V1ptWTRhQzAyVlZCdVdsbFBZMFJtYmpaWlUxTlJaMFYwYlY5M2MyTk5OM2RtTUZodFJXMWhVbmM1YkZKS05GWlZhM0pJUVZkSU5WbENkMFpNWDJWaFJtOWxSM1ZmUkVwM05rTm9iemRUTnpZNFJuaFhWV1Z0UlRBeGVqUTJNbEo2Y0U1NFFXVmhjazV2TjA1MU9EZDZPR1E0WHpkTlgxb3hUM1pLY1ZkT1lWQlpTamQ1U0ZkZlVHdGtabkJJTVhOUFFsZG9hRFp3WVRkWE4xTlpOamxxYnkxMFdqTmhNVTVKYXpCa2EwSk5lREJQWjA5SFZEWmlOVzV3ZW1wVk4yOVBNRk5OVUdaWVVraHpWMEZ4YlhsM1VXbGtkREJpT0VKQ1dWOUtWRWh3TFU1a1NUbGxjMWRtT1dKU1pFWk1USEZ6WW5kNmRVdG9Za05aVVdNM05GZHFXbXQxY1hadlVXVmhTRVE0ZGtseE5GbHplbHBqTjNsZk1tbFZhalE0Y1doQldsVnZha3BMTmt4bVUycHpYemc1ZGtZM1pteEVTSEZGTUZjMlJFVnNkVTlIZFdKeU1qQjJWWFptY1Y5eVpqUk9TMnhST1ROU09FZzVaREJFUjJOblh6TjBOemN3TVhOZlIyNUhXVnBKVjFwTk9GRkdkR3R3ZDJJelFqWkRZMWcwZEZrdGNqZDRNV2xGTFRST2JXOTVWMDVUUjNkcmJ6TkxPVzVQUVdFdFltVnBTVXB4VEZwaVFXSTNkVTVNVWtOa2FIY3hjSHBIZG5wNFN6UkZVV3htVXpNd04wOUJRbVUyZUVKTlN6Vk9ibnB1UldJMmRuSkZTbWxxYVZkTlgyWXpjbUoxVFdJeFJVdHhSbFZSVG01aVJtWnNjR3RLYzIxU1oxRnZjRkYyTVZKUmJWQmtkRzB0U3pkbGMwaGlWRWhtVkhaUFkzQnRkbVZoTm1SZlZsZDBOekEzUjBsbk5raGpVSEV4V0hCaGNEUnZZbVZmYzJkS01HRkpSRkJHYzJaRmFqTTJWMUZ6UVdSM1MzZGpkMUpXY0hock5HMTNkWFZUWVhaQmExUkVMWE0zWms5R2MzWnhUa3N4UkZSVldsSkZPWGRJUkMxbFNFdDBlVEZYYlRCeE9HVjVkak5KWlZwemVrZFNSVWd4UlVGRE5XcE9lVXBSVGxWT2FYRnNjblF4WXpGRVFVVTNlVU5SWW14blVrcHRha2d4VlhwallqZDZYMDgzZVZrNGRFTXpTMkZYT1ZGeUxUZG9SVWhMTWt4MVowVjBkblppTWtSNldscElZbkpWUkdKYU1sWXhhRlY0V0hCUFJGSkdlRVJ1UzJZMmJHRTFOSFk0Y2pjNE0wNUlOMVprVFdOaFlubExVWFZYU21kQ2JHeFZlWEpoZW5NNE5VeEpaa2hMVlZkbU9HbDVTbHBQY3pNMmVuRjZNMUp1TVd0Zk1rVlZhMWRqVjFabE1YbDNha1JHUWtzM1RXOU9kVVpYUTJ4aU4ybDNYME15VVd0RlRtOVNNVnAwTW5WT1RWTnFSVkV0VURsaVZGZDBZbGxMVXpSWVNtTkxkbGw1WlhwVllTMUdkRzQwV0VwbE1EVkpSalpYYVdrNE5HRTVjWGhYYmtWa2RYQjVWM0poYzFacGVHNVhjazFTYVhOMGFHZHFUM1V5Umpaa01ETjRhRGw0TWxwVGVrUnNXR1ZSTW1OWlUxZ3RiblJYV2xkcVRHRk5WRVF5V2s4dFNIRnhaRlZaVkZwYVZFSnFTRXAzYkdWdGRVTkxObk40UmpWNVVrNHpSVTlFVFc1TFFsOXZaMUIyZDFKR1UxSjNNM1Z4YW5vNWNIaE5RVmRLUVZwek4xOW5SemRSUzBadFdUbFpkblpCUWt0bkxUTjFjbEF0YjJ0NlRIVjNkM00yZUhkTFdHUTBkVlJMT1ZKSlNsaGhlbEpFWTNveVZXVjVRM2RNVmtWcGEzTkRkSEIwTmxSaVVFbDRaa2R1TUZadFgxZGpXQzFIZWxkcGVtTlhPRll4VDJOQlEyazNaeTUyZHpaalVUZGphRzQzVTA5NVptRkxRbXREVlhkMy42bThOR1RaZkNsa0JoSy1MWEREZDRSLXJqdkk5UTF4QnYyTGVfRTZZY3RzIiwiZXhwIjoxNzU4MDUwNTQxLCJpYXQiOjE3NTgwNTAyNDF9.wxDIvSCb1hZdQdQB7djZVFUWkxTaWKxN8Y4M7Ce1_Eo","callbacks":[{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/updates"},{"name":"prompt","value":"Send me news and updates"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken1","value":false},{"name":"IDToken1validateOnly","value":false}],"_id":2},{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/marketing"},{"name":"prompt","value":"Send me special offers and services"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken2","value":false},{"name":"IDToken2validateOnly","value":false}],"_id":3}],"header":"Please select your preferences"} <<<<<<<<<<<<<<<<<<<<<<<<< 20:17:22.004 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:22.010 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.010 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.023 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.023 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.036 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.036 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.038 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:22.050 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.050 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.060 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:22.063 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.063 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.076 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.076 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.090 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.090 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.103 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.103 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.116 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.116 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.130 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.130 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.134 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:22.143 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.143 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:22.156 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:22.156 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 2025-09-16 20:17:34,527 DEBUG --- stderr --- 2025-09-16 20:17:34,527 DEBUG 2025-09-16 20:17:34,527 INFO 2025-09-16 20:17:34,527 INFO 2025-09-16 20:17:34,528 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- tail -n 1000 /results/orders/benchmark-300/stdout.txt 2025-09-16 20:17:35,273 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-09-16 20:17:35,273 DEBUG --- stdout --- 2025-09-16 20:17:35,274 DEBUG [print_head_tail]: Print head (80 lines) and tail (80 lines) of input string (1000 lines): 2025-09-16 20:17:35,274 DEBUG ----- output ----- 21:17:14.207 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 21:17:14.211 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 21:17:14.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.214 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 21:17:14.216 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.216 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.217 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 21:17:14.220 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.220 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.222 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.222 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.225 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.225 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.231 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.231 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.233 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.233 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.233 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.233 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.234 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 21:17:14.236 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.236 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.238 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.238 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.239 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.239 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.240 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.240 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.240 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.240 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.248 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.248 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.250 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'userRestlogin' failed for user 1074902: jsonPath($.tokenId).find.exists, found nothing 21:17:14.250 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: userRestlogin: KO jsonPath($.tokenId).find.exists, found nothing ========================= Session: Session(idc.benchmark.Mix2024,1074902,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@565ab127, username -> user.1313807, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@74ac2d00, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834249))), password -> Pa_ssw0rd),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@5b057c8c) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: Content-Type: apppliation/json Accept-API-Version: resource=2.0, protocol=1.0 user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 X-OpenAM-Username: user.1313807 X-OpenAM-Password: Pa_ssw0rd accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 200 OK headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache set-cookie: amlbcookie=01; Path=/; Domain=openam-perf-haproxy.forgeblocks.com; Secure; HttpOnly; SameSite=none content-type: application/json Content-Length: 5283 date: Tue, 16 Sep 2025 20:17:14 GMT x-forgerock-transactionid: 444c0760-de7c-48ee-af07-67f14efb8e01 strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiIxYTc2MWJkZi0yNDc2LTQ3YzMtYWMwMy00OTU1NTRlZTAwYjUiLCJvdGsiOiJnbG1oOWl0dGh1amNhZDQyNnJ0bWljZnIwZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1TWRXODFUMFpEYUhoWGFFMTFjMjV4V2pKQ1JIQkJMak00Y210cU9GbG1ZV3R1Ym1KVFZYWlpWRzF3TTJzeFVWSnpibFZ4Ym1vM2RsYzFYMFpvTkRrM1JGSjVjRk56YkZoeVlXVlVMVmd6UTBreE5IZFhUWHBwVWswMWVHaElXa1p0WjB0M1FsOURWWE5MTXkxbmRFWnVVMmxDZERKQ1YwVmpXVUZ3TTFFd05IWlhkME5yYWpGWlVWUnhOazV1ZUZSTlMzUXpWMkk0Y1ZwZlRsUnZWbEZtYldGbVNuSldaR0ZDZEROTWFXOXphV3hwWlZGNVFUaFRTMHMzUTNZeVIyUkRkRk5yWlZFM01uTkZWbnAzTmtreFMxaHZWa0ZWYW1ObFgwMWxiVlJUWlU0M1VYcG1SSFJCWTFvd2QwTnhiMUY1WmxwYVlYbHBWakZ3UmxCVVIxOXpVekl5VFV0a01qTjBiMnRFY2xwQ1JUTmZiRnBXVFZOME1XVmlOREF5T1RGQlJuY3lUek5xU2xrM09ITnRibXROVEd4R2RreDBNR0V5TWxKNldTMUdkMDVmVVMxdU9IZHpUbmRwU1VONk1EVmpOWFZmWlVkS2FHVldPV1ZUT0RsaVlVSjZVVzlhVUZjMlNHMTRZek5uYzNkc05VaDZVRGszV2w5NVQzZE9NV3hTYkdZNVJqVXRiRXBYVXpsT1ZrcHlSMWhVYTFjNE1tUXlkWGhaZEdGUFpGbHZRbUZLU1hSQ01tZE9SRmN6WW5seFFqUlJUVXBuV2xoSlRVMUVZVzg0YkRkT1ZTMWhRbXR6V2tJdFlVNDVabGt0YUZkR1NsUlVRWGsxZGpoMk1tSXlZV3hxVlc5eVlqTklOVWxPVTNJNGJXWlFRbE5rV2t4bk1UZDFlSEJVVW14TFZGZFhSRFo0WW01NWNqbFJYM2hrTVdzMmRuSTFjekZIVTNSQ2FFdzViRUZyVGtwalQycFhORkYyV1VsU05FZGlaVjluVldaaGQyTjRZMFZhWm1Kd1RuVkVURlpQYTBSeU4xb3pWRGxpTWtORlZHdEhlazVNVTBoWE5pMUxUbWRzVDNaV1JteDBVSGxZUjJ0blJWOUtla0pMTkVFdE5DMXVaalJRVUd0eWJVeG9ZVE5GVDJKNmVHUkZkVmMwUjI0eVkyYzFSVEJtY3pack5tWnhXbkZNTTFCa2JVUlVkVlpUVTJacGFYSnZSa1IxTlc5SVJISlplRFZITTNoYWRXWjFZMnRUZURCNVIwWnZSR2hEU1ZCd1IycHdVR3BwWW1kWFYxZE1TMFk0ZUdOVlJqYzRNM1JKYkV4TWMxTkRURkU1U1VOQ05DMTBXVXRFUkV0YWVGbFNaMmRCV0ZKRVVWVmtVV0pmUVc0elgzbExkVFZmVFRWTmVscEllRVpFT1UwNFMwSkhNR1IzVXpkTlEwOXVZVXhQZGtwYVVESlFYekZQY2xSWE9WaHZhazB4TjBOWFREUTVkbkF5V0ZCNFJuZFRWV3hCUkhsd1JGSk9UMVV6VkhOWGVVcEJaR05yTUZrdFdGSmFYMlJ0YVhaTmVteFNWVmhqWmpkNFV6ZGZNVlprVVhBeVNsbzNWMGxVVTJkTlprRnFZak0zY21Sd2RHUm5WbGxLWTBwb1VWWlhiMVo1TFUxWlF6ZFNWMFZtWDFOcFgxRnRVM0JUVTJkNFduSlJVVXR6VDA5blRYSk5XRU50V1U0NFVGOVJkM3AwTTFsTFJGWkxkRzlJVDJKWk5VUTROVmN6UjBsYU9XZEpTRUZpYzBVMlFVNXZPRlJDYldORVVFcDNkemhVWkRCNGJHTm1WMHBLVjNWNlRsY3pOa1UzTFMxMVN6QkRaMGc1VjB0clNYTmpaRUZ6ZVMxc2NuWmZXR0Z1Ukd4RVMwVkZWREF3YjFaRlIzbHRWa3QyTTNsdlFWZGxkRU14ZW1KbFFubHlNbFUxYUUwMlIxVllXakZTV1ZKMmQwVm1ibTVQWDJwWVlsa3dUa2MyWlZJNGVqRndORzFTUm5kaGVEVllNMmwxTFRJeUxYQmlhRXhoZVVoUVltWndiRWhsVjFwMGFVeFlRME5LZWtoRFVUSjFlVEpKZHpGWU1YZGFkVEZRT0RkbmVYTlBlWFYyYlhvd1JHeElSa1ZFY0dJeWVXVnVjMEZZVjJ4c1EzTXRjMU5OWm1wd1NURlNXa1JwYUhaR1JIVkhVWE56V2xvNE1VMW1lblpKY0RWQlNXdE1UWEZLVm1reU9GbHBWVTgzYTFaSE5EZzFXbWcwY210d1ZHRXlRVTF2VWsxUE4yRnpRVzFRV20xbGNqTjVTRWhLYW14UGIxbElTa0YwZVZaRmRrdGpWVWxLTXkwMU9DMUJUbVJtYjBGeU4ydHNXR1E0U0c1T09FWklTakoyYkhveGNHcFZTVXhyYmpZemFsRndWV1l6VjBKV1FWZzBNRFV6VG1jeFZuWkphM1IwTFVSeGMzQlBlR2cxWldWMWVrWkxhV0UyZFhwMlkzQmZUWEZYTjBSU1NsSmpjM0poY1U5NFV6RTBNbVJaWDBkdGIweHNUWFZ3YjJGekxVcFdNRmxDYkROVlpVMDRTRmxWVEdOVlYzTnNORU5SV1VOeExVNTNVVWc0VldSM1dWbDZSVTF5WHprMVEwZFlNM2MwTjBJMlVVdFZSVzF2VjI5dFUyc3hZMGhhYkZwR1FXdFBTR3RwV0daWGFIazVja2s0UVRnNE5WcFVVbGxYTFhNM1JUTTBiM2cxVTFsNWVrMTNRV3BMYzJNNFNUTktabFJQUlZWV2JHaDJabGxOV1V3emRqQktTVlprYm5kYVgzWnljSE5DVkc1dFFXRk1jMUZyT1ZrNVVXTm1aRTlRUTFSb1NYbHRaMjl1VVcxb1JHWk5TVUpGZFRGaGNESlhXbTh3TVdSYVYwMWtkM1p0WVZOU2EyeENhbmhhZEhsVFJHOU5hbFp3V25CQmJURjFWemRoV1hOMFZsaHNSak5pWmpKUk9WaHlRbGd3ZGpNMFJqZzNlbWM0U1VocFJXMVhRa2hxYVdSTFYwcFVWWE5vZFhkd0xXWjZUMVpYWm5wSVRqaElWRUp0UVdST1pUSmFNbmQwYVRWelVHOUpZa2RwWTNCS01WWnhiV1JZZWxWcFJGRTFkVE5GTURkTVIwZHJWMnN5V2pKblVUTldVall0UW5oeE5EQm1SakJyV2pKRmJqZEdTV3R6ZDAxVFpqbGtNWFZIVjBScGIzQlNVVko2TFVnM1ZUZzBaVFZTY0ZsNmJWbEhWSFZaUWxsNWJYSkdUbkprVUhWWGN6aDJNSHB0Y1ZkdGJWWXplRkZTYTFsTGNERktkVXBYVW5Rell6RnVRV0ZITmpKWGFUWnFNRXhyWTBsWFUwOU5UVUkwVFhsV1VtazNZMDlRYW5vMlJFUmtjelZ5WkVOS1YzSmlNbDgzZVV3eE4wdDBaVmRYUTI1UGFUUlZURkJsTm1SeE5VUnZUR3RHWlVSeFpFRndTek5yVlc1bllXcEtkM0Y2T0cxSU9XRkhkR0pzU0UxSVpISmFVRXhuVlU5UlFtRndUR28xVkZCa1FWbFdlbWM0WTNFek5FaElNV0pUTmpGeE1FSXpTR1ZwYUU5TE1uaDNTMlpCVFZScFZ6TXlWM2hoWXpGb1lYZDRja3hzVWtkc2JYWlFWM0JUZDFSa01IUTRNRkpoWDFsdmJFeFRRUzVoV2pSS2RucGlNRU5rUms1V2RuWk1kRzVLUzIxMy5fVmdJRS1DYnhrSF9Xa1BYNmo0WUFfU0R6RF82LXJZejJwaEctTG1UN0JzIiwiZXhwIjoxNzU4MDU0MTM0LCJpYXQiOjE3NTgwNTM4MzR9.oRDJ9G5wsuHnNmwuMcLcC_QBV9li6sEt7gjn-fyxNlU","callbacks":[{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/updates"},{"name":"prompt","value":"Send me news and updates"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken1","value":false},{"name":"IDToken1validateOnly","value":false}],"_id":2},{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/marketing"},{"name":"prompt","value":"Send me special offers and services"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken2","value":false},{"name":"IDToken2validateOnly","value":false}],"_id":3}],"header":"Please select your preferences"} <<<<<<<<<<<<<<<<<<<<<<<<< [...] <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI AM validateGoto: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1074963,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.9970479, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@57058c6e, gatling.http.referer -> https://openam-perf-haproxy.forgeblocks.com/am/, callbacks -> {"tokenId":"d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834505), CookieKey(d0d18cac672abbc,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834505))), password -> Pa_ssw0rd, fake-ip -> 172.93.109.81, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3489b05, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@1bdb2a9d, tokenId -> d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/64.0.3282.140 Safari/537.36 Edge/17.17134),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@12dae582) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Accept-API-Version: resource=2.1, protocol=1.0 referer: https://openam-perf-haproxy.forgeblocks.com/am/ accept: */* cookie: amlbcookie=01; d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-perf-haproxy.forgeblocks.com host: openam-perf-haproxy.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.612 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI AM validateGoto' failed for user 1074969: j.i.IOException: Premature close 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI AM validateGoto: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1074969,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.8106827, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@16248682, gatling.http.referer -> https://openam-perf-haproxy.forgeblocks.com/am/, callbacks -> {"tokenId":"ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834516), CookieKey(d0d18cac672abbc,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834516))), password -> Pa_ssw0rd, fake-ip -> 208.154.179.41, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@b967030, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@535ece78, tokenId -> ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Linux; Android 6.0; Nexus 5 Build/MRA58N) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@5b7ea70d) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Accept-API-Version: resource=2.1, protocol=1.0 referer: https://openam-perf-haproxy.forgeblocks.com/am/ accept: */* cookie: amlbcookie=01; d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-perf-haproxy.forgeblocks.com host: openam-perf-haproxy.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 1075043: j.n.c.ClosedChannelException 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: restLoginInitiate: KO j.n.c.ClosedChannelException ========================= Session: Session(idc.benchmark.Mix2024,1075043,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.8071955, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@b4c95d6, fake-user-agent -> Mozilla/5.0 (Linux; Android 8.0.0; Pixel 2 Build/OPD3.170816.012) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36, password -> Pa_ssw0rd, fake-ip -> 125.114.146.189, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@4981d9e0),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@12dae582) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate?authIndexType=service&authIndexValue=Login headers: accept: application/json content-type: application/json user-agent: Mozilla/5.0 (Linux; Android 8.0.0; Pixel 2 Build/OPD3.170816.012) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36 X-Forwarded-For: 125.114.146.189 host: openam-perf-haproxy.forgeblocks.com body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 2025-09-16 21:17:14,699 INFO Gatling simulation run ended successfully 2025-09-16 21:17:14,699 DEBUG No archive name provided. No archive will be created 2025-09-16 20:17:35,274 DEBUG --- stderr --- 2025-09-16 20:17:35,274 DEBUG 2025-09-16 20:17:35,274 INFO ________________________________________________________________________________ [2025-09-16 20:17:35] benchmark-300 show_cmd : Display order command ________________________________________________________________________________ 2025-09-16 20:17:35,274 INFO 2025-09-16 20:17:35,275 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-09-16 20:17:35,275 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-09-16 20:17:35,561 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-09-16 20:17:35,561 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:35,561 DEBUG --- stdout --- 2025-09-16 20:17:35,561 DEBUG overseer-0-57d79d468-khs5t 2025-09-16 20:17:35,561 DEBUG --- stderr --- 2025-09-16 20:17:35,561 DEBUG Checking if file exists on pod 'overseer-0-57d79d468-khs5t', wait max 3 minutes if not. 2025-09-16 20:17:35,562 INFO 2025-09-16 20:17:35,562 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- bash -c 'if [ -f "/results/orders/benchmark-300/cmd.txt" ]; then echo "/results/orders/benchmark-300/cmd.txt file found"; exit 0; else echo "/results/orders/benchmark-300/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-300/cmd.txt file found" 2025-09-16 20:17:35,562 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-09-16 20:17:36,098 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:36,098 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:36,098 DEBUG --- stdout --- 2025-09-16 20:17:36,098 DEBUG /results/orders/benchmark-300/cmd.txt file found 2025-09-16 20:17:36,098 DEBUG --- stderr --- 2025-09-16 20:17:36,098 DEBUG 2025-09-16 20:17:36,099 INFO 2025-09-16 20:17:36,099 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-57d79d468-khs5t -- du -k /results/orders/benchmark-300/cmd.txt | grep "^\d+ .+$" 2025-09-16 20:17:36,099 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-09-16 20:17:36,646 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-09-16 20:17:36,647 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:36,647 DEBUG --- stdout --- 2025-09-16 20:17:36,647 DEBUG 4 /results/orders/benchmark-300/cmd.txt 2025-09-16 20:17:36,647 DEBUG --- stderr --- 2025-09-16 20:17:36,647 DEBUG - Download file (size 4kB) source : /results/orders/benchmark-300/cmd.txt @ overseer-0-57d79d468-khs5t destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/cmd.txt 2025-09-16 20:17:36,647 INFO 2025-09-16 20:17:36,647 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-57d79d468-khs5t:/results/orders/benchmark-300/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/cmd.txt 2025-09-16 20:17:36,647 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-09-16 20:17:37,462 INFO [loop_until]: OK (rc = 0) 2025-09-16 20:17:37,463 DEBUG --- stdout --- 2025-09-16 20:17:37,463 DEBUG 2025-09-16 20:17:37,463 DEBUG --- stderr --- 2025-09-16 20:17:37,463 DEBUG 2025-09-16 20:17:37,463 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/cmd.txt is small (1 lines), printing all lines: 2025-09-16 20:17:37,463 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-haproxy" --results-folder="/results/gatling/benchmark-300" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 show_rc : Display rc order ________________________________________________________________________________ 2025-09-16 20:17:37,463 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/rc.txt is small (1 lines), printing all lines: 2025-09-16 20:17:37,463 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 show_stdout : Display stdout order ________________________________________________________________________________ 2025-09-16 20:17:37,464 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/stdout.txt is 2010 lines): 2025-09-16 20:17:37,464 INFO ----- output ----- NOTE: This file was too big so it was truncated. Only first 1000 and last 1000 lines are present. ------------------------------------------------------------ 2025-09-16 20:16:53,166 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpajhhfz26 2025-09-16 20:16:53,170 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode --quiet -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-300" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-haproxy.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-haproxy.forgeblocks.com -Dlogin_cookie=d0d18cac672abbc -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd System property think_time_multiplier not set. No think time emulation will be done in the simulation. Simulation com.forgerock.pyrock.Loadtest started... 20:17:14.802 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'authAsPolicyAdmin' failed for user 1: status.find.in([200, 209], 304), found 401 20:17:14.815 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: authAsPolicyAdmin: KO status.find.in([200, 209], 304), found 401 ========================= Session: Session(getToken,1,Map(gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@60e57377, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@32cbef7c, gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, 607c1adb-ea30-44c5-bd47-b1534e1d666d -> 0),KO,List(ExitOnCompleteLoopBlock(607c1adb-ea30-44c5-bd47-b1534e1d666d)),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@52e7a2fa,io.netty.channel.epoll.EpollEventLoop@f79a760) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: X-OpenAM-Username: policyAdmin Content-Type: application/json Accept-API-Version: resource=2.0, protocol=1.0 X-OpenAM-Password: Pa_ssw0rd user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 accept: */* host: openam-perf-haproxy.forgeblocks.com content-length: 0 ========================= HTTP response: version: HTTP/1.1 status: 401 Unauthorized headers: x-frame-options: SAMEORIGIN content-security-policy-report-only: frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline' x-content-type-options: nosniff cache-control: private content-api-version: resource=2.1 expires: 0 pragma: no-cache content-type: application/json Content-Length: 62 date: Tue, 16 Sep 2025 19:17:14 GMT x-forgerock-transactionid: 40410fe5-4739-4fce-b69d-a0868aadfb69 strict-transport-security: max-age=31536000; includeSubDomains; preload; x-robots-tag: none Via: 1.1 google Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 body: {"code":401,"reason":"Unauthorized","message":"Login failure"} <<<<<<<<<<<<<<<<<<<<<<<<< 20:17:14.818 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-8' crashed with 'j.u.NoSuchElementException: No attribute named 'policyEvalTokenId' is defined', forwarding to the next one 20:17:15.013 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.014 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.167 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.214 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.414 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.415 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.615 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.629 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.630 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.681 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.740 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.748 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.749 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.803 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.813 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.815 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.816 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.881 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.882 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:15.885 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:15.949 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.016 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.017 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.017 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.083 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.083 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.144 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.149 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.150 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.216 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.217 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.283 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.283 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.349 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.350 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.396 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request EvalPolicy: No attribute named 'tokenIdCookieName' is defined 20:17:16.417 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 20:17:16.417 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 20:17:16.469 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'userRestlogin' failed for user 18: jsonPath($.tokenId).find.exists, found nothing [...] Session: Session(idc.benchmark.Mix2024,1074778,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMTc5ZTM0ZTYtODljYy00MDcxLTg2MDQtZjNlNmFkY2U3ZmVlLTE3NzYwNDY3MyIsInN1Ym5hbWUiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLWhhcHJveHkuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIvcmVhbG1zL3Jvb3QvcmVhbG1zL2FscGhhIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiNWdvR183TVN3TzlLWUI1c2Z2NWhnTTZxVVhvIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiZW5kVXNlclVJQ2xpZW50IiwiYXVkIjoiZW5kVXNlclVJQ2xpZW50IiwibmJmIjoxNzU4MDUzODM0LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzU4MDUzODM0LCJyZWFsbSI6Ii9hbHBoYSIsImV4cCI6MTc1ODA1NzQzNCwiaWF0IjoxNzU4MDUzODM0LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJ3c2JuUndqZlZldHM3TDhUczl3X0dpcUYyMzQifQ.Fo4z599deZ1ANS7XVhwtlEp8zzSwjQmGvscr0vIK20g, username -> user.9321600, access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNzAyMzM4MDYtNmI5MS00ZWY0LWEyMDctYzZkMTczOGI3Y2VmLTE3NzY2Nzk5OCIsInN1Ym5hbWUiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLWhhcHJveHkuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIvcmVhbG1zL3Jvb3QvcmVhbG1zL2FscGhhIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiUElGQ1FDdm1Hd21lRGUxM2tNTlVVMGhaYlFjIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiZW5kVXNlclVJQ2xpZW50IiwiYXVkIjoiZW5kVXNlclVJQ2xpZW50IiwibmJmIjoxNzU4MDUzODM0LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzU4MDUzODM0LCJyZWFsbSI6Ii9hbHBoYSIsImV4cCI6MTc1ODA1NzQzNCwiaWF0IjoxNzU4MDUzODM0LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJqQ1RXeFZ0a05PSGQ1MGI3Z0QtbTd3Ykp2RW8ifQ.K9PByrbXuwu6hD7utbS0CJcTS8lmAFtrO_41CzmRZeU, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@21dd7fa3, gatling.http.referer -> https://openam-perf-haproxy.forgeblocks.com/am/, authcode -> Sor6xO54f0smSC0z12AHyFq8P_o, callbacks -> {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJkODFmODY4NC1hMWEwLTQ5MjctOTMwYi0zY2YyNWZlOTQ2NDkiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiaThwanZhdmU1Ym9pbmgzZnM2MzU3b3FwMmwiLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1dk0wUmFUbHBxTTNrMFZtWmxkVFIwYUUxTGNVdG5Ma1pCT0Y5QmFFZG9kblJTZHpkTGMxUlVPV2t6UldNMGIzVlRlV3AwV1dOMFNESmlPVU4yUVU5dE5FYzFOekUyVlZkeFNrOUphM1E1TUZCcWQxQk5kVWQxYTJOR1ZGSkpMVlZVVFdOeWRVdHZTMlZNWVRCeldETlFSek5VVDFnd2NXMTNhVzlLYkVsMkxWTjZlVE42Vm14eFVqQlhZM2R1Ykd4TU1tVmhjelJGUVdwNlJWSkZUV050UW1sTk4zWmhMVTU1T1hCaVNWVkxaeTFEYzBOMlVERnlaVmhWZDNad1RqQk5URVZHZFRWc2VscFpaREpIVEc5UmRtWmZObTVGUkZwRFkwVjJhVlEwZFdjelJuZEVWVmRtUkdkQ04yYzJVMDVTTFVOelIwOTRYMXBxYlV0Zk0wMUxVRVJ3T0ZsYVVHTTBRMWw0TmtwU1VpMVZXVUp5V21sUlMycEdUVEJGT1ZKTlQyUjFhRjk2Wm5ObU1XcDFSbmxoTUhGdlgwbExVSEJSVG0wd2JVNU5UM2g0Tlc1bk5GbFVZVWhZYTJ0ZldXaFRhM1ZzUW1ObFQxTmlZeTFYT1RKM1ZqRnJkV2xxYVVsb1p6ZFZkVTUwV0ZSUFJXVXhjMUpHT0ZaWkxVVkNOM2xXTFVkbU4ydE9TM0E1TkRSc1IydHRRVzVLTUhBNGRWQTJZVzkzU21KdGNFeFZORWN4VGxWNk0xUmZURWhVWkZoM2VtVlhNMDFtVEd4Q1FqTmtaRE5tYlVOMFJFaGhXWGRaUm5oUlJHeE1Rbmx4TnpJNGRsSjJUMlowUkZkaVRXeHRZMjAwWm1zeVNVOWZMVXhJU3poRVRFNDRXbHBuWDJaTFl6ZGxhekY1UXpnd1ZHZzRXbU5OV1VaVlYxcERhVTFSU0dOa2MzWnFOVFl5TUhVNE5rbEZjVUYyTkd0S01tY3pkVjlOYzFGa1YxcGlabXd6YUVseFNtWm5kbXhVTlROWlVsUkJRa1pLVm1GWGJrVXRlV0YzZURKbGVYQjVTemR5VEUxUmQwc3dTV05oTFhBdFVHcEdRME13TlhOV1RFNVhaRFppZW1JMVZVNHlWVTg1T0dNNFdHaE5iSEpoYlU5ME9EaFFOMWhWWDI1dFlqWTJaM2hJV1VRd2NVZFpSSEZCYVRkTWFuVk9UVE5LYmxWRFlVaFpWR2xLYUhoUGVGZzFUVFJmZGxoU2NGb3llSGh5Um5NeFJYQlhhRE50VkZoV1N6RmtSMUp5VFMxUlZsSjZjVXBNVVV0eFFVNW5ObnB4YkhCclNGcHlNMHBHT1ZOZmRtTjJiSEprWW01RVpGVlRRV1IzT0ZvME9ESnRORzlMVjNVM2VGcE9ZWGRqY1hGZlVtUm5OVTFMT0RBelNVNTZVbDlGUVdwRlYxazFTbWhpVEV4VU0yRkNURGhQVkdremNHZGtOVTU1VkZwNVNsbHZNekZsWTFCallWWm1TMmhRWVZoeE1tUlpSMGxDYm1WWVZHZG9kMmhQTVZGeGNrSnJSak14VlZkR2FVRkhZbGxNZERCWE5WVnFlRTFNUjJSZlREVktTMnhpWkVKQmRGTmlZMWgwVEdWMWQxQjBXVmhDWVZSRlJVcGxVbVJIUjNJdFRGb3Rha2RXUXpaVFpsRTViazgwYjNkbllWRmFkMVpZYjJ4WVdEWkdVR0pPVVhWTFdUQnhUWGgyUzNKWE1WVkZVbTU0U1ZoVWVsZDJiVmxwY3pkM01ESmpNbWhIYVZBd05FVnFkSFZDWVVwQ1pHNDVjVUkyV2paVVRXWXlhbU4zZW1FMmJESmthemN4V0dSd1l6UnFVRlUwZEVFMmVVMWlReko0UVRCdU4zUnhhQzE0YjFjek5FRnhXa3BoYkdGa2JXODVZMVZNVWxZNVNtUlRiM2RZVHpaTVJDMXdZMTlpWW1GeExWaFJXazEzVkdwVk4zRTNZMWhxWHpCYWRFNTJlR0Z5WW1GTlFXODBjRzVwYzNOcVEwVklMVGxvTWtORlZVSXpjMVJYV2toa1UzWjBXSE5xVVROdWNtWnNVRkZ2UmtKTVVIVXRVbTE1VmtOS2JHTlRVMU5wWDBkcVJqZDJaMjFXTm05RmVGVlZaREF3VlZoaFJGRlpjMnB5U0hOSFEzTjVORXQ2ZEZWSlJXTnBPR1JNWm5WcFpFaHljVEpGTWxOcFduZENVMjFNU3poQlJqQjBibWh2UzFsTVUyZ3hWVFE0ZUROelJIcHRhM1ZqWTFGdE5tdFJSRlJtTlRkNmFsRmpNMnBhT0daMmMyaG5ORzlXTWxCdGJHZHBWVlV3VDA1UFRFcGhZMHh5YVd4S1pYZDJRblJMY21JNWF6UTVSbTQwY1hSclJUWnphR3BKWm5vMU9XOUxORWx0TFRjd1oxVm5hVjlmWDBwT2RtRmFNMmg2UkVSSk9YbDJNWE5vVVRkbGVGWlBUelpIYm14alpHeHlkbFZEVTFCeFNFcHdWVzlOYjNseFpHMTZVbE5LTTJGMVRqTkZNbE5MZFhac1YzWnlXbXR2ZFRBeU1GaERiMHhPY21Oc2RUSkxTM1pFTjJ4eVVYUTFXbVZJVURsT01XcEhYekpPVjB4VFp6VjJUWFI2ZWxKcGIwaGplRlp6TjFJd1ZuUkNNSFp6Y1RaeU1uUmhhMlpLZG1kdVptd3hOMmhxY0U5bFZ6azRlVlZZWjA5ME9GY3hNazVZV21oeFdVUTVWbVZRUmxwcVRYbzRkbGRtVkZKWVF6RktVWEZLZG5jd04xQkNMVTFCWlVFelNreG1aRzh5VUhaNGJYUm5kVXBITVhKeU9XNVFORUZmWkVWRFRXTllWRUpSZEhGR1RHeFdValYxYUU5dFowUXlVekJPY0VVMVQwOUNjVTlIY2pWSlF5MWZVWHBETUdKYVNVTm1kbUZMT0UxT2JIaEpjMjVYUWpCTE9FVXlWa1ExV1ZSRVdsTTRaVGhVT1VwUlFXTlBhMEZLT1VKeFIwOVVVRkZvZWw5cFpXWk5WRjl0UVU0dFRURlhiWEpTWmxoSWJrZEVWbXB1UzFoclYzZGxTMmhLV1RKTFFrWm1XV2gzWVdwUlRVMHhlbXhQZURsSlZYZHBhbUV5UmtaRVFsQTNjRkI0ZEU1UU0xVklURkZ6WkZKbVJuQm1XVk13YUcxbmJXeE1ObWw1VGxKb2RFRk9hbEZMZFhObGMyOURTaTFuUTNjNE0zZzBSblY0WjBKUldERjZkRFJGVDJweVNqZEdaV1o1Ym5oME1qSTRaMWhQZW5FdE5XVlJNVVF5TkdOc1RsODFYMDFpYjFGVFdYWktjMk5xVFVVdE9HSlVVbkJZYW5GYVl6aHpNbmgwV0hRM2IzUXliVGM0WjNoTlNXUnBRVmRyV0dSdGFrUXhOVzg0UmpoNE5HZDFObFpzUTJSbFZuWjVWMjlUWkY5cWMySkZlbko1YlhsSlFtWlBZbU5CUkZWelFUVnJNMlU1YkRCQk5YZE5Xa0Z2ZFRsS1QyMTFXRVZxVVdsRlVXUjZjR3Q2T0ZrM1NVMDNjelJVY1V0SWFVVnFXbEp3VWw5RVlVVjJWa2h2TXpWdWNraGlMVmcyTVhaVk1tVnFUbEl6TUdkMlFqbDVhbU5XUmt0R2VtZzJaMFUyV1UxUWNETmxXVU0yT1VOVlpsQjZObWM0ZURReWRGOW5SbTlPU1RGTVpqZzNObkZFVkZBelNHWTNiR3AwVmtKdGRsWlhjbFJrUWtaeFJqaHFRVzQwZW1WZlFpNVdjSGRQZFhKTVVqbFBTMjVvVjJwS2R6VnVhbEozLkFXQlc2eWJCZEF0NVoxRXJjZS1IdFZTUlFROHF6bU1CQW5zRFJlX0o4cDAiLCJleHAiOjE3NTgwNTQxMzMsImlhdCI6MTc1ODA1MzgzM30.dIf1wauKQo1xFfGubmcwv0dWE1SGCjrxPKKsrkxrIVE","callbacks":[{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/updates"},{"name":"prompt","value":"Send me news and updates"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken1","value":true},{"name":"IDToken1validateOnly","value":false}],"_id":2},{"type":"BooleanAttributeInputCallback","output":[{"name":"name","value":"preferences/marketing"},{"name":"prompt","value":"Send me special offers and services"},{"name":"required","value":false},{"name":"policies","value":{}},{"name":"failedPolicies","value":[]},{"name":"validateOnly","value":false},{"name":"value","value":false}],"input":[{"name":"IDToken2","value":true},{"name":"IDToken2validateOnly","value":false}],"_id":3}],"header":"Please select your preferences"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834056), CookieKey(d0d18cac672abbc,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(d0d18cac672abbc=OMNlUR-0TVoIN4Q2wRuojWYqhbc.*AAJTSQACMDIAAlNLABxuaU9sRnNRbjdCWEtvMUIwQ1QwMGpndUI0L3M9AAR0eXBlAANDVFMAAlMxAAIwMQ..*,true,false,1758053834057))), user_uuid -> 2a603c6d-4bc8-442b-82fd-b56ea2720a8d, password -> Pa_ssw0rd, challenge -> iaRN1jH-7mS2U7qlIS82DFtUiG6fgqANy07laGLozlw, gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, fake-ip -> 6.83.211.18, verifier -> LTQyOTkwMDYxNjcwOTU2Nzk5Nzk, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@54ee98e5, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@7f567973, tokenId -> OMNlUR-0TVoIN4Q2wRuojWYqhbc.*AAJTSQACMDIAAlNLABxuaU9sRnNRbjdCWEtvMUIwQ1QwMGpndUI0L3M9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/116.0.0.0 Safari/537.36),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/openidm/privilege?_action=listPrivileges headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 referer: https://openam-perf-haproxy.forgeblocks.com/am/ Authorization: Bearer eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNzAyMzM4MDYtNmI5MS00ZWY0LWEyMDctYzZkMTczOGI3Y2VmLTE3NzY2Nzk5OCIsInN1Ym5hbWUiOiIyYTYwM2M2ZC00YmM4LTQ0MmItODJmZC1iNTZlYTI3MjBhOGQiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLWhhcHJveHkuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIvcmVhbG1zL3Jvb3QvcmVhbG1zL2FscGhhIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiUElGQ1FDdm1Hd21lRGUxM2tNTlVVMGhaYlFjIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiZW5kVXNlclVJQ2xpZW50IiwiYXVkIjoiZW5kVXNlclVJQ2xpZW50IiwibmJmIjoxNzU4MDUzODM0LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzU4MDUzODM0LCJyZWFsbSI6Ii9hbHBoYSIsImV4cCI6MTc1ODA1NzQzNCwiaWF0IjoxNzU4MDUzODM0LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJqQ1RXeFZ0a05PSGQ1MGI3Z0QtbTd3Ykp2RW8ifQ.K9PByrbXuwu6hD7utbS0CJcTS8lmAFtrO_41CzmRZeU Accept-Api-Version: accept: */* cookie: amlbcookie=01; d0d18cac672abbc=OMNlUR-0TVoIN4Q2wRuojWYqhbc.*AAJTSQACMDIAAlNLABxuaU9sRnNRbjdCWEtvMUIwQ1QwMGpndUI0L3M9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-perf-haproxy.forgeblocks.com host: openam-perf-haproxy.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None d0d18cac672abbc=OMNlUR-0TVoIN4Q2wRuojWYqhbc.*AAJTSQACMDIAAlNLABxuaU9sRnNRbjdCWEtvMUIwQ1QwMGpndUI0L3M9AAR0eXBlAANDVFMAAlMxAAIwMQ..* ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI AM validateGoto: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1074963,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.9970479, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@57058c6e, gatling.http.referer -> https://openam-perf-haproxy.forgeblocks.com/am/, callbacks -> {"tokenId":"d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834505), CookieKey(d0d18cac672abbc,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834505))), password -> Pa_ssw0rd, fake-ip -> 172.93.109.81, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3489b05, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@1bdb2a9d, tokenId -> d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/64.0.3282.140 Safari/537.36 Edge/17.17134),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@12dae582) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Accept-API-Version: resource=2.1, protocol=1.0 referer: https://openam-perf-haproxy.forgeblocks.com/am/ accept: */* cookie: amlbcookie=01; d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-perf-haproxy.forgeblocks.com host: openam-perf-haproxy.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None d0d18cac672abbc=d5GiDvPGzWngN3X_M11UFQ4RcQE.*AAJTSQACMDIAAlNLABw0bUViWm5PUjVIV0dpQ3R4OS92VVQ1N3Bpajg9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.612 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI AM validateGoto' failed for user 1074969: j.i.IOException: Premature close 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI AM validateGoto: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1074969,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.8106827, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@16248682, gatling.http.referer -> https://openam-perf-haproxy.forgeblocks.com/am/, callbacks -> {"tokenId":"ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834516), CookieKey(d0d18cac672abbc,openam-perf-haproxy.forgeblocks.com,/) -> StoredCookie(d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1758053834516))), password -> Pa_ssw0rd, fake-ip -> 208.154.179.41, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@b967030, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@535ece78, tokenId -> ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Linux; Android 6.0; Nexus 5 Build/MRA58N) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@5b7ea70d) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Accept-API-Version: resource=2.1, protocol=1.0 referer: https://openam-perf-haproxy.forgeblocks.com/am/ accept: */* cookie: amlbcookie=01; d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-perf-haproxy.forgeblocks.com host: openam-perf-haproxy.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None d0d18cac672abbc=ix35j--1ik_b55Mj-N5tA3IsVQM.*AAJTSQACMDIAAlNLABxWcEhjaUJlTlVIaGVSTFRncnRhUjJKVEZDakk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-haproxy.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 1075043: j.n.c.ClosedChannelException 21:17:14.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: restLoginInitiate: KO j.n.c.ClosedChannelException ========================= Session: Session(idc.benchmark.Mix2024,1075043,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-haproxy.forgeblocks.com:443, username -> user.8071955, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@b4c95d6, fake-user-agent -> Mozilla/5.0 (Linux; Android 8.0.0; Pixel 2 Build/OPD3.170816.012) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36, password -> Pa_ssw0rd, fake-ip -> 125.114.146.189, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@4981d9e0),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007bed3c6a07a0@7722353f,io.netty.channel.epoll.EpollEventLoop@12dae582) ========================= HTTP request: POST https://openam-perf-haproxy.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate?authIndexType=service&authIndexValue=Login headers: accept: application/json content-type: application/json user-agent: Mozilla/5.0 (Linux; Android 8.0.0; Pixel 2 Build/OPD3.170816.012) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36 X-Forwarded-For: 125.114.146.189 host: openam-perf-haproxy.forgeblocks.com body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-200' crashed with 'j.u.NoSuchElementException: key not found: policyEvalTokenId', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 21:17:14.616 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-199' crashed with 'j.u.NoSuchElementException: key not found: tokenIdCookieName', forwarding to the next one 2025-09-16 21:17:14,699 INFO Gatling simulation run ended successfully 2025-09-16 21:17:14,699 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 show_stderr : Display stderr order ________________________________________________________________________________ 2025-09-16 20:17:37,464 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-300/stderr.txt is small (0 lines), printing all lines: 2025-09-16 20:17:37,464 INFO ----- output ----- ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 check_rc_and_logs : Check order's outputs ________________________________________________________________________________ CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) PASS: no error found in rc log PASS: no error found in stdout log PASS: no error found in stderr log ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-09-16 20:17:37] benchmark-300 post : Post method ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped