--Task-- name: benchmark-130 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-120'] preceding_task: benchmark-120 options: {'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130-', 'testCase': 'idc.benchmark.Mix2024', 'testMode': 'open', 'throughput': 130} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock ________________________________________________________________________________ [2024-11-07 01:14:39] benchmark-130 pre : N/A ________________________________________________________________________________ 2024-11-07 01:14:39 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2024-11-07 01:14:39 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/benchmark-130/stdout.txt Pod log : /results/orders/benchmark-130 2024-11-07 01:14:39,469 INFO 2024-11-07 01:14:39,469 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-07 01:14:39,469 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 01:14:39,746 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 01:14:39,746 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:39,746 DEBUG --- stdout --- 2024-11-07 01:14:39,747 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 01:14:39,747 DEBUG --- stderr --- 2024-11-07 01:14:39,747 DEBUG ________________________________________________________________________________ [2024-11-07 01:14:39] benchmark-130 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-11-07 01:14:39,747 INFO 2024-11-07 01:14:39,747 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-07 01:14:39,747 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 01:14:40,024 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 01:14:40,024 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:40,024 DEBUG --- stdout --- 2024-11-07 01:14:40,024 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 01:14:40,024 DEBUG --- stderr --- 2024-11-07 01:14:40,024 DEBUG /lodestar/lodestar.py run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-benchmark" --results-folder="/results/gatling/benchmark-130" --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=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=130 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2024-11-07 01:14:40] benchmark-130 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-11-07 01:14:40,024 INFO 2024-11-07 01:14:40,025 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-07 01:14:40,025 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 01:14:40,299 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 01:14:40,299 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:40,299 DEBUG --- stdout --- 2024-11-07 01:14:40,299 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 01:14:40,299 DEBUG --- stderr --- 2024-11-07 01:14:40,299 DEBUG Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/order.json { "name": "benchmark-130", "command": " /lodestar/lodestar.py run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idc.benchmark.Mix2024@perf-benchmark\" --results-folder=\"/results/gatling/benchmark-130\" --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=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=130 -Duser_password=Pa_ssw0rd\"", "out-dir": "/results/orders/benchmark-130" } ________________________________________________________________________________ [2024-11-07 01:14:40] benchmark-130 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-07 01:14:40,303 INFO 2024-11-07 01:14:40,303 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-11-07 01:14:40,303 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-11-07 01:14:40,521 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-07 01:14:40,521 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:40,521 DEBUG --- stdout --- 2024-11-07 01:14:40,521 DEBUG WAITING 2024-11-07 01:14:40,521 DEBUG --- stderr --- 2024-11-07 01:14:40,521 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-07 01:14:40] benchmark-130 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-11-07 01:14:40,521 INFO 2024-11-07 01:14:40,521 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-07 01:14:40,521 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 01:14:40,799 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 01:14:40,799 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:40,799 DEBUG --- stdout --- 2024-11-07 01:14:40,799 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 01:14:40,799 DEBUG --- stderr --- 2024-11-07 01:14:40,799 DEBUG 2024-11-07 01:14:40,800 INFO 2024-11-07 01:14:40,800 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/06_benchmark-130/order.json overseer-0-6644bb6697-9gfkx:/results/orders/order.json 2024-11-07 01:14:40,800 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 01:14:42,159 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:42,159 DEBUG --- stdout --- 2024-11-07 01:14:42,159 DEBUG 2024-11-07 01:14:42,159 DEBUG --- stderr --- 2024-11-07 01:14:42,159 DEBUG Order has been successfully forwarded to overseer 2024-11-07 01:14:42 - INFO: Check if Gatling simulation started successfully 2024-11-07 01:14:42,160 INFO 2024-11-07 01:14:42,160 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-07 01:14:42,160 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 01:14:42,434 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 01:14:42,434 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:42,434 DEBUG --- stdout --- 2024-11-07 01:14:42,434 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 01:14:42,434 DEBUG --- stderr --- 2024-11-07 01:14:42,434 DEBUG 2024-11-07 01:14:42,434 INFO 2024-11-07 01:14:42,434 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx -- head --lines 5000 /results/orders/benchmark-130/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2024-11-07 01:14:42,434 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-11-07 01:14:43,152 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2024-11-07 01:14:48,883 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2024-11-07 01:14:54,622 INFO [loop_until]: Function succeeded after 12s (rc=0) - expected pattern found 2024-11-07 01:14:54,622 INFO [loop_until]: OK (rc = 0) 2024-11-07 01:14:54,622 DEBUG --- stdout --- 2024-11-07 01:14:54,622 DEBUG 2024-11-07 01:14:43,005 DEBUG Creating results folder /results/gatling/benchmark-130 2024-11-07 01:14:43,012 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpa1zzaiwf 2024-11-07 01:14:43,014 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-130" -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=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=130 -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/tmpa1zzaiwf/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/tmpa1zzaiwf/target/test-classes ... [INFO] compile in 7.0 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. 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-07 01:14:54,622 DEBUG --- stderr --- 2024-11-07 01:14:54,622 DEBUG ________________________________________________________________________________ [2024-11-07 01:14:54] benchmark-130 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 01s, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 02s, retry Order is running since 14m 02s, retry Order is running since 16m 02s, retry Order is running since 18m 03s, retry Order is running since 20m 03s, retry Order is running since 22m 03s, retry Order is running since 24m 03s, retry Order is running since 26m 04s, retry Order is running since 28m 04s, retry Order is running since 30m 04s, retry Order is running since 32m 05s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 06s, retry Order is running since 40m 06s, retry Order is running since 42m 06s, retry Order is running since 44m 07s, retry Order is running since 46m 07s, retry Order is running since 48m 07s, retry Order is running since 50m 08s, retry Order is running since 52m 08s, retry Order is running since 54m 08s, retry Order is running since 56m 09s, retry Order is running since 58m 09s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2024-11-07 02:15:04] benchmark-130 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-11-07 02:15:04,387 INFO 2024-11-07 02:15:04,387 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-07 02:15:04,387 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:04,700 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:04,700 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:04,700 DEBUG --- stdout --- 2024-11-07 02:15:04,700 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:04,700 DEBUG --- stderr --- 2024-11-07 02:15:04,700 DEBUG 2024-11-07 02:15:04,700 INFO 2024-11-07 02:15:04,700 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx -- rm -f /results/orders/order.json 2024-11-07 02:15:04,700 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 02:15:05,470 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:05,470 DEBUG --- stdout --- 2024-11-07 02:15:05,471 DEBUG 2024-11-07 02:15:05,471 DEBUG --- stderr --- 2024-11-07 02:15:05,471 DEBUG Order ran during 1h ________________________________________________________________________________ [2024-11-07 02:15:05] benchmark-130 download_logs : Download individual order files ________________________________________________________________________________ 2024-11-07 02:15:05 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/order.json 2024-11-07 02:15:05,471 INFO 2024-11-07 02:15:05,471 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-07 02:15:05,471 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:05,747 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:05,748 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:05,748 DEBUG --- stdout --- 2024-11-07 02:15:05,748 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:05,748 DEBUG --- stderr --- 2024-11-07 02:15:05,748 DEBUG Checking pod: overseer-0-6644bb6697-9gfkx for file exists, if not wait. 2024-11-07 02:15:05,748 INFO 2024-11-07 02:15:05,748 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-07 02:15:05,748 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:06,022 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:06,022 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:06,022 DEBUG --- stdout --- 2024-11-07 02:15:06,022 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:06,022 DEBUG --- stderr --- 2024-11-07 02:15:06,022 DEBUG 2024-11-07 02:15:06,023 INFO 2024-11-07 02:15:06,023 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- bash -c 'if [ -f "/results/orders/benchmark-130/rc.txt" ]; then echo "/results/orders/benchmark-130/rc.txt file found"; exit 0; else echo "/results/orders/benchmark-130/rc.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-130/rc.txt file found" 2024-11-07 02:15:06,023 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 02:15:06,816 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-07 02:15:06,817 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:06,817 DEBUG --- stdout --- 2024-11-07 02:15:06,817 DEBUG /results/orders/benchmark-130/rc.txt file found 2024-11-07 02:15:06,817 DEBUG --- stderr --- 2024-11-07 02:15:06,817 DEBUG 2024-11-07 02:15:06,817 INFO 2024-11-07 02:15:06,817 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-07 02:15:06,817 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:07,093 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:07,093 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:07,093 DEBUG --- stdout --- 2024-11-07 02:15:07,093 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:07,093 DEBUG --- stderr --- 2024-11-07 02:15:07,093 DEBUG 2024-11-07 02:15:07,093 INFO 2024-11-07 02:15:07,093 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- du -k /results/orders/benchmark-130/rc.txt 2024-11-07 02:15:07,891 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-07 02:15:07,891 DEBUG --- stdout --- 2024-11-07 02:15:07,892 DEBUG 4 /results/orders/benchmark-130/rc.txt 2024-11-07 02:15:07,892 DEBUG --- stderr --- 2024-11-07 02:15:07,892 DEBUG 2024-11-07 02:15:07,892 INFO - Download file (size 4k) 2024-11-07 02:15:07,892 INFO 2024-11-07 02:15:07,892 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-07 02:15:07,892 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:08,166 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:08,166 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:08,166 DEBUG --- stdout --- 2024-11-07 02:15:08,166 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:08,166 DEBUG --- stderr --- 2024-11-07 02:15:08,166 DEBUG source : /results/orders/benchmark-130/rc.txt @ overseer-0-6644bb6697-9gfkx destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/rc.txt 2024-11-07 02:15:08,166 INFO 2024-11-07 02:15:08,166 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-07 02:15:08,166 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:08,444 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:08,444 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:08,444 DEBUG --- stdout --- 2024-11-07 02:15:08,444 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:08,444 DEBUG --- stderr --- 2024-11-07 02:15:08,444 DEBUG 2024-11-07 02:15:08,444 INFO 2024-11-07 02:15:08,444 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-9gfkx:/results/orders/benchmark-130/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/rc.txt 2024-11-07 02:15:08,444 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-07 02:15:09,161 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:09,161 DEBUG --- stdout --- 2024-11-07 02:15:09,161 DEBUG tar: Removing leading `/' from member names 2024-11-07 02:15:09,161 DEBUG --- stderr --- 2024-11-07 02:15:09,161 DEBUG 2024-11-07 02:15:09,161 INFO 2024-11-07 02:15:09,161 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-07 02:15:09,161 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:09,436 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:09,436 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:09,436 DEBUG --- stdout --- 2024-11-07 02:15:09,436 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:09,436 DEBUG --- stderr --- 2024-11-07 02:15:09,436 DEBUG Checking pod: overseer-0-6644bb6697-9gfkx for file exists, if not wait. 2024-11-07 02:15:09,437 INFO 2024-11-07 02:15:09,437 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-07 02:15:09,437 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:09,729 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:09,729 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:09,729 DEBUG --- stdout --- 2024-11-07 02:15:09,729 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:09,729 DEBUG --- stderr --- 2024-11-07 02:15:09,729 DEBUG 2024-11-07 02:15:09,730 INFO 2024-11-07 02:15:09,730 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- bash -c 'if [ -f "/results/orders/benchmark-130/stderr.txt" ]; then echo "/results/orders/benchmark-130/stderr.txt file found"; exit 0; else echo "/results/orders/benchmark-130/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-130/stderr.txt file found" 2024-11-07 02:15:09,730 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 02:15:10,525 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-07 02:15:10,525 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:10,525 DEBUG --- stdout --- 2024-11-07 02:15:10,525 DEBUG /results/orders/benchmark-130/stderr.txt file found 2024-11-07 02:15:10,525 DEBUG --- stderr --- 2024-11-07 02:15:10,525 DEBUG 2024-11-07 02:15:10,525 INFO 2024-11-07 02:15:10,525 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-07 02:15:10,525 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:10,801 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:10,801 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:10,801 DEBUG --- stdout --- 2024-11-07 02:15:10,801 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:10,801 DEBUG --- stderr --- 2024-11-07 02:15:10,801 DEBUG 2024-11-07 02:15:10,802 INFO 2024-11-07 02:15:10,802 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- du -k /results/orders/benchmark-130/stderr.txt 2024-11-07 02:15:11,590 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-07 02:15:11,590 DEBUG --- stdout --- 2024-11-07 02:15:11,591 DEBUG 0 /results/orders/benchmark-130/stderr.txt 2024-11-07 02:15:11,591 DEBUG --- stderr --- 2024-11-07 02:15:11,591 DEBUG 2024-11-07 02:15:11,591 INFO - Download file (size 0k) 2024-11-07 02:15:11,591 INFO 2024-11-07 02:15:11,591 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-07 02:15:11,591 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:11,866 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:11,866 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:11,866 DEBUG --- stdout --- 2024-11-07 02:15:11,866 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:11,866 DEBUG --- stderr --- 2024-11-07 02:15:11,866 DEBUG source : /results/orders/benchmark-130/stderr.txt @ overseer-0-6644bb6697-9gfkx destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/stderr.txt 2024-11-07 02:15:11,867 INFO 2024-11-07 02:15:11,867 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-07 02:15:11,867 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:12,143 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:12,144 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:12,144 DEBUG --- stdout --- 2024-11-07 02:15:12,144 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:12,144 DEBUG --- stderr --- 2024-11-07 02:15:12,144 DEBUG 2024-11-07 02:15:12,144 INFO 2024-11-07 02:15:12,144 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-9gfkx:/results/orders/benchmark-130/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/stderr.txt 2024-11-07 02:15:12,144 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-07 02:15:12,904 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:12,904 DEBUG --- stdout --- 2024-11-07 02:15:12,904 DEBUG tar: Removing leading `/' from member names 2024-11-07 02:15:12,904 DEBUG --- stderr --- 2024-11-07 02:15:12,904 DEBUG 2024-11-07 02:15:12,905 INFO 2024-11-07 02:15:12,905 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-07 02:15:12,905 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:13,180 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:13,180 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:13,180 DEBUG --- stdout --- 2024-11-07 02:15:13,180 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:13,180 DEBUG --- stderr --- 2024-11-07 02:15:13,180 DEBUG Checking pod: overseer-0-6644bb6697-9gfkx for file exists, if not wait. 2024-11-07 02:15:13,180 INFO 2024-11-07 02:15:13,180 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-07 02:15:13,180 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:13,455 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:13,455 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:13,455 DEBUG --- stdout --- 2024-11-07 02:15:13,455 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:13,455 DEBUG --- stderr --- 2024-11-07 02:15:13,456 DEBUG 2024-11-07 02:15:13,456 INFO 2024-11-07 02:15:13,456 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- bash -c 'if [ -f "/results/orders/benchmark-130/stdout.txt" ]; then echo "/results/orders/benchmark-130/stdout.txt file found"; exit 0; else echo "/results/orders/benchmark-130/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-130/stdout.txt file found" 2024-11-07 02:15:13,456 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 02:15:14,259 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-07 02:15:14,259 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:14,259 DEBUG --- stdout --- 2024-11-07 02:15:14,259 DEBUG /results/orders/benchmark-130/stdout.txt file found 2024-11-07 02:15:14,259 DEBUG --- stderr --- 2024-11-07 02:15:14,259 DEBUG 2024-11-07 02:15:14,260 INFO 2024-11-07 02:15:14,260 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-07 02:15:14,260 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:14,535 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:14,535 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:14,535 DEBUG --- stdout --- 2024-11-07 02:15:14,535 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:14,535 DEBUG --- stderr --- 2024-11-07 02:15:14,535 DEBUG 2024-11-07 02:15:14,535 INFO 2024-11-07 02:15:14,536 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- du -k /results/orders/benchmark-130/stdout.txt 2024-11-07 02:15:15,335 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-07 02:15:15,335 DEBUG --- stdout --- 2024-11-07 02:15:15,336 DEBUG 4747436 /results/orders/benchmark-130/stdout.txt 2024-11-07 02:15:15,336 DEBUG --- stderr --- 2024-11-07 02:15:15,336 DEBUG 2024-11-07 02:15:15,336 INFO - Download file (size 4747436k) 2024-11-07 02:15:15,336 INFO 2024-11-07 02:15:15,336 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-07 02:15:15,336 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:15,611 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:15,611 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:15,611 DEBUG --- stdout --- 2024-11-07 02:15:15,611 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:15,611 DEBUG --- stderr --- 2024-11-07 02:15:15,611 DEBUG source : /results/orders/benchmark-130/stdout.txt @ overseer-0-6644bb6697-9gfkx destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/stdout.txt 2024-11-07 02:15:15,611 INFO 2024-11-07 02:15:15,611 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-07 02:15:15,611 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:15:15,894 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:15:15,894 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:15:15,894 DEBUG --- stdout --- 2024-11-07 02:15:15,894 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:15:15,894 DEBUG --- stderr --- 2024-11-07 02:15:15,894 DEBUG 2024-11-07 02:15:15,895 INFO 2024-11-07 02:15:15,895 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-9gfkx:/results/orders/benchmark-130/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/stdout.txt 2024-11-07 02:15:15,895 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-07 02:17:09,667 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:09,667 DEBUG --- stdout --- 2024-11-07 02:17:09,667 DEBUG tar: Removing leading `/' from member names 2024-11-07 02:17:09,667 DEBUG --- stderr --- 2024-11-07 02:17:09,667 DEBUG ________________________________________________________________________________ [2024-11-07 02:17:09] benchmark-130 show_cmd : Display order command ________________________________________________________________________________ 2024-11-07 02:17:09,668 INFO 2024-11-07 02:17:09,668 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-07 02:17:09,668 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:17:09,967 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:17:09,967 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:09,967 DEBUG --- stdout --- 2024-11-07 02:17:09,967 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:17:09,967 DEBUG --- stderr --- 2024-11-07 02:17:09,967 DEBUG Checking pod: overseer-0-6644bb6697-9gfkx for file exists, if not wait. 2024-11-07 02:17:09,967 INFO 2024-11-07 02:17:09,967 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-07 02:17:09,967 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:17:10,243 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:17:10,244 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:10,244 DEBUG --- stdout --- 2024-11-07 02:17:10,244 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:17:10,244 DEBUG --- stderr --- 2024-11-07 02:17:10,244 DEBUG 2024-11-07 02:17:10,245 INFO 2024-11-07 02:17:10,245 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- bash -c 'if [ -f "/results/orders/benchmark-130/cmd.txt" ]; then echo "/results/orders/benchmark-130/cmd.txt file found"; exit 0; else echo "/results/orders/benchmark-130/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-130/cmd.txt file found" 2024-11-07 02:17:10,245 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-11-07 02:17:11,078 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-11-07 02:17:11,079 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:11,079 DEBUG --- stdout --- 2024-11-07 02:17:11,079 DEBUG /results/orders/benchmark-130/cmd.txt file found 2024-11-07 02:17:11,079 DEBUG --- stderr --- 2024-11-07 02:17:11,079 DEBUG 2024-11-07 02:17:11,079 INFO 2024-11-07 02:17:11,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-07 02:17:11,079 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:17:11,356 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:17:11,356 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:11,356 DEBUG --- stdout --- 2024-11-07 02:17:11,356 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:17:11,356 DEBUG --- stderr --- 2024-11-07 02:17:11,356 DEBUG 2024-11-07 02:17:11,356 INFO 2024-11-07 02:17:11,357 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6644bb6697-9gfkx --stdin -- du -k /results/orders/benchmark-130/cmd.txt 2024-11-07 02:17:12,150 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-11-07 02:17:12,150 DEBUG --- stdout --- 2024-11-07 02:17:12,150 DEBUG 4 /results/orders/benchmark-130/cmd.txt 2024-11-07 02:17:12,150 DEBUG --- stderr --- 2024-11-07 02:17:12,150 DEBUG 2024-11-07 02:17:12,150 INFO - Download file (size 4k) 2024-11-07 02:17:12,151 INFO 2024-11-07 02:17:12,151 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-07 02:17:12,151 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:17:12,426 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:17:12,426 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:12,426 DEBUG --- stdout --- 2024-11-07 02:17:12,426 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:17:12,426 DEBUG --- stderr --- 2024-11-07 02:17:12,426 DEBUG source : /results/orders/benchmark-130/cmd.txt @ overseer-0-6644bb6697-9gfkx destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/cmd.txt 2024-11-07 02:17:12,426 INFO 2024-11-07 02:17:12,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-07 02:17:12,426 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-11-07 02:17:12,705 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-11-07 02:17:12,705 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:12,705 DEBUG --- stdout --- 2024-11-07 02:17:12,705 DEBUG overseer-0-6644bb6697-9gfkx 2024-11-07 02:17:12,705 DEBUG --- stderr --- 2024-11-07 02:17:12,705 DEBUG 2024-11-07 02:17:12,706 INFO 2024-11-07 02:17:12,706 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6644bb6697-9gfkx:/results/orders/benchmark-130/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/cmd.txt 2024-11-07 02:17:12,706 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-11-07 02:17:13,461 INFO [loop_until]: OK (rc = 0) 2024-11-07 02:17:13,461 DEBUG --- stdout --- 2024-11-07 02:17:13,461 DEBUG tar: Removing leading `/' from member names 2024-11-07 02:17:13,461 DEBUG --- stderr --- 2024-11-07 02:17:13,461 DEBUG 2024-11-07 02:17:13,461 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/cmd.txt is small (1 lines), printing all lines: 2024-11-07 02:17:13,461 DEBUG ----- output ----- 2024-11-07 02:17:13,461 DEBUG /lodestar/lodestar.py run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@perf-benchmark" --results-folder="/results/gatling/benchmark-130" --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=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=130 -Duser_password=Pa_ssw0rd" 2024-11-07 02:17:13,461 INFO ________________________________________________________________________________ [2024-11-07 02:17:13] benchmark-130 show_rc : Display rc order ________________________________________________________________________________ 2024-11-07 02:17:13,461 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/rc.txt is small (1 lines), printing all lines: 2024-11-07 02:17:13,461 DEBUG ----- output ----- 2024-11-07 02:17:13,461 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-11-07 02:17:13,461 INFO ________________________________________________________________________________ [2024-11-07 02:17:13] benchmark-130 show_stdout : Display stdout order ________________________________________________________________________________ 2024-11-07 02:17:19,873 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/06_benchmark-130/stdout.txt is 44746976 lines): 2024-11-07 02:17:19,874 DEBUG ----- output ----- 2024-11-07 02:17:19,874 INFO 2024-11-07 01:14:43,005 DEBUG Creating results folder /results/gatling/benchmark-130 2024-11-07 02:17:19,874 INFO 2024-11-07 01:14:43,012 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpa1zzaiwf 2024-11-07 02:17:19,874 INFO 2024-11-07 01:14:43,014 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-130" -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=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Dprefix=self130- -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=130 -Duser_password=**** 2024-11-07 02:17:19,874 INFO [INFO] Scanning for projects... 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- 2024-11-07 02:17:19,874 INFO [INFO] Building pyrock-gatling-simulation 3.12.0 2024-11-07 02:17:19,874 INFO [INFO] from pom.xml 2024-11-07 02:17:19,874 INFO [INFO] --------------------------------[ jar ]--------------------------------- 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] skip non existing resourceDirectory /tmp/tmpa1zzaiwf/src/main/resources 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] No sources to compile 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] Copying 2 resources from src/test/resources to target/test-classes 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] Nothing to compile - all classes are up to date. 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] compiling 38 Scala sources to /tmp/tmpa1zzaiwf/target/test-classes ... 2024-11-07 02:17:19,874 INFO [INFO] compile in 7.0 s 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] 2024-11-07 02:17:19,874 INFO [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- 2024-11-07 02:17:19,874 INFO [INFO] Running simulation com.forgerock.pyrock.Loadtest. 2024-11-07 02:17:19,874 INFO System property think_time_multiplier not set. No think time emulation will be done in the simulation. 2024-11-07 02:17:19,874 INFO Simulation com.forgerock.pyrock.Loadtest started... 2024-11-07 02:17:19,874 INFO 2024-11-07 02:17:19,874 INFO ================================================================================ 2024-11-07 02:17:19,874 INFO 2024-11-07 01:14:59 GMT 5s elapsed 2024-11-07 02:17:19,874 INFO ---- Requests ------------------------------------------------------------------ 2024-11-07 02:17:19,874 INFO > Global (OK=639 KO=0 ) 2024-11-07 02:17:19,874 INFO > restLoginInitiate (OK=53 KO=0 ) 2024-11-07 02:17:19,874 INFO > restLoginUsernamePasswordCallback (OK=51 KO=0 ) 2024-11-07 02:17:19,874 INFO > User Authorize PKCE stage (OK=61 KO=0 ) 2024-11-07 02:17:19,874 INFO > User AccessToken PKCE stage (OK=60 KO=0 ) 2024-11-07 02:17:19,874 INFO > tokenUserinfo (OK=6 KO=0 ) 2024-11-07 02:17:19,874 INFO > Skip 2FA (OK=30 KO=0 ) 2024-11-07 02:17:19,874 INFO > RootUserinfo (OK=12 KO=0 ) 2024-11-07 02:17:19,874 INFO > UI-Post-Login - stage 1 (OK=14 KO=0 ) 2024-11-07 02:17:19,874 INFO > UI-Post-Login - stage 1 Redirect 1 (OK=14 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI AM idFromSession (OK=13 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI AM validateGoto (OK=13 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Post-Login - stage 2 (OK=13 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Post-Login - stage 2 Redirect 1 (OK=12 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI Enduser appAuthHelper1 (OK=12 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI Enduser appAuthHelper2 (OK=12 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Post-Login - stage 3 (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > getIdToken (OK=5 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Post-Login - stage 3 Redirect 1 (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > getIdToken Redirect 1 (OK=5 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI Enduser sessioncheck (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM uiconfig (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM version (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM features (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM login (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM privilege (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > createOrganization (OK=5 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM dashboard (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM managed user schema (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM user (OK=11 KO=0 ) 2024-11-07 02:17:19,875 INFO > GetUUid (OK=18 KO=0 ) 2024-11-07 02:17:19,875 INFO > queryOrganization (OK=4 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI IDM oidcToken (OK=10 KO=0 ) 2024-11-07 02:17:19,875 INFO > GetOpenidConfig (OK=17 KO=0 ) 2024-11-07 02:17:19,875 INFO > deleteOrganization (OK=4 KO=0 ) 2024-11-07 02:17:19,875 INFO > userinfo (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > CreatePolicy (OK=17 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Logout (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI-Logout Redirect 1 (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI AM revoke2 (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI AM endsession (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > UI AM revoke1 (OK=9 KO=0 ) 2024-11-07 02:17:19,875 INFO > restloginProgressiveProfileCallback (OK=3 KO=0 ) 2024-11-07 02:17:19,875 INFO 2024-11-07 02:17:19,875 INFO ---- idc.benchmark.Mix2024 ----------------------------------------------------- 2024-11-07 02:17:19,875 INFO [- ] 0% 2024-11-07 02:17:19,875 INFO waiting: 469165 / active: 35 / done: 19 2024-11-07 02:17:19,875 INFO ================================================================================ 2024-11-07 02:17:19,875 INFO 2024-11-07 02:17:19,875 INFO 01:15:03.035 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request tokenUserinfo: No attribute named 'access_token' is defined 2024-11-07 02:17:19,875 INFO 2024-11-07 02:17:19,875 INFO ================================================================================ 2024-11-07 02:17:19,875 INFO 2024-11-07 01:15:04 GMT 10s elapsed 2024-11-07 02:17:19,875 INFO ---- Requests ------------------------------------------------------------------ 2024-11-07 02:17:19,875 INFO > Global (OK=2689 KO=0 ) 2024-11-07 02:17:19,875 INFO > restLoginInitiate (OK=207 KO=0 ) 2024-11-07 02:17:19,875 INFO > restLoginUsernamePasswordCallback (OK=203 KO=0 ) 2024-11-07 02:17:19,875 INFO > User Authorize PKCE stage (OK=245 KO=0 ) 2024-11-07 02:17:19,875 INFO > User AccessToken PKCE stage (OK=244 KO=0 ) 2024-11-07 02:17:19,875 INFO > tokenUserinfo (OK=33 KO=0 ) 2024-11-07 02:17:19,875 INFO > Skip 2FA (OK=115 KO=0 ) 2024-11-07 02:17:19,875 INFO [...] 2024-11-07 02:17:30,293 INFO ========================= 2024-11-07 02:17:30,294 INFO Session: 2024-11-07 02:17:30,294 INFO Session(idc.benchmark.Mix2024,461432,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, username -> user.453088, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@37ffed18, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, callbacks -> {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiIzM2RiMTAxZC00MzliLTRlMDItYTFkYy03YWIxMjM0YmI2OTAiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiZ2trbWQzMjkwaDV2cGt2MmpkNTQ5NGlsc2giLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1QlpYSktjSGg1VjAwd2FsbFNNa2h3T0VsTFZGaG5MbmRVVkVkcVN6QkxWa2RPTmtkWGNEQlhlRGROWDI5bE0wVmxObXR1TWtaQ2IybzBlRmxrYUVOZlZWQlhSemh1UVdzME16Um5UQzEyWTBwcmMwNUVhSEUzYWtJMGNrUjRkMU5TVUROaFRFTXdWRVprTVcxc2VHcElRbG8zYzBKaVpVeE5TUzFTU2xOeVZHVnlRbFEyYVVkbldVeEdaRGxVTldobWFXWkNRVWRyUm5Cb2RHMVBWVEZ3WlZGUFJqSnhURTEyYkhseldYbDRiM0pDZFc0M1UzQlBRbWhhWVVnMVQzZGtkVE5tT1VOU01sRTJPR1pDYVZSYVIxQnZkbmw1VEMxNk0ycHVOVFZ0Vm1kS1lqWjVja3hDTTBOTU5UWlJWVEJUYkRSaFMwb3RZbE53Ukd4Tk4yZFZjbE13Y1Zkck5HVXlkekpOWVRVMFNHMDNNemRwZDNaTk1IYzVhak5NU1RScmIyMHlYMmc1VlZacGFqTjRjVVZ2U2pWRlVHRldSVEpGYlhOR0xVRm1VMVpZZVdGdWJ6bHZjMnhTTm00MGVsUkNXRXBwZUZCdk9VNXJVbWszYzNCd04xZEZVR0pZU0ZORGMzcDBWRVJ5VEY5QlprMHpYMkpUZGpKNVZGcFNOblJvZVd4R1IzbGlhekEzV0ZGM05Ib3dSVlExZWtSQmRtUnVNbXBFYzB3NWJFNDNRblExTmpobmVHUnJXR0kwY0RSMFNGUkxWVnByYTNsc2QxcHdXREJqU25FNVNXVlhXSGRMTXpJdFgwSlNlRlZqTjJkSWNXOVBPVXg1UTBwYWJWTnlUMWRwUVRCWU1WQlZhbUkwZEd4QlNYTlhObG80YkdkeWVIVkpUbmswYkY5MVZuaFZOV3RrV1VaTWJsbEJWbTFvYlUxRVIyWmZaV2RKVVY5V2MzbFFlVU16T0ZkS2RsbzNhbEExT1MxeVVVNHlWRzV1Ulc1cVVUZE5aRTFxTXpWa2EwcFlTazVxUkZOSk4xRk9NMU5UTUMxclEwdFJjbGxmYmxGTk5GTk1jWGxRVWt4TWJ6aHdla2Q1WjNKMmRuSllYMk55U2xWMFpFTTRNelZoUzFJNE1VSkNOVTVhUlZFNFNWbEJSVzFXVEVKck5qTlJXV1JOTm5KVU9GWlZTSGRvZW5KcFVtbHJibnBHUjNkVU1YbHBTSE51Y2pkV2JrNWZNbEZtWlZodE9EZzFVVkZsTldaaVNFOTVRMFJ2YVdnd1JtY3liMk5NWWtSc1FqbHdUMlZFTjBSb2NtbFNSMGRmVUVFd1RFWlhTbU0wZFcxNlNUTnBiMFpwTmxrNFFVMU5jMkZmVG5jelZqSkNiMGxDU1ZZMFQxY3dlamRMYjFwbVdIQnlaems0YmpZMWVGRm9USFkyTUZodWNHaENTVzFPVEZoT1R6QnBlWGRtTWpoMllXZExaRkpmUlRGWVoycHFiRmxGWm1GMmJFZHhWR0ZJYjFjeFZuQjJTMjgwTkUxc01UQjZTbFpOYURWR04zcEZObmhITW5KRVZFMUxVMTgyWWpCbmRWSkhZWFZhYkhaeGJWUm1SRkJCYkRKUmR6UklPRVZRZWxCb1lUUkRTMnBIWkY5YVpWcEJNMmt6YnpOTmRGUm5TV2gwZEhJd1EzbEhWa2QyT1RGbmFubFFYM2s1Y21WeE1UbEJOM2RPUlZkUGJrSkpkR1p3VlVKNk9EVm5hRTFyVjE5aldEZFJkM05VTlUwM1NUQlNPVFJ4VEZWVGFtVkZkRVI2U21oUlZEaG5lbFEzVFRrd1ZHRmFWR05GU2pGNVQwZGphMjVWZEUxemMxQnhXbE5hVFdSZkxVaElUV3hOTm5Wa1dGUjZlVXRrYVV0TWREVlVSMk5hV1VoQldqRjFjemRrYW5aRlUyazNSMDQyV0ZGUmFYaEJWazVQUVZac2RIUjJTVXRCTldWM2VYRk5XbmhyYVRGSFp6WlJkVzE0V1Rsa1NqRkZZV3RIYTFVMVN5MXlVblpWY1d4R01ERTJVRTFvUzFkRlpXbG1XVFE0VGxocmFVcERRa3BKYjJObFRUUnVPRGxDWDIxblRtbElia05oZWpjd1kydG1TbkJ4Y0RWME1UTTNNRkJzU1VaSFluSXhSekY0VFVoQlRGRkhVRE51UjIxT1lWZFJhVlZ4VlVneVJHOU9TRUYzZDJRek1GVjNUMVl6TlVKNVgyOHhUR3RRZWtOUVUxZEJZV1J6VGpWdFVscDZRVVpLVm5sTGMyRnlkWFV5VlRsdWNWaFJXSFZETkRKbk9WSjZWMkpxYWt4alZXaHVXV1JVWldadmMyNTJWR3RMZFRZMWQwaFNkR3BCYmtGNlJ6SlBURmxRUzBGaFkwbGpMVVEwUWxkTmExSTRSR2hSWjBvMlkyaDBSbVpPYkdaVWVGTjBOVVZ4ZVZWclZqSkRPRFZYY210YWMyNDRiRXBsVm0wNFNraFJka3B5WjFOSFVFZ3hOamhNU1doNE9WSlhNVGt5VUZwUFVYQTJSRFF3VHpKVFEzaFRYMGxvVkdaUVdFRjNUV0ZxVkRjdExVbHVOR2cyY1dGRVdUazVaRTFoY2pGVlExcE1MVkpNTFRkNGNURTRNVWgyYkRSS1QzQTVVV0Z2V0hWQ05EazVTMGhEUmtkTlREaDFja3B5ZDJwRFZGTXRlR2MxWVRsSlVrMXFjazB3VEZSZlJHcEZTM0ZFTVZjeVFVRkxkM2c1YmtaMmMzUkdWV1pUYTNwVWMwY3dWSFprYVhCM2RXd3dlblZDWlZaWGRWRnRTMVpuUkZSWGNVTm5jamhRTlVoeldqVjRWMGczZWpCTlpsRlRiV0pxVVcxa2RURXhNM1Z6Y1hkdVZXRjFNbkk0WkVkMVJrVTNUbHBXVjBoVmIzQlBYMWxrYTBGWk5USXpUME0xYTJGZlpsTkVhVk5TUW1ac1lrTTJTbkphVmpsQlozYzVNMjFyZW1WV1NtUTBhSEo1VUZScmRGbEthbk5IV1VwS05EVmZVMUpyYURGWFMyTnBUamRLYm5Wdll6aFVOR0pHZFdWVVJtOXZUMU5DUTFsQlJteGtWM1EyY2xKbExUZHlUVlUxTW1vd2ExaHFkakZuY0ZsWGNFZ3hlbGR3WmtJdFkwbFdaVFZJVFVSek4yc3lhSGRHUzNaSVZISXdiMHhST0VaMVlUWlhRVjlRUTJkb2MwUndZWE4xV1MxWWFtaE1WRGh1VTJaUlMwcDBUVzU2UkdwSlNXRkdVMDVVVVdRd1pHaEtjak5tZGtkUGFURnZlSEpDUWxObFNVWklPRmcwYTJKRVpWTkVXSFJHUWxJeGNXOUljRjlSVTNoS1NEaFBlVlJQY1c1V1NVMXJSR1J1UjJKeWNXZFBSM0Z0YWpGWlJtWjNUMFpvT0VsNWJVdENhV2xYVjBSUmNXeFJXamxDYm1SYWFqZFlXSEZzWVZvMGR6QkVlR0ZWTXpSdWNubE5kMHBvV0UxVGRYSXdXVk5TUkV0U05Fc3lXREprVDBaWlVraHJjRWhsTkdsNGRWcDFaekp2UW5OR2RFOTBaVGxDVDE5SFNIQkhha0pKUms5WWEwTnFiblJPT0Y5aFkyUndlVEJRTldodlFYYzNaRUZpVTFsdWJ6Wm1OV3hsZEZSRFJuSkZRbUkwWTJVd2NqVndSM2RQZWxST2VuY3paeTVvVlZCdVpYWjBSelJhV0UxWk1IQlBZaTFNZDBSUi5xRHdlZjlSdi1BNzMxd1pIeElRaUlFSWk5TllQZk9HV0F0S1RoVDRMSWM0IiwiZXhwIjoxNzMwOTQ1OTY0LCJpYXQiOjE3MzA5NDU2NjR9.MeIxlLE2zioaUhMIg9HXOQMgAAa5MN0lm2JLCsbZIoI","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,1730945665063), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=0Kk7eJx_K544on3rWfgGGf1d9GA.*AAJTSQACMDIAAlNLABxuclduMm5pQzF2K2xEYitlRXlCVWUrUjJSVFE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*,true,false,1730945665063))), password -> Pa_ssw0rd, fake-ip -> 42.42.42.42, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@1274061f, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@408f082f, tokenId -> 0Kk7eJx_K544on3rWfgGGf1d9GA.*AAJTSQACMDIAAlNLABxuclduMm5pQzF2K2xEYitlRXlCVWUrUjJSVFE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, 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),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x0000798d6869a0e0@1bcc8a2f,io.netty.channel.epoll.EpollEventLoop@652a7737) 2024-11-07 02:17:30,294 INFO ========================= 2024-11-07 02:17:30,294 INFO HTTP request: 2024-11-07 02:17:30,294 INFO POST https://openam-perf-benchmark.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto 2024-11-07 02:17:30,294 INFO headers: 2024-11-07 02:17:30,294 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-07 02:17:30,294 INFO Accept-API-Version: resource=2.1, protocol=1.0 2024-11-07 02:17:30,294 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-07 02:17:30,294 INFO accept: */* 2024-11-07 02:17:30,294 INFO cookie: amlbcookie=01; 9b75a55744995d0=0Kk7eJx_K544on3rWfgGGf1d9GA.*AAJTSQACMDIAAlNLABxuclduMm5pQzF2K2xEYitlRXlCVWUrUjJSVFE9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-07 02:17:30,294 INFO origin: https://openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,294 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,294 INFO content-length: 0 2024-11-07 02:17:30,294 INFO cookies: 2024-11-07 02:17:30,294 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-07 02:17:30,294 INFO 9b75a55744995d0=0Kk7eJx_K544on3rWfgGGf1d9GA.*AAJTSQACMDIAAlNLABxuclduMm5pQzF2K2xEYitlRXlCVWUrUjJSVFE9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-07 02:17:30,294 INFO ========================= 2024-11-07 02:17:30,294 INFO HTTP response: 2024-11-07 02:17:30,294 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-07 02:17:30,294 INFO 02:14:54.213 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-104' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 2024-11-07 02:17:30,294 INFO 02:14:54.212 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-07 02:17:30,294 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-07 02:17:30,294 INFO Request: 2024-11-07 02:17:30,294 INFO UI AM validateGoto: KO j.i.IOException: Premature close 2024-11-07 02:17:30,294 INFO ========================= 2024-11-07 02:17:30,294 INFO Session: 2024-11-07 02:17:30,294 INFO Session(idc.benchmark.Mix2024,452902,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, username -> user.249389, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@55cfbc3d, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/am/, callbacks -> {"tokenId":"eeyTuzaIl0GVxwvue6zBF2r81tU.*AAJTSQACMDIAAlNLABw4ajBuRnZHZUYrQ2hJYVpvR1NKVEZoaWJ4WHM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","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,1730945642923), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=eeyTuzaIl0GVxwvue6zBF2r81tU.*AAJTSQACMDIAAlNLABw4ajBuRnZHZUYrQ2hJYVpvR1NKVEZoaWJ4WHM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1730945642923))), password -> Pa_ssw0rd, fake-ip -> 42.42.42.42, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@58566de0, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@647135cd, tokenId -> eeyTuzaIl0GVxwvue6zBF2r81tU.*AAJTSQACMDIAAlNLABw4ajBuRnZHZUYrQ2hJYVpvR1NKVEZoaWJ4WHM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (iPhone; CPU iPhone OS 10_3 like Mac OS X) AppleWebKit/602.1.50 (KHTML, like Gecko) CriOS/56.0.2924.75 Mobile/14E5239e Safari/602.1),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x0000798d6869a0e0@1bcc8a2f,io.netty.channel.epoll.EpollEventLoop@5b057c8c) 2024-11-07 02:17:30,294 INFO ========================= 2024-11-07 02:17:30,294 INFO HTTP request: 2024-11-07 02:17:30,294 INFO POST https://openam-perf-benchmark.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto 2024-11-07 02:17:30,294 INFO headers: 2024-11-07 02:17:30,294 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-07 02:17:30,294 INFO Accept-API-Version: resource=2.1, protocol=1.0 2024-11-07 02:17:30,294 INFO referer: https://openam-perf-benchmark.forgeblocks.com/am/ 2024-11-07 02:17:30,294 INFO accept: */* 2024-11-07 02:17:30,294 INFO cookie: amlbcookie=01; 9b75a55744995d0=eeyTuzaIl0GVxwvue6zBF2r81tU.*AAJTSQACMDIAAlNLABw4ajBuRnZHZUYrQ2hJYVpvR1NKVEZoaWJ4WHM9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-07 02:17:30,294 INFO origin: https://openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,294 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,294 INFO content-length: 0 2024-11-07 02:17:30,294 INFO cookies: 2024-11-07 02:17:30,294 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-07 02:17:30,294 INFO 9b75a55744995d0=eeyTuzaIl0GVxwvue6zBF2r81tU.*AAJTSQACMDIAAlNLABw4ajBuRnZHZUYrQ2hJYVpvR1NKVEZoaWJ4WHM9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-07 02:17:30,294 INFO ========================= 2024-11-07 02:17:30,294 INFO HTTP response: 2024-11-07 02:17:30,294 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-07 02:17:30,294 INFO 02:14:54.212 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-133' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 2024-11-07 02:17:30,294 INFO 02:14:54.213 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'GetOpenidConfig' failed for user 442774: j.i.IOException: Premature close 2024-11-07 02:17:30,294 INFO 02:14:54.213 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-07 02:17:30,294 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-07 02:17:30,295 INFO Request: 2024-11-07 02:17:30,295 INFO GetOpenidConfig: KO j.i.IOException: Premature close 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO Session: 2024-11-07 02:17:30,295 INFO Session(idc.benchmark.Mix2024,442774,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJyNFl0WW1RcVZXeGcwVkt2aWNzcllTMWd5NFE9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiI2MGE2M2NhYS1lOTBlLTQzYWMtODJkNi1lZjk2N2U3OGUzYmUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMjkyNTgwZDctOWFkMi00MDljLTg4OGItNjYyYmRiNTE2MDQ2LTg3NzMyODgwIiwic3VibmFtZSI6IjYwYTYzY2FhLWU5MGUtNDNhYy04MmQ2LWVmOTY3ZTc4ZTNiZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiMnluTlNHU29pUGFWTFljeml3RmxYSlhMaVgwIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiaWRtQWRtaW5DbGllbnQiLCJhdWQiOiJpZG1BZG1pbkNsaWVudCIsIm5iZiI6MTczMDk0NTYzMywiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIiwib3BlbmlkIl0sImF1dGhfdGltZSI6MTczMDk0NTU5MywicmVhbG0iOiIvIiwiZXhwIjoxNzMwOTQ5MjMzLCJpYXQiOjE3MzA5NDU2MzMsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6IkZjNVBheDItU0VLVEhIYUNnbGtSSFpyTU9OMCJ9.NMmHiT_fTygm_KzA6Efi7salplxUtB0x8T6aV_nY8K8qCeB5wqZj2RTnTMbSkoaLzFriNG9brJM8fnQU503SEtV5Txi8iY_CgYKBwQpHgY5gS23RYDdhOOYf4tTdk38KTFFcKQBKjugTEgerTFt2fZEsuJgQM7xKdh466k4G6jSmMwlNn1wzE47o60IIzayTuoxX4hybbPD1Kwv_VspYmwY1Ko0haXZefE-pkvQTC1H6MSS21A1zonn1meUbNkmNxedxP6OCLXaDcfrSBPI9v5TI9nKXFrKzjTTRQUKts55DipdJojKh94iZPHJD85TcCtjHVAHhR02KGJV6yJTh6Q, username -> user.791012, tokenIdCookieName -> 9b75a55744995d0, randomPolicyName -> testPolicy203398, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@61bb1a7f, authcode -> 9tnakZgFuSvaylYOxjpSUQnE3V8, useAdminRealm -> true, callbacks -> {"tokenId":"rJSgLw0Xxg9nL2eqtFEl_MWlzxc.*AAJTSQACMDIAAlNLABwxQStUeVhucWtTNmlnYUUvTENQWXpuL3I2WW89AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/platform","realm":"/"}, 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,1730945594020), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=rJSgLw0Xxg9nL2eqtFEl_MWlzxc.*AAJTSQACMDIAAlNLABwxQStUeVhucWtTNmlnYUUvTENQWXpuL3I2WW89AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1730945594020))), password -> Pa_ssw0rd, challenge -> SFNO1hB_e5mPs8OI2cHbdZHRUgs_wA5vh8O0FEfRO04, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 109.208.168.47, verifier -> NTQ0MTg3Mjk1NzExNTE4OTI0Nw, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@40dcb4bd, tokenId -> rJSgLw0Xxg9nL2eqtFEl_MWlzxc.*AAJTSQACMDIAAlNLABwxQStUeVhucWtTNmlnYUUvTENQWXpuL3I2WW89AAR0eXBlAANDVFMAAlMxAAIwMQ..*, 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$823/0x0000798d6869a0e0@1bcc8a2f,io.netty.channel.epoll.EpollEventLoop@5b057c8c) 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO HTTP request: 2024-11-07 02:17:30,295 INFO GET https://openam-perf-benchmark.forgeblocks.com/am/oauth2/alpha/.well-known/openid-configuration 2024-11-07 02:17:30,295 INFO headers: 2024-11-07 02:17:30,295 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-07 02:17:30,295 INFO accept: */* 2024-11-07 02:17:30,295 INFO cookie: amlbcookie=01; 9b75a55744995d0=rJSgLw0Xxg9nL2eqtFEl_MWlzxc.*AAJTSQACMDIAAlNLABwxQStUeVhucWtTNmlnYUUvTENQWXpuL3I2WW89AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-11-07 02:17:30,295 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,295 INFO cookies: 2024-11-07 02:17:30,295 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-07 02:17:30,295 INFO 9b75a55744995d0=rJSgLw0Xxg9nL2eqtFEl_MWlzxc.*AAJTSQACMDIAAlNLABwxQStUeVhucWtTNmlnYUUvTENQWXpuL3I2WW89AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO HTTP response: 2024-11-07 02:17:30,295 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-07 02:17:30,295 INFO 02:14:54.213 [ERROR] i.g.h.a.HttpRequestAction - Failed to build request CreatePolicy: No attribute named 'oauth2_uuId' is defined 2024-11-07 02:17:30,295 INFO 02:14:54.212 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-11-07 02:17:30,295 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-11-07 02:17:30,295 INFO Request: 2024-11-07 02:17:30,295 INFO restLoginInitiate: KO j.i.IOException: Premature close 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO Session: 2024-11-07 02:17:30,295 INFO Session(idc.benchmark.Mix2024,461713,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, username -> user.204119, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@50f3dcbe, fake-user-agent -> Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/44.0.2403.157 Safari/537.36, password -> Pa_ssw0rd, fake-ip -> 127.41.85.138, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@76607dda),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$823/0x0000798d6869a0e0@1bcc8a2f,io.netty.channel.epoll.EpollEventLoop@f79a760) 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO HTTP request: 2024-11-07 02:17:30,295 INFO POST https://openam-perf-benchmark.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate?authIndexType=service&authIndexValue=Login 2024-11-07 02:17:30,295 INFO headers: 2024-11-07 02:17:30,295 INFO accept: application/json 2024-11-07 02:17:30,295 INFO content-type: application/json 2024-11-07 02:17:30,295 INFO user-agent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/44.0.2403.157 Safari/537.36 2024-11-07 02:17:30,295 INFO X-Forwarded-For: 127.41.85.138 2024-11-07 02:17:30,295 INFO host: openam-perf-benchmark.forgeblocks.com 2024-11-07 02:17:30,295 INFO content-length: 0 2024-11-07 02:17:30,295 INFO body:StringChunksRequestBody{charset=UTF-8, content=} 2024-11-07 02:17:30,295 INFO ========================= 2024-11-07 02:17:30,295 INFO HTTP response: 2024-11-07 02:17:30,295 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-11-07 02:17:30,295 INFO [INFO] ------------------------------------------------------------------------ 2024-11-07 02:17:30,295 INFO [INFO] BUILD SUCCESS 2024-11-07 02:17:30,295 INFO [INFO] ------------------------------------------------------------------------ 2024-11-07 02:17:30,295 INFO [INFO] Total time: 01:00 h 2024-11-07 02:17:30,295 INFO [INFO] Finished at: 2024-11-07T02:14:54Z 2024-11-07 02:17:30,295 INFO [INFO] ------------------------------------------------------------------------ 2024-11-07 02:17:30,295 INFO 2024-11-07 02:14:54,717 INFO Gatling simulation run ended successfully 2024-11-07 02:17:30,295 INFO 2024-11-07 02:14:54,717 DEBUG No archive name provided. No archive will be created 2024-11-07 02:17:30,295 INFO ________________________________________________________________________________ [2024-11-07 02:17:30] benchmark-130 show_stderr : Display stderr order ________________________________________________________________________________ 2024-11-07 02:17:30,296 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/06_benchmark-130/stderr.txt is small (0 lines), printing all lines: 2024-11-07 02:17:30,296 DEBUG ----- output ----- 2024-11-07 02:17:30,296 DEBUG 2024-11-07 02:17:30,296 INFO ________________________________________________________________________________ [2024-11-07 02:17:30] benchmark-130 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-07 02:18:48] benchmark-130 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-11-07 02:18:48] benchmark-130 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped