--Task-- name: benchmark-70 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-50'] preceding_task: benchmark-50 options: {'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70-', 'testCase': 'idc.benchmark.Mix2024', 'testMode': 'open', 'throughput': 70} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock ________________________________________________________________________________ [2024-11-14 04:28:41] benchmark-70 pre : N/A ________________________________________________________________________________ 2024-11-14 04:28:41 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2024-11-14 04:28:41 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/benchmark-70/stdout.txt Pod log : /results/orders/benchmark-70 2024-11-14 04:28:41,526 INFO 2024-11-14 04:28:41,526 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 2024-11-14 04:28:41,526 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 04:28:41,801 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 04:28:41,802 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:41,802 DEBUG --- stdout --- 2024-11-14 04:28:41,802 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 04:28:41,802 DEBUG --- stderr --- 2024-11-14 04:28:41,802 DEBUG ________________________________________________________________________________ [2024-11-14 04:28:41] benchmark-70 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-11-14 04:28:41,802 INFO 2024-11-14 04:28:41,802 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 2024-11-14 04:28:41,802 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 04:28:42,079 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 04:28:42,079 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:42,079 DEBUG --- stdout --- 2024-11-14 04:28:42,079 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 04:28:42,079 DEBUG --- stderr --- 2024-11-14 04:28:42,079 DEBUG /lodestar/lodestar.py run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-benchmark" --results-folder="/results/gatling/benchmark-70" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Dlogin_cookie=9b75a55744995d0 -Dnum_users=200000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=70 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2024-11-14 04:28:42] benchmark-70 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-11-14 04:28:42,079 INFO 2024-11-14 04:28:42,079 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 2024-11-14 04:28:42,079 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 04:28:42,357 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 04:28:42,357 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:42,357 DEBUG --- stdout --- 2024-11-14 04:28:42,357 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 04:28:42,357 DEBUG --- stderr --- 2024-11-14 04:28:42,357 DEBUG Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/order.json { "name": "benchmark-70", "command": " /lodestar/lodestar.py run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idc.benchmark.Mix2024@perf-benchmark\" --results-folder=\"/results/gatling/benchmark-70\" --no-reports --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx4G\" --simulation-system-properties=\"-Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Dlogin_cookie=9b75a55744995d0 -Dnum_users=200000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=70 -Duser_password=Pa_ssw0rd\"", "out-dir": "/results/orders/benchmark-70" } ________________________________________________________________________________ [2024-11-14 04:28:42] benchmark-70 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: ________________________________________________________________________________ 2024-11-14 04:28:42,360 INFO 2024-11-14 04:28:42,360 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-11-14 04:28:42,360 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-11-14 04:28:42,576 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-14 04:28:42,576 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:42,576 DEBUG --- stdout --- 2024-11-14 04:28:42,576 DEBUG WAITING 2024-11-14 04:28:42,576 DEBUG --- stderr --- 2024-11-14 04:28:42,576 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 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2024-11-14 04:28:42] benchmark-70 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-11-14 04:28:42,577 INFO 2024-11-14 04:28:42,577 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 2024-11-14 04:28:42,577 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 04:28:42,850 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 04:28:42,850 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:42,851 DEBUG --- stdout --- 2024-11-14 04:28:42,851 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 04:28:42,851 DEBUG --- stderr --- 2024-11-14 04:28:42,851 DEBUG 2024-11-14 04:28:42,851 INFO 2024-11-14 04:28:42,851 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-70/order.json overseer-0-6644bb6697-rchxr:/results/orders/order.json 2024-11-14 04:28:42,851 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 04:28:44,205 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:44,205 DEBUG --- stdout --- 2024-11-14 04:28:44,205 DEBUG 2024-11-14 04:28:44,205 DEBUG --- stderr --- 2024-11-14 04:28:44,205 DEBUG Order has been successfully forwarded to overseer 2024-11-14 04:28:44 - INFO: Check if Gatling simulation started successfully 2024-11-14 04:28:44,205 INFO 2024-11-14 04:28:44,205 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 2024-11-14 04:28:44,205 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 04:28:44,481 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 04:28:44,482 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:44,482 DEBUG --- stdout --- 2024-11-14 04:28:44,482 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 04:28:44,482 DEBUG --- stderr --- 2024-11-14 04:28:44,482 DEBUG 2024-11-14 04:28:44,482 INFO 2024-11-14 04:28:44,482 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr -- head --lines 5000 /results/orders/benchmark-70/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2024-11-14 04:28:44,482 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-11-14 04:28:45,206 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2024-11-14 04:28:50,931 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2024-11-14 04:28:56,674 INFO [loop_until]: Function succeeded after 12s (rc=0) - expected pattern found 2024-11-14 04:28:56,675 INFO [loop_until]: OK (rc = 0) 2024-11-14 04:28:56,675 DEBUG --- stdout --- 2024-11-14 04:28:56,675 DEBUG 2024-11-14 04:28:44,905 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp_zpily4_ 2024-11-14 04:28:44,907 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-70" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Dlogin_cookie=9b75a55744995d0 -Dnum_users=200000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=70 -Duser_password=**** [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp_zpily4_/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] Copying 2 resources from src/test/resources to target/test-classes [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] Nothing to compile - all classes are up to date. [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compiling 38 Scala sources to /tmp/tmp_zpily4_/target/test-classes ... [INFO] compile in 6.8 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.1 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Simulation com.forgerock.pyrock.Loadtest started... 2024-11-14 04:28:56,675 DEBUG --- stderr --- 2024-11-14 04:28:56,675 DEBUG ________________________________________________________________________________ [2024-11-14 04:28:56] benchmark-70 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 02s, 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 04s, retry Order is running since 30m 04s, retry Order is running since 32m 04s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 05s, retry Order is running since 40m 05s, retry Order is running since 42m 06s, retry Order is running since 44m 06s, retry Order is running since 46m 06s, retry Order is running since 48m 07s, retry Order is running since 50m 07s, retry Order is running since 52m 07s, retry Order is running since 54m 07s, retry Order is running since 56m 08s, retry Order is running since 58m 08s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2024-11-14 05:29:05] benchmark-70 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-11-14 05:29:05,526 INFO 2024-11-14 05:29:05,527 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 2024-11-14 05:29:05,527 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:05,826 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:05,826 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:05,826 DEBUG --- stdout --- 2024-11-14 05:29:05,826 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:05,826 DEBUG --- stderr --- 2024-11-14 05:29:05,826 DEBUG 2024-11-14 05:29:05,827 INFO 2024-11-14 05:29:05,827 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr -- rm -f /results/orders/order.json 2024-11-14 05:29:05,827 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 05:29:06,603 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:06,603 DEBUG --- stdout --- 2024-11-14 05:29:06,603 DEBUG 2024-11-14 05:29:06,603 DEBUG --- stderr --- 2024-11-14 05:29:06,603 DEBUG Order ran during 1h ________________________________________________________________________________ [2024-11-14 05:29:06] benchmark-70 download_logs : Download individual order files ________________________________________________________________________________ 2024-11-14 05:29:06 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/order.json 2024-11-14 05:29:06,603 INFO 2024-11-14 05:29:06,603 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 2024-11-14 05:29:06,603 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:06,877 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:06,877 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:06,877 DEBUG --- stdout --- 2024-11-14 05:29:06,877 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:06,877 DEBUG --- stderr --- 2024-11-14 05:29:06,877 DEBUG Checking pod: overseer-0-6644bb6697-rchxr for file exists, if not wait. 2024-11-14 05:29:06,877 INFO 2024-11-14 05:29:06,877 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 2024-11-14 05:29:06,877 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:07,153 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:07,153 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:07,153 DEBUG --- stdout --- 2024-11-14 05:29:07,153 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:07,153 DEBUG --- stderr --- 2024-11-14 05:29:07,153 DEBUG 2024-11-14 05:29:07,154 INFO 2024-11-14 05:29:07,154 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- bash -c 'if [ -f "/results/orders/benchmark-70/rc.txt" ]; then echo "/results/orders/benchmark-70/rc.txt file found"; exit 0; else echo "/results/orders/benchmark-70/rc.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-70/rc.txt file found" 2024-11-14 05:29:07,154 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 05:29:07,952 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-14 05:29:07,952 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:07,952 DEBUG --- stdout --- 2024-11-14 05:29:07,952 DEBUG /results/orders/benchmark-70/rc.txt file found 2024-11-14 05:29:07,952 DEBUG --- stderr --- 2024-11-14 05:29:07,952 DEBUG 2024-11-14 05:29:07,952 INFO 2024-11-14 05:29:07,953 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 2024-11-14 05:29:07,953 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:08,229 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:08,229 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:08,229 DEBUG --- stdout --- 2024-11-14 05:29:08,229 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:08,229 DEBUG --- stderr --- 2024-11-14 05:29:08,229 DEBUG 2024-11-14 05:29:08,229 INFO 2024-11-14 05:29:08,229 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- du -k /results/orders/benchmark-70/rc.txt 2024-11-14 05:29:09,088 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-14 05:29:09,088 DEBUG --- stdout --- 2024-11-14 05:29:09,088 DEBUG 4 /results/orders/benchmark-70/rc.txt 2024-11-14 05:29:09,088 DEBUG --- stderr --- 2024-11-14 05:29:09,088 DEBUG 2024-11-14 05:29:09,088 INFO - Download file (size 4k) 2024-11-14 05:29:09,088 INFO 2024-11-14 05:29:09,088 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 2024-11-14 05:29:09,088 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:09,363 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:09,363 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:09,363 DEBUG --- stdout --- 2024-11-14 05:29:09,363 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:09,363 DEBUG --- stderr --- 2024-11-14 05:29:09,363 DEBUG source : /results/orders/benchmark-70/rc.txt @ overseer-0-6644bb6697-rchxr destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/rc.txt 2024-11-14 05:29:09,364 INFO 2024-11-14 05:29:09,364 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 2024-11-14 05:29:09,364 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:09,671 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:09,671 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:09,671 DEBUG --- stdout --- 2024-11-14 05:29:09,671 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:09,671 DEBUG --- stderr --- 2024-11-14 05:29:09,671 DEBUG 2024-11-14 05:29:09,671 INFO 2024-11-14 05:29:09,671 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-rchxr:/results/orders/benchmark-70/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/rc.txt 2024-11-14 05:29:09,671 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-14 05:29:10,426 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:10,426 DEBUG --- stdout --- 2024-11-14 05:29:10,426 DEBUG tar: Removing leading `/' from member names 2024-11-14 05:29:10,426 DEBUG --- stderr --- 2024-11-14 05:29:10,426 DEBUG 2024-11-14 05:29:10,426 INFO 2024-11-14 05:29:10,426 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 2024-11-14 05:29:10,426 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:10,702 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:10,702 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:10,702 DEBUG --- stdout --- 2024-11-14 05:29:10,703 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:10,703 DEBUG --- stderr --- 2024-11-14 05:29:10,703 DEBUG Checking pod: overseer-0-6644bb6697-rchxr for file exists, if not wait. 2024-11-14 05:29:10,703 INFO 2024-11-14 05:29:10,703 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 2024-11-14 05:29:10,703 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:10,976 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:10,976 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:10,976 DEBUG --- stdout --- 2024-11-14 05:29:10,976 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:10,976 DEBUG --- stderr --- 2024-11-14 05:29:10,976 DEBUG 2024-11-14 05:29:10,977 INFO 2024-11-14 05:29:10,977 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- bash -c 'if [ -f "/results/orders/benchmark-70/stderr.txt" ]; then echo "/results/orders/benchmark-70/stderr.txt file found"; exit 0; else echo "/results/orders/benchmark-70/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-70/stderr.txt file found" 2024-11-14 05:29:10,977 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 05:29:11,769 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-14 05:29:11,769 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:11,769 DEBUG --- stdout --- 2024-11-14 05:29:11,769 DEBUG /results/orders/benchmark-70/stderr.txt file found 2024-11-14 05:29:11,769 DEBUG --- stderr --- 2024-11-14 05:29:11,769 DEBUG 2024-11-14 05:29:11,770 INFO 2024-11-14 05:29:11,770 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 2024-11-14 05:29:11,770 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:12,044 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:12,044 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:12,044 DEBUG --- stdout --- 2024-11-14 05:29:12,044 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:12,044 DEBUG --- stderr --- 2024-11-14 05:29:12,044 DEBUG 2024-11-14 05:29:12,044 INFO 2024-11-14 05:29:12,044 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- du -k /results/orders/benchmark-70/stderr.txt 2024-11-14 05:29:12,832 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-14 05:29:12,832 DEBUG --- stdout --- 2024-11-14 05:29:12,832 DEBUG 0 /results/orders/benchmark-70/stderr.txt 2024-11-14 05:29:12,832 DEBUG --- stderr --- 2024-11-14 05:29:12,832 DEBUG 2024-11-14 05:29:12,832 INFO - Download file (size 0k) 2024-11-14 05:29:12,833 INFO 2024-11-14 05:29:12,833 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 2024-11-14 05:29:12,833 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:13,107 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:13,108 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:13,108 DEBUG --- stdout --- 2024-11-14 05:29:13,108 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:13,108 DEBUG --- stderr --- 2024-11-14 05:29:13,108 DEBUG source : /results/orders/benchmark-70/stderr.txt @ overseer-0-6644bb6697-rchxr destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/stderr.txt 2024-11-14 05:29:13,108 INFO 2024-11-14 05:29:13,108 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 2024-11-14 05:29:13,108 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:13,384 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:13,384 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:13,384 DEBUG --- stdout --- 2024-11-14 05:29:13,384 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:13,384 DEBUG --- stderr --- 2024-11-14 05:29:13,384 DEBUG 2024-11-14 05:29:13,385 INFO 2024-11-14 05:29:13,385 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-rchxr:/results/orders/benchmark-70/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/stderr.txt 2024-11-14 05:29:13,385 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-14 05:29:14,140 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:14,140 DEBUG --- stdout --- 2024-11-14 05:29:14,140 DEBUG tar: Removing leading `/' from member names 2024-11-14 05:29:14,140 DEBUG --- stderr --- 2024-11-14 05:29:14,140 DEBUG 2024-11-14 05:29:14,140 INFO 2024-11-14 05:29:14,140 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 2024-11-14 05:29:14,140 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:14,416 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:14,416 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:14,416 DEBUG --- stdout --- 2024-11-14 05:29:14,416 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:14,416 DEBUG --- stderr --- 2024-11-14 05:29:14,416 DEBUG Checking pod: overseer-0-6644bb6697-rchxr for file exists, if not wait. 2024-11-14 05:29:14,416 INFO 2024-11-14 05:29:14,416 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 2024-11-14 05:29:14,416 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:14,689 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:14,689 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:14,689 DEBUG --- stdout --- 2024-11-14 05:29:14,689 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:14,689 DEBUG --- stderr --- 2024-11-14 05:29:14,689 DEBUG 2024-11-14 05:29:14,690 INFO 2024-11-14 05:29:14,690 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- bash -c 'if [ -f "/results/orders/benchmark-70/stdout.txt" ]; then echo "/results/orders/benchmark-70/stdout.txt file found"; exit 0; else echo "/results/orders/benchmark-70/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-70/stdout.txt file found" 2024-11-14 05:29:14,690 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 05:29:15,485 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-14 05:29:15,485 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:15,485 DEBUG --- stdout --- 2024-11-14 05:29:15,485 DEBUG /results/orders/benchmark-70/stdout.txt file found 2024-11-14 05:29:15,485 DEBUG --- stderr --- 2024-11-14 05:29:15,485 DEBUG 2024-11-14 05:29:15,486 INFO 2024-11-14 05:29:15,486 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 2024-11-14 05:29:15,486 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:15,761 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:15,761 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:15,761 DEBUG --- stdout --- 2024-11-14 05:29:15,761 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:15,761 DEBUG --- stderr --- 2024-11-14 05:29:15,761 DEBUG 2024-11-14 05:29:15,761 INFO 2024-11-14 05:29:15,761 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- du -k /results/orders/benchmark-70/stdout.txt 2024-11-14 05:29:16,614 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-14 05:29:16,614 DEBUG --- stdout --- 2024-11-14 05:29:16,614 DEBUG 5472 /results/orders/benchmark-70/stdout.txt 2024-11-14 05:29:16,614 DEBUG --- stderr --- 2024-11-14 05:29:16,614 DEBUG 2024-11-14 05:29:16,614 INFO - Download file (size 5472k) 2024-11-14 05:29:16,614 INFO 2024-11-14 05:29:16,614 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 2024-11-14 05:29:16,614 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:16,913 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:16,913 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:16,913 DEBUG --- stdout --- 2024-11-14 05:29:16,913 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:16,913 DEBUG --- stderr --- 2024-11-14 05:29:16,913 DEBUG source : /results/orders/benchmark-70/stdout.txt @ overseer-0-6644bb6697-rchxr destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/stdout.txt 2024-11-14 05:29:16,913 INFO 2024-11-14 05:29:16,913 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 2024-11-14 05:29:16,913 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:17,187 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:17,187 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:17,187 DEBUG --- stdout --- 2024-11-14 05:29:17,187 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:17,187 DEBUG --- stderr --- 2024-11-14 05:29:17,187 DEBUG 2024-11-14 05:29:17,188 INFO 2024-11-14 05:29:17,188 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-rchxr:/results/orders/benchmark-70/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/stdout.txt 2024-11-14 05:29:17,188 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-14 05:29:18,451 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:18,451 DEBUG --- stdout --- 2024-11-14 05:29:18,451 DEBUG tar: Removing leading `/' from member names 2024-11-14 05:29:18,451 DEBUG --- stderr --- 2024-11-14 05:29:18,451 DEBUG ________________________________________________________________________________ [2024-11-14 05:29:18] benchmark-70 show_cmd : Display order command ________________________________________________________________________________ 2024-11-14 05:29:18,452 INFO 2024-11-14 05:29:18,452 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 2024-11-14 05:29:18,452 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:18,727 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:18,727 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:18,727 DEBUG --- stdout --- 2024-11-14 05:29:18,727 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:18,727 DEBUG --- stderr --- 2024-11-14 05:29:18,727 DEBUG Checking pod: overseer-0-6644bb6697-rchxr for file exists, if not wait. 2024-11-14 05:29:18,728 INFO 2024-11-14 05:29:18,728 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 2024-11-14 05:29:18,728 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:19,001 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:19,001 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:19,001 DEBUG --- stdout --- 2024-11-14 05:29:19,002 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:19,002 DEBUG --- stderr --- 2024-11-14 05:29:19,002 DEBUG 2024-11-14 05:29:19,002 INFO 2024-11-14 05:29:19,002 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- bash -c 'if [ -f "/results/orders/benchmark-70/cmd.txt" ]; then echo "/results/orders/benchmark-70/cmd.txt file found"; exit 0; else echo "/results/orders/benchmark-70/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-70/cmd.txt file found" 2024-11-14 05:29:19,002 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-14 05:29:19,794 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-14 05:29:19,794 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:19,794 DEBUG --- stdout --- 2024-11-14 05:29:19,794 DEBUG /results/orders/benchmark-70/cmd.txt file found 2024-11-14 05:29:19,794 DEBUG --- stderr --- 2024-11-14 05:29:19,794 DEBUG 2024-11-14 05:29:19,794 INFO 2024-11-14 05:29:19,795 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 2024-11-14 05:29:19,795 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:20,068 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:20,068 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:20,068 DEBUG --- stdout --- 2024-11-14 05:29:20,069 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:20,069 DEBUG --- stderr --- 2024-11-14 05:29:20,069 DEBUG 2024-11-14 05:29:20,069 INFO 2024-11-14 05:29:20,069 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-rchxr --stdin -- du -k /results/orders/benchmark-70/cmd.txt 2024-11-14 05:29:20,855 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-14 05:29:20,855 DEBUG --- stdout --- 2024-11-14 05:29:20,855 DEBUG 4 /results/orders/benchmark-70/cmd.txt 2024-11-14 05:29:20,855 DEBUG --- stderr --- 2024-11-14 05:29:20,855 DEBUG 2024-11-14 05:29:20,855 INFO - Download file (size 4k) 2024-11-14 05:29:20,855 INFO 2024-11-14 05:29:20,856 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 2024-11-14 05:29:20,856 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:21,128 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:21,128 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:21,128 DEBUG --- stdout --- 2024-11-14 05:29:21,128 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:21,128 DEBUG --- stderr --- 2024-11-14 05:29:21,128 DEBUG source : /results/orders/benchmark-70/cmd.txt @ overseer-0-6644bb6697-rchxr destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/cmd.txt 2024-11-14 05:29:21,129 INFO 2024-11-14 05:29:21,129 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 2024-11-14 05:29:21,129 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-14 05:29:21,405 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-14 05:29:21,405 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:21,405 DEBUG --- stdout --- 2024-11-14 05:29:21,406 DEBUG overseer-0-6644bb6697-rchxr 2024-11-14 05:29:21,406 DEBUG --- stderr --- 2024-11-14 05:29:21,406 DEBUG 2024-11-14 05:29:21,407 INFO 2024-11-14 05:29:21,407 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-rchxr:/results/orders/benchmark-70/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/cmd.txt 2024-11-14 05:29:21,407 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-14 05:29:22,125 INFO [loop_until]: OK (rc = 0) 2024-11-14 05:29:22,125 DEBUG --- stdout --- 2024-11-14 05:29:22,125 DEBUG tar: Removing leading `/' from member names 2024-11-14 05:29:22,125 DEBUG --- stderr --- 2024-11-14 05:29:22,125 DEBUG 2024-11-14 05:29:22,125 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/cmd.txt is small (1 lines), printing all lines: 2024-11-14 05:29:22,125 DEBUG ----- output ----- 2024-11-14 05:29:22,125 DEBUG /lodestar/lodestar.py run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-benchmark" --results-folder="/results/gatling/benchmark-70" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Dlogin_cookie=9b75a55744995d0 -Dnum_users=200000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=70 -Duser_password=Pa_ssw0rd" 2024-11-14 05:29:22,125 INFO ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 show_rc : Display rc order ________________________________________________________________________________ 2024-11-14 05:29:22,125 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/rc.txt is small (1 lines), printing all lines: 2024-11-14 05:29:22,125 DEBUG ----- output ----- 2024-11-14 05:29:22,125 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-11-14 05:29:22,125 INFO ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 show_stdout : Display stdout order ________________________________________________________________________________ 2024-11-14 05:29:22,132 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-70/stdout.txt is 64239 lines): 2024-11-14 05:29:22,132 DEBUG ----- output ----- 2024-11-14 05:29:22,133 INFO 2024-11-14 04:28:44,905 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp_zpily4_ 2024-11-14 05:29:22,133 INFO 2024-11-14 04:28:44,907 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-70" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Dlogin_cookie=9b75a55744995d0 -Dnum_users=200000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self70- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=70 -Duser_password=**** 2024-11-14 05:29:22,133 INFO [INFO] Scanning for projects... 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- 2024-11-14 05:29:22,133 INFO [INFO] Building pyrock-gatling-simulation 3.12.0 2024-11-14 05:29:22,133 INFO [INFO] from pom.xml 2024-11-14 05:29:22,133 INFO [INFO] --------------------------------[ jar ]--------------------------------- 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] skip non existing resourceDirectory /tmp/tmp_zpily4_/src/main/resources 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] No sources to compile 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] Copying 2 resources from src/test/resources to target/test-classes 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] Nothing to compile - all classes are up to date. 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] compiling 38 Scala sources to /tmp/tmp_zpily4_/target/test-classes ... 2024-11-14 05:29:22,133 INFO [INFO] compile in 6.8 s 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] 2024-11-14 05:29:22,133 INFO [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- 2024-11-14 05:29:22,133 INFO [INFO] Running simulation com.forgerock.pyrock.Loadtest. 2024-11-14 05:29:22,133 INFO Gatling 3.13.1 is available! (you're using 3.12.0) 2024-11-14 05:29:22,133 INFO System property think_time_multiplier not set. No think time emulation will be done in the simulation. 2024-11-14 05:29:22,133 INFO Simulation com.forgerock.pyrock.Loadtest started... 2024-11-14 05:29:22,133 INFO 2024-11-14 05:29:22,133 INFO ================================================================================ 2024-11-14 05:29:22,133 INFO 2024-11-14 04:29:00 GMT 5s elapsed 2024-11-14 05:29:22,133 INFO ---- Requests ------------------------------------------------------------------ 2024-11-14 05:29:22,133 INFO > Global (OK=306 KO=0 ) 2024-11-14 05:29:22,133 INFO > restLoginInitiate (OK=29 KO=0 ) 2024-11-14 05:29:22,133 INFO > restLoginUsernamePasswordCallback (OK=28 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 1 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 1 Redirect 1 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI AM idFromSession (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI AM validateGoto (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > User Authorize PKCE stage (OK=32 KO=0 ) 2024-11-14 05:29:22,133 INFO > User AccessToken PKCE stage (OK=30 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 2 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 2 Redirect 1 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI Enduser appAuthHelper1 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI Enduser appAuthHelper2 (OK=6 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 3 (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI-Post-Login - stage 3 Redirect 1 (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM uiconfig (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI Enduser sessioncheck (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM version (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM login (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM features (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM privilege (OK=5 KO=0 ) 2024-11-14 05:29:22,133 INFO > UI IDM dashboard (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI IDM managed user schema (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI IDM user (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI IDM oidcToken (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > userinfo (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI-Logout (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI-Logout Redirect 1 (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI AM revoke2 (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI AM revoke1 (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI AM endsession (OK=5 KO=0 ) 2024-11-14 05:29:22,134 INFO > Skip 2FA (OK=13 KO=0 ) 2024-11-14 05:29:22,134 INFO > RootUserinfo (OK=10 KO=0 ) 2024-11-14 05:29:22,134 INFO > tokenUserinfo (OK=7 KO=0 ) 2024-11-14 05:29:22,134 INFO > GetUUid (OK=6 KO=0 ) 2024-11-14 05:29:22,134 INFO > GetOpenidConfig (OK=6 KO=0 ) 2024-11-14 05:29:22,134 INFO > CreatePolicy (OK=6 KO=0 ) 2024-11-14 05:29:22,134 INFO > restloginProgressiveProfileCallback (OK=1 KO=0 ) 2024-11-14 05:29:22,134 INFO 2024-11-14 05:29:22,134 INFO ---- idc.benchmark.Mix2024 ----------------------------------------------------- 2024-11-14 05:29:22,134 INFO [- ] 0% 2024-11-14 05:29:22,134 INFO waiting: 253130 / active: 17 / done: 12 2024-11-14 05:29:22,134 INFO ================================================================================ 2024-11-14 05:29:22,134 INFO 2024-11-14 05:29:22,134 INFO 04:29:01.842 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 04:29:02.308 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 04:29:02.776 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 04:29:03.767 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 04:29:04.476 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 04:29:05.287 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-14 05:29:22,134 INFO 2024-11-14 05:29:22,134 INFO ================================================================================ 2024-11-14 05:29:22,134 INFO 2024-11-14 04:29:05 GMT 10s elapsed 2024-11-14 05:29:22,134 INFO ---- Requests ------------------------------------------------------------------ 2024-11-14 05:29:22,134 INFO > Global (OK=1296 KO=0 ) 2024-11-14 05:29:22,134 INFO > restLoginInitiate (OK=110 KO=0 ) 2024-11-14 05:29:22,134 INFO > restLoginUsernamePasswordCallback (OK=108 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI-Post-Login - stage 1 (OK=24 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI-Post-Login - stage 1 Redirect 1 (OK=24 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI AM idFromSession (OK=24 KO=0 ) 2024-11-14 05:29:22,134 INFO > UI AM validateGoto (OK=24 KO=0 ) 2024-11-14 05:29:22,134 INFO [...] 2024-11-14 05:29:22,143 INFO Session: 2024-11-14 05:29:22,143 INFO Session(idc.benchmark.Mix2024,251019,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJhYmVjOWExNy00NzZjLTQwMjktYTRkNy05NzUwM2E2ZTEyYWUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYTA2NGI3YzctNmJiYS00Y2MwLTg3ZTgtM2RhY2IxODliOTNkLTg1MjQwNzM0Iiwic3VibmFtZSI6ImFiZWM5YTE3LTQ3NmMtNDAyOS1hNGQ3LTk3NTAzYTZlMTJhZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Ikh5NlhSbm9VWWZkbVlvdEhVYUxUc1g1YWdfZyIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbIm9wZW5pZCIsImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiRFJrNkxwVkNqZWFDdWtjeHJpUDVSaHlLdkpnIn0.-NA6fK5ouQ0zejVz6qdBSQegjFwNBXvhpN5gB0b1Nms, username -> user.185081, access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJhYmVjOWExNy00NzZjLTQwMjktYTRkNy05NzUwM2E2ZTEyYWUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMDdmNTQxOWYtOTZkNS00ZDM3LWJmOTgtYzU4ODYxMzA3NjhmLTg1OTczNDYzIiwic3VibmFtZSI6ImFiZWM5YTE3LTQ3NmMtNDAyOS1hNGQ3LTk3NTAzYTZlMTJhZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Iko4ekV0Ym5zVW1XV0N3QjdBQ2psaENyOU9xNCIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiYXRSVFlIOVRQWlVhOGFvTDNrd19aYk9yYmxjIn0.S7c8Zg87TDf8UOh6PrcW7YZvE4CUkI5Aq8jkjDoUZF8, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@46031110, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, authcode -> -PSycwI1PYEvjOfRgv3gsbR_hm0, callbacks -> {"tokenId":"FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135045), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135045))), user_uuid -> abec9a17-476c-4029-a4d7-97503a6e12ae, password -> Pa_ssw0rd, challenge -> wD7NziZoEgxAGSIdiKm6iM5NmSnlbqak1SJYVt-4hOA, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 209.156.124.16, verifier -> LTQ2NDE2MTI2MzkxNzkwODI5MDg, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3f0f8260, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@5217a918, tokenId -> FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/44.0.2403.157 Safari/537.36),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x00007f02ec69a0e0@2d1a9f7d,io.netty.channel.epoll.EpollEventLoop@650eab8) 2024-11-14 05:29:22,143 INFO ========================= 2024-11-14 05:29:22,143 INFO HTTP request: 2024-11-14 05:29:22,143 INFO GET https://openam-perf-benchmark.forgeblocks.com/openidm/info/features?_queryFilter=true 2024-11-14 05:29:22,144 INFO headers: 2024-11-14 05:29:22,144 INFO 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 2024-11-14 05:29:22,144 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-14 05:29:22,144 INFO Authorization: Bearer eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJhYmVjOWExNy00NzZjLTQwMjktYTRkNy05NzUwM2E2ZTEyYWUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMDdmNTQxOWYtOTZkNS00ZDM3LWJmOTgtYzU4ODYxMzA3NjhmLTg1OTczNDYzIiwic3VibmFtZSI6ImFiZWM5YTE3LTQ3NmMtNDAyOS1hNGQ3LTk3NTAzYTZlMTJhZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Iko4ekV0Ym5zVW1XV0N3QjdBQ2psaENyOU9xNCIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiYXRSVFlIOVRQWlVhOGFvTDNrd19aYk9yYmxjIn0.S7c8Zg87TDf8UOh6PrcW7YZvE4CUkI5Aq8jkjDoUZF8 2024-11-14 05:29:22,144 INFO Accept-Api-Version: 2024-11-14 05:29:22,144 INFO accept: */* 2024-11-14 05:29:22,144 INFO cookie: amlbcookie=01; 9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,144 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-14 05:29:22,144 INFO cookies: 2024-11-14 05:29:22,144 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,144 INFO 9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO HTTP response: 2024-11-14 05:29:22,144 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-14 05:29:22,144 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI IDM version' failed for user 251019: j.i.IOException: Premature close 2024-11-14 05:29:22,144 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI IDM features' failed for user 251010: j.n.c.ClosedChannelException 2024-11-14 05:29:22,144 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-14 05:29:22,144 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-14 05:29:22,144 INFO Request: 2024-11-14 05:29:22,144 INFO UI IDM version: KO j.i.IOException: Premature close 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO Session: 2024-11-14 05:29:22,144 INFO Session(idc.benchmark.Mix2024,251019,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJhYmVjOWExNy00NzZjLTQwMjktYTRkNy05NzUwM2E2ZTEyYWUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYTA2NGI3YzctNmJiYS00Y2MwLTg3ZTgtM2RhY2IxODliOTNkLTg1MjQwNzM0Iiwic3VibmFtZSI6ImFiZWM5YTE3LTQ3NmMtNDAyOS1hNGQ3LTk3NTAzYTZlMTJhZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Ikh5NlhSbm9VWWZkbVlvdEhVYUxUc1g1YWdfZyIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbIm9wZW5pZCIsImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiRFJrNkxwVkNqZWFDdWtjeHJpUDVSaHlLdkpnIn0.-NA6fK5ouQ0zejVz6qdBSQegjFwNBXvhpN5gB0b1Nms, username -> user.185081, access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJhYmVjOWExNy00NzZjLTQwMjktYTRkNy05NzUwM2E2ZTEyYWUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMDdmNTQxOWYtOTZkNS00ZDM3LWJmOTgtYzU4ODYxMzA3NjhmLTg1OTczNDYzIiwic3VibmFtZSI6ImFiZWM5YTE3LTQ3NmMtNDAyOS1hNGQ3LTk3NTAzYTZlMTJhZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Iko4ekV0Ym5zVW1XV0N3QjdBQ2psaENyOU9xNCIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiYXRSVFlIOVRQWlVhOGFvTDNrd19aYk9yYmxjIn0.S7c8Zg87TDf8UOh6PrcW7YZvE4CUkI5Aq8jkjDoUZF8, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@46031110, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, authcode -> -PSycwI1PYEvjOfRgv3gsbR_hm0, callbacks -> {"tokenId":"FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135045), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135045))), user_uuid -> abec9a17-476c-4029-a4d7-97503a6e12ae, password -> Pa_ssw0rd, challenge -> wD7NziZoEgxAGSIdiKm6iM5NmSnlbqak1SJYVt-4hOA, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 209.156.124.16, verifier -> LTQ2NDE2MTI2MzkxNzkwODI5MDg, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3f0f8260, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@5217a918, tokenId -> FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/44.0.2403.157 Safari/537.36),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x00007f02ec69a0e0@2d1a9f7d,io.netty.channel.epoll.EpollEventLoop@650eab8) 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO HTTP request: 2024-11-14 05:29:22,144 INFO GET https://openam-perf-benchmark.forgeblocks.com/openidm/info/version 2024-11-14 05:29:22,144 INFO headers: 2024-11-14 05:29:22,144 INFO 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 2024-11-14 05:29:22,144 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-14 05:29:22,144 INFO Accept-Api-Version: 2024-11-14 05:29:22,144 INFO accept: */* 2024-11-14 05:29:22,144 INFO cookie: amlbcookie=01; 9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,144 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-14 05:29:22,144 INFO cookies: 2024-11-14 05:29:22,144 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,144 INFO 9b75a55744995d0=FaL74hdxwDfVU2TbX7J9VZtM06o.*AAJTSQACMDIAAlNLABxMQzgvZTJTbHV1NFFlTUFld1NHUnp0ZEY3VnM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO HTTP response: 2024-11-14 05:29:22,144 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-14 05:29:22,144 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-14 05:29:22,144 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-14 05:29:22,144 INFO Request: 2024-11-14 05:29:22,144 INFO UI IDM features: KO j.n.c.ClosedChannelException 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO Session: 2024-11-14 05:29:22,144 INFO Session(idc.benchmark.Mix2024,251010,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiI1NmMwMDk1NC01ZjUzLTQwNzEtYjAyZS1kYTA4ZjBkNzc1MTciLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMDdmNTQxOWYtOTZkNS00ZDM3LWJmOTgtYzU4ODYxMzA3NjhmLTg1OTcyOTUwIiwic3VibmFtZSI6IjU2YzAwOTU0LTVmNTMtNDA3MS1iMDJlLWRhMDhmMGQ3NzUxNyIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Im16MWt3a09US1Q1dnpkeGJZa2R2X1VUcGFkcyIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbIm9wZW5pZCIsImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiVm1zSzFYRjFVVi14SThPWU16cWo5UmhiTFlVIn0.U41hvtwH3YcaJeZunNTBZu-_4WLM02rbT8UcdsspOIY, username -> user.78528, access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiI1NmMwMDk1NC01ZjUzLTQwNzEtYjAyZS1kYTA4ZjBkNzc1MTciLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMGIzOGU2MjYtMDhkZC00YzdhLTliN2ItMGQxMTUzYWM3NjdkLTg1MjQwMTY2Iiwic3VibmFtZSI6IjU2YzAwOTU0LTVmNTMtNDA3MS1iMDJlLWRhMDhmMGQ3NzUxNyIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6InhQMWlUakppbkFFaXJvMlJfY2JqRGVsVERLTSIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiaGp3djBBQzFrZ044U2FxVlJNb0NFcWlDWGRZIn0.FV9jTIkEQAWM-OpDo1V0QaIl3awUIX0szYNRKipgD0I, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1a9d8c03, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, authcode -> JqnwkWvO8z5qR-8T7I33sqst-1E, callbacks -> {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJhYzg2YTdkNS03MGI5LTRkZTAtYTdkMi1lOThmZDA3NGUwMjMiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiamtuOTBtNW51ajZxZnAxb2htYnRwMzBla3UiLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1R1RYTnJhVE5FTUhkaWVVbDJXbWRuVlVSbFRYbDNMblp6UVZOMldYcEJOM2x1VkZONFVFbEthbGM0Y0V4UVRuRXpRUzFOV0ZsaFpuRnNVRjgwZVZCV2NYRnlOblJFTkdSbGNVVTRhWEU1WW1kUFlUUllWWEZFVjJwQlRrMTJaWEF6YWt3eGJWUlJYMFpqY1VacGFHNU1OVXBHWTA1YVpXTjVORzlCU0RndGExQjFXa1Y2Tmw5amFsSjFlR05KVmpGVk9VcHlia2hhZGxjelRGcHdlRFpmTUhFd05qTjVSRkJRVURSNGNGbFZSVVUxVW5KcVNFRlNWRTFFVTBsc1kyTmhVbFZYUlZCb2IyVmxZakYxUTJoamJISnNTV3hUZVZOMFZteE5ZbGxFVTB3MmIxQTVXR3BSYXkxS2QxWkhPWFJ3Ym14Vk9HOVNXamt6WlhOWlZtTk1VRTlETTBaa2RHTlBlV1pCY2xWMFZsOTRVRkYzYUVGaGNuWlNkbkUzUTFrNFFuQkRNMWw2WkV3d1kwZFVNMm94ZUVKcFpHRkhaV2xUYTBaaFZGQndZbnBRUlhKa1pqZDRNVWd3VjJKa1UxbDZUV1JaV2s1c01qSXdWVEpJTkc5aWVUWmhObmxxTVRsalMyTjZSMlJIWWxZNFZIRk9WbEZGU1Zob1NqaGxYMEYzTXpSRWNGYzBNRTVVY3pGRlNUUmxSbkI1ZGxST2QxODBRa2hJT0VjM1VXcEVlWEJCVVhSd09DMVVZMnBRVjFCeVJIZE1SVkpGWkRGeFh6WldUbDkzZVRoaVFXSktSMEptZGpCdU5tRmFjR3AxZFY4M1ltOXVVSGR1WXpKZk9GcE5iRk5IZUdWQlJtSk5SVXhhV25SYWQzSlpjbVZOVXpWblYwTlhWRUpJUkVkMFNUZHVRbUV5TlV0dmNGOVRPV1l5VTJaeFUydDNiV2hHZW5aWlJFcFpPRGd5WVZVdE9WaENiV1pmUVhCNVMzVTVSemw1TVZKVFpIRXliVFZtV1dsMmQyeFJPVTh0Wm00eldXUXphMHhXVDFaaVdtZHNZMU4yTjJaeFFsVnlYMDkzU210VFlWQmZiVlJpUzBKRU1qaGthM2RRZDFaMllsTXhlRUZQV2tSS2RITlRaelJGZFV4RlVrVTFXVkJsYnpkeFVuQnBaME5EU205NlNtVm9UVlF5TUhoU2NGVXhUeTB3WnpSVWJXaElWM2hCUkUxaWQwRmthMHRmWlhCbGVVOHlOblZUWXpSRU9HUmhWMkpwTVRaRmIzUTFNMWRrY0ZCUmFWRnRhRWhaVERNMmFqZE9abkpPYkU5d2NFMTZNRmhrTTJad2R6VkplV1ZsVDBrMmJEQmpNbWt6ZHpJMlNtTkNiV28wVW1oUFUxSndPV3RqYzNaUldqaGxWazVmTUhCT2RrcEZkVzFPTUZOUlZYSnhiVzFSTVVKMk5WbEdPV1JuZEc5QmRIRXdXVEoyTW5aTFNrNXFhakp4WVZWNVYxcHZORWRIYWpkSE1uaGlYM05OWVVSRWRrVlBNRGhmTlZCclpHWnlWMVpEUW1wR1kycFpUVU53Wm5WNVFtSnVWa2RNVFRScWNVTldkR3h5VWxseFQwVjBlbWsxZUZwemFpMHdkVzVZVEdFeVdYRlFhVmwzYkVocU5pMUlSakY0TVVZME1GOWlWakpVTlZGdVdtRktXRXBWUW0xbVVHaFRSVVZYUlRkSmNHdGhjSEV6T0c1eE56bHNNRGxhZDI5QmJubzBXVWR0VkhSTFRrMDVOVE5NZFhVdE5XRnhOR1U0VVVwTFIyUndka2RsT0hKeE1tSXhjRUZmWTA1bk5qbElOMFZUWVd0NVVUTjFjMFI1WlhCc1RVSlBSMVphU0ZoQk1GOWZUVUprUkdKU1ZtOURXSE56WWxZMU1IUlBkek16T1RobldUQmphREZ0YlhkTk1WTkZhR2ROVlU1SmRXOWtRelZSVHpoS01HeEVZMlpNVVZndGJqQjRUSEozVjJ3eGR6WnVaMUJVYTA5VVJWQXpOVlYxUTNsc1RWRjNlbUV0YVY5NFUwVm5lRUZTYUVvM05YbFZjUzFtY0dOblVXeGZNalJYU1U4dFprOWtiRVJFTFVKa1NtNTNhRjkzUW1wNmJYVjVabk5rUjNSbFdIQlRUV05uTjNScmMxRnFRWGsxV0c5MFdtcEdaWE53YzNvNVR6QTRPVGRLWlZCTGNtcFNSV1pZWTFVek1HSlpaRGwxUVZwSU1HSTVhVm96V0ZsdFNtNUZTa0p2YW1sZk9EZDROWHBQTTNKMmJWUlNNQzFyZDFsVmFHaE5hbWxyZDNWTlNFOXpTa2RrWVdGVWFWbDNaRFIzVWtJd2NsZENaVVJoVXpkQ1psbFhZWFpaTlhwNWJIZFRPRzFZZVc5WmNVNWxjWE4wYWtwTGFUTkliblJrWVdOM1EycFdSSFJEYm1vdGJuSlNkMk5IUzA1aGNtSkdNbFJYUkdsMmJWQXdjbFo2VERoRVVWWkpkRVZOUkVScFMyaDFRMjlWY21GWlVUZHNTVXhzU2tWeVkxUnNXSGhXT1cxUVlsUk1UMWhOUzJ3d2JXdFRXRTV0T1hvNGRFSTJYMnRVTlRSRWExQkxXRzlVZVVGNVJqWnZXR2h5UzJOUWFFeFJXakZmTUdGM2IzVmpRMlpxWWxscFltSXRZVEp5WjFONlRuSlBiakJUUnpOZlVFaEdVMVU0YTJaR2JuTjRVR3hwV1d4eFFqYzNYMGxhZURSNFVrSXpVMUpOYVZkWVVXTkhhVXhITTJkM1YyZDFkbmRJYmt3M2IwaGlURlZOVlRsU2JGZFhSMjQxU0ZWb1dXZDJaazQ0UjAxcGJXWmpjMHBXWWxCMGRubGpkMkpLVDB0alJtOVBhRll0U0U0emNrczRUbGRwVmpOSU4wTjJVSGRpU0hNMFVuaDZValZXTFMwemQyeHVTVEpvWWkxcVkwZ3lNRkJUTkZSNlVXdzRhRTlwTFVwTkxVUnNkRnBvVkRKaGIyOURVUzA1WDJsZlZHZFFRMXB1TlV0eGFGUk5SM0V5YWxoeWJ6WnpaMU5WYUdGWVVFRm9RbE5VUTNWMWFqVTRSR3N5WDJkbE5FUnJRVGc1TlZNeE0yRjRjemxuUkZSeFJEbEtNbDl6ZG1JNWFVaGtTbFZ6Um05b1VXRmthVzFuZFd4RVNHeFpVMFpYV0haWFIyOVlabGR5WTJWVWQzZFlVamQyU1ZSWVlVRXlRVWRqVTJFM1UwNDNSbkJrY0ZOVU5GUm9URmRUUmpZd1dITnFXbUZUYjNsSlUxcFJVbGt4WjNGek5FVk5hMDF1ZDIxSlptUk5ialIwZWw5NGMxaHViSHBWUjBWbFptZ3RabE5FVEhwTFpIaDVMWEl4VFRKUFdYWkJaMm8zUVhGQ1FYWktYemhZWVVGNWRrNVllRmRMVEdsVFZFbFdUbFV5WkVsUFVFVjRhMTlITVMwd1RYZDBUVjgxTjJ0V1NHaHlWalp1WTFSNFFtbGtkak5OVGtaRFRsQnRTalpyVDFSZmJVbExaa2hyZWpRMVlUaHpTV3BmTTBKV2JVWlNNbWgzTjBGUE0wTjRTalY1TTBaeVJHdFhjMUV0VVdJeU5WSXlaRlZIVmxwblpsTk5SMDE1UkVrd1VXRk5kVTlSTkVod1gyNVRPSFpRTFdWemMyb3plRTlQZG1sS05HTk9aeTQyYkRSbE5tSjZhRll4UTNOU1JHSnhUeTFDTW5Cbi5pRS1fME9Pd0U4dFozcGc4U2djQXd3OVVHTjFXWWNxSGhxdmxJUTJPazZBIiwiZXhwIjoxNzMxNTYyNDM0LCJpYXQiOjE3MzE1NjIxMzR9.YA9pSJXBHc5W-ikZM0FkAybqaSSuX_th8Sp5JN31Auw","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-benchmark.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135031), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*,true,false,1731562135031))), user_uuid -> 56c00954-5f53-4071-b02e-da08f0d77517, password -> Pa_ssw0rd, challenge -> 18DJF0LSIx8Blj2HhM9CvfUEMYursQcZSsYk0KjmR-Y, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 55.83.135.124, verifier -> LTExNjc0Mzg5MDQ5MjE2MTExMDE, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@302e637, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@13d2d973, tokenId -> 4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/58.0.3029.110 Safari/537.3),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x00007f02ec69a0e0@2d1a9f7d,io.netty.channel.epoll.EpollEventLoop@14f5da2c) 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,144 INFO HTTP request: 2024-11-14 05:29:22,144 INFO GET https://openam-perf-benchmark.forgeblocks.com/openidm/info/features?_queryFilter=true 2024-11-14 05:29:22,144 INFO headers: 2024-11-14 05:29:22,144 INFO 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 2024-11-14 05:29:22,144 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-14 05:29:22,144 INFO Authorization: Bearer eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiI1NmMwMDk1NC01ZjUzLTQwNzEtYjAyZS1kYTA4ZjBkNzc1MTciLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMGIzOGU2MjYtMDhkZC00YzdhLTliN2ItMGQxMTUzYWM3NjdkLTg1MjQwMTY2Iiwic3VibmFtZSI6IjU2YzAwOTU0LTVmNTMtNDA3MS1iMDJlLWRhMDhmMGQ3NzUxNyIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6InhQMWlUakppbkFFaXJvMlJfY2JqRGVsVERLTSIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiaGp3djBBQzFrZ044U2FxVlJNb0NFcWlDWGRZIn0.FV9jTIkEQAWM-OpDo1V0QaIl3awUIX0szYNRKipgD0I 2024-11-14 05:29:22,144 INFO Accept-Api-Version: 2024-11-14 05:29:22,144 INFO accept: */* 2024-11-14 05:29:22,144 INFO cookie: amlbcookie=01; 9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,144 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-14 05:29:22,144 INFO cookies: 2024-11-14 05:29:22,144 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,144 INFO 9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,144 INFO ========================= 2024-11-14 05:29:22,145 INFO HTTP response: 2024-11-14 05:29:22,145 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-14 05:29:22,145 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI IDM version' failed for user 251010: j.n.c.ClosedChannelException 2024-11-14 05:29:22,145 INFO 05:28:55.613 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-14 05:29:22,145 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-14 05:29:22,145 INFO Request: 2024-11-14 05:29:22,145 INFO UI IDM version: KO j.n.c.ClosedChannelException 2024-11-14 05:29:22,145 INFO ========================= 2024-11-14 05:29:22,145 INFO Session: 2024-11-14 05:29:22,145 INFO Session(idc.benchmark.Mix2024,251010,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiI1NmMwMDk1NC01ZjUzLTQwNzEtYjAyZS1kYTA4ZjBkNzc1MTciLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMDdmNTQxOWYtOTZkNS00ZDM3LWJmOTgtYzU4ODYxMzA3NjhmLTg1OTcyOTUwIiwic3VibmFtZSI6IjU2YzAwOTU0LTVmNTMtNDA3MS1iMDJlLWRhMDhmMGQ3NzUxNyIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6Im16MWt3a09US1Q1dnpkeGJZa2R2X1VUcGFkcyIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbIm9wZW5pZCIsImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiVm1zSzFYRjFVVi14SThPWU16cWo5UmhiTFlVIn0.U41hvtwH3YcaJeZunNTBZu-_4WLM02rbT8UcdsspOIY, username -> user.78528, access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiI1NmMwMDk1NC01ZjUzLTQwNzEtYjAyZS1kYTA4ZjBkNzc1MTciLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMGIzOGU2MjYtMDhkZC00YzdhLTliN2ItMGQxMTUzYWM3NjdkLTg1MjQwMTY2Iiwic3VibmFtZSI6IjU2YzAwOTU0LTVmNTMtNDA3MS1iMDJlLWRhMDhmMGQ3NzUxNyIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyL3JlYWxtcy9yb290L3JlYWxtcy9hbHBoYSIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6InhQMWlUakppbkFFaXJvMlJfY2JqRGVsVERLTSIsIm5vbmNlIjoiMTIzNCIsImNsaWVudF9pZCI6ImVuZFVzZXJVSUNsaWVudCIsImF1ZCI6ImVuZFVzZXJVSUNsaWVudCIsIm5iZiI6MTczMTU2MjEzNSwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIl0sImF1dGhfdGltZSI6MTczMTU2MjEzNSwicmVhbG0iOiIvYWxwaGEiLCJleHAiOjE3MzE1NjU3MzUsImlhdCI6MTczMTU2MjEzNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiaGp3djBBQzFrZ044U2FxVlJNb0NFcWlDWGRZIn0.FV9jTIkEQAWM-OpDo1V0QaIl3awUIX0szYNRKipgD0I, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1a9d8c03, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, authcode -> JqnwkWvO8z5qR-8T7I33sqst-1E, callbacks -> {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJhYzg2YTdkNS03MGI5LTRkZTAtYTdkMi1lOThmZDA3NGUwMjMiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiamtuOTBtNW51ajZxZnAxb2htYnRwMzBla3UiLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1R1RYTnJhVE5FTUhkaWVVbDJXbWRuVlVSbFRYbDNMblp6UVZOMldYcEJOM2x1VkZONFVFbEthbGM0Y0V4UVRuRXpRUzFOV0ZsaFpuRnNVRjgwZVZCV2NYRnlOblJFTkdSbGNVVTRhWEU1WW1kUFlUUllWWEZFVjJwQlRrMTJaWEF6YWt3eGJWUlJYMFpqY1VacGFHNU1OVXBHWTA1YVpXTjVORzlCU0RndGExQjFXa1Y2Tmw5amFsSjFlR05KVmpGVk9VcHlia2hhZGxjelRGcHdlRFpmTUhFd05qTjVSRkJRVURSNGNGbFZSVVUxVW5KcVNFRlNWRTFFVTBsc1kyTmhVbFZYUlZCb2IyVmxZakYxUTJoamJISnNTV3hUZVZOMFZteE5ZbGxFVTB3MmIxQTVXR3BSYXkxS2QxWkhPWFJ3Ym14Vk9HOVNXamt6WlhOWlZtTk1VRTlETTBaa2RHTlBlV1pCY2xWMFZsOTRVRkYzYUVGaGNuWlNkbkUzUTFrNFFuQkRNMWw2WkV3d1kwZFVNMm94ZUVKcFpHRkhaV2xUYTBaaFZGQndZbnBRUlhKa1pqZDRNVWd3VjJKa1UxbDZUV1JaV2s1c01qSXdWVEpJTkc5aWVUWmhObmxxTVRsalMyTjZSMlJIWWxZNFZIRk9WbEZGU1Zob1NqaGxYMEYzTXpSRWNGYzBNRTVVY3pGRlNUUmxSbkI1ZGxST2QxODBRa2hJT0VjM1VXcEVlWEJCVVhSd09DMVVZMnBRVjFCeVJIZE1SVkpGWkRGeFh6WldUbDkzZVRoaVFXSktSMEptZGpCdU5tRmFjR3AxZFY4M1ltOXVVSGR1WXpKZk9GcE5iRk5IZUdWQlJtSk5SVXhhV25SYWQzSlpjbVZOVXpWblYwTlhWRUpJUkVkMFNUZHVRbUV5TlV0dmNGOVRPV1l5VTJaeFUydDNiV2hHZW5aWlJFcFpPRGd5WVZVdE9WaENiV1pmUVhCNVMzVTVSemw1TVZKVFpIRXliVFZtV1dsMmQyeFJPVTh0Wm00eldXUXphMHhXVDFaaVdtZHNZMU4yTjJaeFFsVnlYMDkzU210VFlWQmZiVlJpUzBKRU1qaGthM2RRZDFaMllsTXhlRUZQV2tSS2RITlRaelJGZFV4RlVrVTFXVkJsYnpkeFVuQnBaME5EU205NlNtVm9UVlF5TUhoU2NGVXhUeTB3WnpSVWJXaElWM2hCUkUxaWQwRmthMHRmWlhCbGVVOHlOblZUWXpSRU9HUmhWMkpwTVRaRmIzUTFNMWRrY0ZCUmFWRnRhRWhaVERNMmFqZE9abkpPYkU5d2NFMTZNRmhrTTJad2R6VkplV1ZsVDBrMmJEQmpNbWt6ZHpJMlNtTkNiV28wVW1oUFUxSndPV3RqYzNaUldqaGxWazVmTUhCT2RrcEZkVzFPTUZOUlZYSnhiVzFSTVVKMk5WbEdPV1JuZEc5QmRIRXdXVEoyTW5aTFNrNXFhakp4WVZWNVYxcHZORWRIYWpkSE1uaGlYM05OWVVSRWRrVlBNRGhmTlZCclpHWnlWMVpEUW1wR1kycFpUVU53Wm5WNVFtSnVWa2RNVFRScWNVTldkR3h5VWxseFQwVjBlbWsxZUZwemFpMHdkVzVZVEdFeVdYRlFhVmwzYkVocU5pMUlSakY0TVVZME1GOWlWakpVTlZGdVdtRktXRXBWUW0xbVVHaFRSVVZYUlRkSmNHdGhjSEV6T0c1eE56bHNNRGxhZDI5QmJubzBXVWR0VkhSTFRrMDVOVE5NZFhVdE5XRnhOR1U0VVVwTFIyUndka2RsT0hKeE1tSXhjRUZmWTA1bk5qbElOMFZUWVd0NVVUTjFjMFI1WlhCc1RVSlBSMVphU0ZoQk1GOWZUVUprUkdKU1ZtOURXSE56WWxZMU1IUlBkek16T1RobldUQmphREZ0YlhkTk1WTkZhR2ROVlU1SmRXOWtRelZSVHpoS01HeEVZMlpNVVZndGJqQjRUSEozVjJ3eGR6WnVaMUJVYTA5VVJWQXpOVlYxUTNsc1RWRjNlbUV0YVY5NFUwVm5lRUZTYUVvM05YbFZjUzFtY0dOblVXeGZNalJYU1U4dFprOWtiRVJFTFVKa1NtNTNhRjkzUW1wNmJYVjVabk5rUjNSbFdIQlRUV05uTjNScmMxRnFRWGsxV0c5MFdtcEdaWE53YzNvNVR6QTRPVGRLWlZCTGNtcFNSV1pZWTFVek1HSlpaRGwxUVZwSU1HSTVhVm96V0ZsdFNtNUZTa0p2YW1sZk9EZDROWHBQTTNKMmJWUlNNQzFyZDFsVmFHaE5hbWxyZDNWTlNFOXpTa2RrWVdGVWFWbDNaRFIzVWtJd2NsZENaVVJoVXpkQ1psbFhZWFpaTlhwNWJIZFRPRzFZZVc5WmNVNWxjWE4wYWtwTGFUTkliblJrWVdOM1EycFdSSFJEYm1vdGJuSlNkMk5IUzA1aGNtSkdNbFJYUkdsMmJWQXdjbFo2VERoRVVWWkpkRVZOUkVScFMyaDFRMjlWY21GWlVUZHNTVXhzU2tWeVkxUnNXSGhXT1cxUVlsUk1UMWhOUzJ3d2JXdFRXRTV0T1hvNGRFSTJYMnRVTlRSRWExQkxXRzlVZVVGNVJqWnZXR2h5UzJOUWFFeFJXakZmTUdGM2IzVmpRMlpxWWxscFltSXRZVEp5WjFONlRuSlBiakJUUnpOZlVFaEdVMVU0YTJaR2JuTjRVR3hwV1d4eFFqYzNYMGxhZURSNFVrSXpVMUpOYVZkWVVXTkhhVXhITTJkM1YyZDFkbmRJYmt3M2IwaGlURlZOVlRsU2JGZFhSMjQxU0ZWb1dXZDJaazQ0UjAxcGJXWmpjMHBXWWxCMGRubGpkMkpLVDB0alJtOVBhRll0U0U0emNrczRUbGRwVmpOSU4wTjJVSGRpU0hNMFVuaDZValZXTFMwemQyeHVTVEpvWWkxcVkwZ3lNRkJUTkZSNlVXdzRhRTlwTFVwTkxVUnNkRnBvVkRKaGIyOURVUzA1WDJsZlZHZFFRMXB1TlV0eGFGUk5SM0V5YWxoeWJ6WnpaMU5WYUdGWVVFRm9RbE5VUTNWMWFqVTRSR3N5WDJkbE5FUnJRVGc1TlZNeE0yRjRjemxuUkZSeFJEbEtNbDl6ZG1JNWFVaGtTbFZ6Um05b1VXRmthVzFuZFd4RVNHeFpVMFpYV0haWFIyOVlabGR5WTJWVWQzZFlVamQyU1ZSWVlVRXlRVWRqVTJFM1UwNDNSbkJrY0ZOVU5GUm9URmRUUmpZd1dITnFXbUZUYjNsSlUxcFJVbGt4WjNGek5FVk5hMDF1ZDIxSlptUk5ialIwZWw5NGMxaHViSHBWUjBWbFptZ3RabE5FVEhwTFpIaDVMWEl4VFRKUFdYWkJaMm8zUVhGQ1FYWktYemhZWVVGNWRrNVllRmRMVEdsVFZFbFdUbFV5WkVsUFVFVjRhMTlITVMwd1RYZDBUVjgxTjJ0V1NHaHlWalp1WTFSNFFtbGtkak5OVGtaRFRsQnRTalpyVDFSZmJVbExaa2hyZWpRMVlUaHpTV3BmTTBKV2JVWlNNbWgzTjBGUE0wTjRTalY1TTBaeVJHdFhjMUV0VVdJeU5WSXlaRlZIVmxwblpsTk5SMDE1UkVrd1VXRk5kVTlSTkVod1gyNVRPSFpRTFdWemMyb3plRTlQZG1sS05HTk9aeTQyYkRSbE5tSjZhRll4UTNOU1JHSnhUeTFDTW5Cbi5pRS1fME9Pd0U4dFozcGc4U2djQXd3OVVHTjFXWWNxSGhxdmxJUTJPazZBIiwiZXhwIjoxNzMxNTYyNDM0LCJpYXQiOjE3MzE1NjIxMzR9.YA9pSJXBHc5W-ikZM0FkAybqaSSuX_th8Sp5JN31Auw","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-benchmark.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1731562135031), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*,true,false,1731562135031))), user_uuid -> 56c00954-5f53-4071-b02e-da08f0d77517, password -> Pa_ssw0rd, challenge -> 18DJF0LSIx8Blj2HhM9CvfUEMYursQcZSsYk0KjmR-Y, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 55.83.135.124, verifier -> LTExNjc0Mzg5MDQ5MjE2MTExMDE, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@302e637, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@13d2d973, tokenId -> 4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/58.0.3029.110 Safari/537.3),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x00007f02ec69a0e0@2d1a9f7d,io.netty.channel.epoll.EpollEventLoop@14f5da2c) 2024-11-14 05:29:22,145 INFO ========================= 2024-11-14 05:29:22,145 INFO HTTP request: 2024-11-14 05:29:22,145 INFO GET https://openam-perf-benchmark.forgeblocks.com/openidm/info/version 2024-11-14 05:29:22,145 INFO headers: 2024-11-14 05:29:22,145 INFO 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 2024-11-14 05:29:22,145 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-14 05:29:22,145 INFO Accept-Api-Version: 2024-11-14 05:29:22,145 INFO accept: */* 2024-11-14 05:29:22,145 INFO cookie: amlbcookie=01; 9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,145 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-14 05:29:22,145 INFO cookies: 2024-11-14 05:29:22,145 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-14 05:29:22,145 INFO 9b75a55744995d0=4OGYqXl5pUvdKS3meRuNqnAL0Gg.*AAJTSQACMDIAAlNLABxxMmhMR2l3YVM5NGdIaFlwQ3dmWlJZaTdHMGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-14 05:29:22,145 INFO ========================= 2024-11-14 05:29:22,145 INFO HTTP response: 2024-11-14 05:29:22,145 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-14 05:29:22,145 INFO [INFO] ------------------------------------------------------------------------ 2024-11-14 05:29:22,145 INFO [INFO] BUILD SUCCESS 2024-11-14 05:29:22,145 INFO [INFO] ------------------------------------------------------------------------ 2024-11-14 05:29:22,145 INFO [INFO] Total time: 01:00 h 2024-11-14 05:29:22,145 INFO [INFO] Finished at: 2024-11-14T05:28:55Z 2024-11-14 05:29:22,145 INFO [INFO] ------------------------------------------------------------------------ 2024-11-14 05:29:22,145 INFO 2024-11-14 05:28:55,737 INFO Gatling simulation run ended successfully 2024-11-14 05:29:22,145 INFO 2024-11-14 05:28:55,737 DEBUG No archive name provided. No archive will be created 2024-11-14 05:29:22,145 INFO ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 show_stderr : Display stderr order ________________________________________________________________________________ 2024-11-14 05:29:22,145 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/04_benchmark-70/stderr.txt is small (0 lines), printing all lines: 2024-11-14 05:29:22,145 DEBUG ----- output ----- 2024-11-14 05:29:22,145 DEBUG 2024-11-14 05:29:22,145 INFO ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 check_rc_and_logs : Check order's outputs ________________________________________________________________________________ PASS: no error found in rc log PASS: no error found in stdout log PASS: no error found in stderr log ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-11-14 05:29:22] benchmark-70 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped