--Task-- name: benchmark enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: idm 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: [] preceding_task: None options: {'testCase': 'idc.benchmark.CH2023', 'testMode': 'open', 'duration': 3600, 'throughput': 100, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock ________________________________________________________________________________ [2024-10-17 04:26:27] benchmark pre : N/A ________________________________________________________________________________ 2024-10-17 04:26:27 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2024-10-17 04:26:27 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/benchmark/stdout.txt Pod log : /results/orders/benchmark 2024-10-17 04:26:27,720 INFO 2024-10-17 04:26:27,720 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-10-17 04:26:27,720 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 04:26:27,989 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 04:26:27,989 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:27,989 DEBUG --- stdout --- 2024-10-17 04:26:27,989 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 04:26:27,989 DEBUG --- stderr --- 2024-10-17 04:26:27,989 DEBUG 2024-10-17 04:26:27 - INFO: Get overseer pod resources requests memory 2024-10-17 04:26:27,990 INFO 2024-10-17 04:26:27,990 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods overseer-0-68b86489-ztj5j --output jsonpath={.spec.containers[].resources.requests.memory} 2024-10-17 04:26:27,990 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 04:26:28,280 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:28,280 DEBUG --- stdout --- 2024-10-17 04:26:28,280 DEBUG 4Gi 2024-10-17 04:26:28,281 DEBUG --- stderr --- 2024-10-17 04:26:28,281 DEBUG ________________________________________________________________________________ [2024-10-17 04:26:28] benchmark print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-10-17 04:26:28,281 INFO 2024-10-17 04:26:28,281 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-10-17 04:26:28,281 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 04:26:28,548 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 04:26:28,548 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:28,548 DEBUG --- stdout --- 2024-10-17 04:26:28,548 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 04:26:28,548 DEBUG --- stderr --- 2024-10-17 04:26:28,548 DEBUG /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling/ --run-description "idc.benchmark.CH2023@perf-benchmark" --results-folder /results/gatling/benchmark --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-10-17 04:26:28] benchmark create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-10-17 04:26:28,549 INFO 2024-10-17 04:26:28,549 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-10-17 04:26:28,549 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 04:26:28,816 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 04:26:28,816 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:28,816 DEBUG --- stdout --- 2024-10-17 04:26:28,816 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 04:26:28,816 DEBUG --- stderr --- 2024-10-17 04:26:28,816 DEBUG Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/order.json { "name": "benchmark", "command": " /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling/ --run-description \"idc.benchmark.CH2023@perf-benchmark\" --results-folder /results/gatling/benchmark --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/benchmark", "environment": { "JAVA_OPTS": "-Dam_host=openam-perf-benchmark.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-perf-benchmark.forgeblocks.com -Dlogin_cookie=9b75a55744995d0 -Dnum_users=1000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.CH2023 -DtestMode=open -Dthroughput=100 -Duser_password=Pa_ssw0rd" } } ________________________________________________________________________________ [2024-10-17 04:26:28] benchmark 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-10-17 04:26:28,818 INFO 2024-10-17 04:26:28,818 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-10-17 04:26:28,818 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-10-17 04:26:29,083 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-10-17 04:26:29,083 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:29,083 DEBUG --- stdout --- 2024-10-17 04:26:29,083 DEBUG WAITING 2024-10-17 04:26:29,083 DEBUG --- stderr --- 2024-10-17 04:26:29,083 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 27 0 --:--:-- --:--:-- --:--:-- 27 ________________________________________________________________________________ [2024-10-17 04:26:29] benchmark start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-10-17 04:26:29,083 INFO 2024-10-17 04:26:29,083 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-10-17 04:26:29,083 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 04:26:29,355 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 04:26:29,355 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:29,355 DEBUG --- stdout --- 2024-10-17 04:26:29,356 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 04:26:29,356 DEBUG --- stderr --- 2024-10-17 04:26:29,356 DEBUG 2024-10-17 04:26:29,356 INFO 2024-10-17 04:26:29,356 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_ch2023/07_Scenario_benchmark/01_benchmark/order.json overseer-0-68b86489-ztj5j:/results/orders/order.json 2024-10-17 04:26:29,356 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 04:26:30,726 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:30,726 DEBUG --- stdout --- 2024-10-17 04:26:30,726 DEBUG 2024-10-17 04:26:30,726 DEBUG --- stderr --- 2024-10-17 04:26:30,726 DEBUG Order has been successfully forwarded to overseer 2024-10-17 04:26:30 - INFO: Check if Gatling simulation started successfully 2024-10-17 04:26:30,727 INFO 2024-10-17 04:26:30,727 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-10-17 04:26:30,727 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 04:26:30,995 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 04:26:30,995 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:30,995 DEBUG --- stdout --- 2024-10-17 04:26:30,995 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 04:26:30,995 DEBUG --- stderr --- 2024-10-17 04:26:30,995 DEBUG 2024-10-17 04:26:30,996 INFO 2024-10-17 04:26:30,996 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j -- head -n 25 /results/orders/benchmark/stdout.txt | grep "started..." 2024-10-17 04:26:30,996 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-10-17 04:26:31,704 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-10-17 04:26:37,421 INFO [loop_until]: Function succeeded after 6s (rc=0) - expected pattern found 2024-10-17 04:26:37,421 INFO [loop_until]: OK (rc = 0) 2024-10-17 04:26:37,421 DEBUG --- stdout --- 2024-10-17 04:26:37,421 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Gatling 3.12.0 is available! (you're using 3.9.5) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Simulation com.forgerock.gatling.Loadtest started... 2024-10-17 04:26:37,421 DEBUG --- stderr --- 2024-10-17 04:26:37,421 DEBUG ________________________________________________________________________________ [2024-10-17 04:26:37] benchmark 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 5s, retry Order is running since 10s, retry Order is running since 15s, retry Order is running since 20s, retry Order is running since 26s, retry Order is running since 31s, retry Order is running since 36s, retry Order is running since 41s, retry Order is running since 46s, retry Order is running since 52s, retry Order is running since 57s, retry Order is running since 1m 02s, retry Order is running since 1m 07s, retry Order is running since 1m 13s, retry Order is running since 1m 18s, retry Order is running since 1m 23s, retry Order is running since 1m 28s, retry Order is running since 1m 33s, retry Order is running since 1m 39s, retry Order is running since 1m 44s, retry Order is running since 1m 49s, retry Order is running since 1m 54s, retry Order is running since 2m, retry Order is running since 2m 05s, retry Order is running since 2m 10s, retry Order is running since 2m 15s, retry Order is running since 2m 20s, retry Order is running since 2m 26s, retry Order is running since 2m 31s, retry Order is running since 2m 36s, retry Order is running since 2m 41s, retry Order is running since 2m 47s, retry Order is running since 2m 52s, retry Order is running since 2m 57s, retry Order is running since 3m 02s, retry Order is running since 3m 07s, retry Order is running since 3m 13s, retry Order is running since 3m 18s, retry Order is running since 3m 23s, retry Order is running since 3m 28s, retry Order is running since 3m 34s, retry Order is running since 3m 39s, retry Order is running since 3m 44s, retry Order is running since 3m 49s, retry Order is running since 3m 54s, retry Order is running since 4m, retry Order is running since 4m 05s, retry Order is running since 4m 10s, retry Order is running since 4m 15s, retry Order is running since 4m 21s, retry Order is running since 4m 26s, retry Order is running since 4m 31s, retry Order is running since 4m 36s, retry Order is running since 4m 41s, retry Order is running since 4m 47s, retry Order is running since 4m 52s, retry Order is running since 4m 57s, retry Order is running since 5m 02s, retry Order is running since 5m 07s, retry Order is running since 5m 13s, retry Order is running since 5m 18s, retry Order is running since 5m 23s, retry Order is running since 5m 28s, retry Order is running since 5m 34s, retry Order is running since 5m 39s, retry Order is running since 5m 44s, retry Order is running since 5m 49s, retry Order is running since 5m 54s, retry Order is running since 6m, retry Order is running since 6m 05s, retry Order is running since 6m 10s, retry Order is running since 6m 15s, retry Order is running since 6m 20s, retry Order is running since 6m 26s, retry Order is running since 6m 31s, retry Order is running since 6m 36s, retry Order is running since 6m 41s, retry Order is running since 6m 47s, retry Order is running since 6m 52s, retry Order is running since 6m 57s, retry Order is running since 7m 02s, retry Order is running since 7m 07s, retry Order is running since 7m 13s, retry Order is running since 7m 18s, retry Order is running since 7m 23s, retry Order is running since 7m 28s, retry Order is running since 7m 33s, retry Order is running since 7m 39s, retry Order is running since 7m 44s, retry Order is running since 7m 49s, retry Order is running since 7m 54s, retry Order is running since 8m, retry Order is running since 8m 05s, retry Order is running since 8m 10s, retry Order is running since 8m 15s, retry Order is running since 8m 21s, retry Order is running since 8m 26s, retry Order is running since 8m 31s, retry Order is running since 8m 36s, retry Order is running since 8m 41s, retry Order is running since 8m 47s, retry Order is running since 8m 52s, retry Order is running since 8m 57s, retry Order is running since 9m 02s, retry Order is running since 9m 07s, retry Order is running since 9m 13s, retry Order is running since 9m 18s, retry Order is running since 9m 23s, retry Order is running since 9m 28s, retry Order is running since 9m 34s, retry Order is running since 9m 39s, retry Order is running since 9m 44s, retry Order is running since 9m 49s, retry Order is running since 9m 54s, retry Order is running since 10m, retry Order is running since 10m 05s, retry Order is running since 10m 10s, retry Order is running since 10m 15s, retry Order is running since 10m 20s, retry Order is running since 10m 26s, retry Order is running since 10m 31s, retry Order is running since 10m 36s, retry Order is running since 10m 41s, retry Order is running since 10m 47s, retry Order is running since 10m 52s, retry Order is running since 10m 57s, retry Order is running since 11m 02s, retry Order is running since 11m 07s, retry Order is running since 11m 13s, retry Order is running since 11m 18s, retry Order is running since 11m 23s, retry Order is running since 11m 28s, retry Order is running since 11m 34s, retry Order is running since 11m 39s, retry Order is running since 11m 44s, retry Order is running since 11m 49s, retry Order is running since 11m 54s, retry Order is running since 12m, retry Order is running since 12m 05s, retry Order is running since 12m 10s, retry Order is running since 12m 15s, retry Order is running since 12m 20s, retry Order is running since 12m 26s, retry Order is running since 12m 31s, retry Order is running since 12m 36s, retry Order is running since 12m 41s, retry Order is running since 12m 47s, retry Order is running since 12m 52s, retry Order is running since 12m 57s, retry Order is running since 13m 02s, retry Order is running since 13m 07s, retry Order is running since 13m 13s, retry Order is running since 13m 18s, retry Order is running since 13m 23s, retry Order is running since 13m 28s, retry Order is running since 13m 33s, retry Order is running since 13m 39s, retry Order is running since 13m 44s, retry Order is running since 13m 49s, retry Order is running since 13m 54s, retry Order is running since 14m, retry Order is running since 14m 05s, retry Order is running since 14m 10s, retry Order is running since 14m 15s, retry Order is running since 14m 20s, retry Order is running since 14m 26s, retry Order is running since 14m 31s, retry Order is running since 14m 36s, retry Order is running since 14m 41s, retry Order is running since 14m 46s, retry Order is running since 14m 52s, retry Order is running since 14m 57s, retry Order is running since 15m 02s, retry Order is running since 15m 07s, retry Order is running since 15m 13s, retry Order is running since 15m 18s, retry Order is running since 15m 23s, retry Order is running since 15m 28s, retry Order is running since 15m 33s, retry Order is running since 15m 39s, retry Order is running since 15m 44s, retry Order is running since 15m 49s, retry Order is running since 15m 54s, retry Order is running since 15m 59s, retry Order is running since 16m 05s, retry Order is running since 16m 10s, retry Order is running since 16m 15s, retry Order is running since 16m 20s, retry Order is running since 16m 26s, retry Order is running since 16m 31s, retry Order is running since 16m 36s, retry Order is running since 16m 41s, retry Order is running since 16m 46s, retry Order is running since 16m 52s, retry Order is running since 16m 57s, retry Order is running since 17m 02s, retry Order is running since 17m 07s, retry Order is running since 17m 12s, retry Order is running since 17m 18s, retry Order is running since 17m 23s, retry Order is running since 17m 28s, retry Order is running since 17m 33s, retry Order is running since 17m 39s, retry Order is running since 17m 44s, retry Order is running since 17m 49s, retry Order is running since 17m 54s, retry Order is running since 17m 59s, retry Order is running since 18m 05s, retry Order is running since 18m 10s, retry Order is running since 18m 15s, retry Order is running since 18m 20s, retry Order is running since 18m 25s, retry Order is running since 18m 31s, retry Order is running since 18m 36s, retry Order is running since 18m 41s, retry Order is running since 18m 46s, retry Order is running since 18m 52s, retry Order is running since 18m 57s, retry Order is running since 19m 02s, retry Order is running since 19m 07s, retry Order is running since 19m 12s, retry Order is running since 19m 18s, retry Order is running since 19m 23s, retry Order is running since 19m 28s, retry Order is running since 19m 33s, retry Order is running since 19m 38s, retry Order is running since 19m 44s, retry Order is running since 19m 49s, retry Order is running since 19m 54s, retry Order is running since 19m 59s, retry Order is running since 20m 05s, retry Order is running since 20m 10s, retry Order is running since 20m 15s, retry Order is running since 20m 20s, retry Order is running since 20m 25s, retry Order is running since 20m 31s, retry Order is running since 20m 36s, retry Order is running since 20m 41s, retry Order is running since 20m 46s, retry Order is running since 20m 51s, retry Order is running since 20m 57s, retry Order is running since 21m 02s, retry Order is running since 21m 07s, retry Order is running since 21m 12s, retry Order is running since 21m 18s, retry Order is running since 21m 23s, retry Order is running since 21m 28s, retry Order is running since 21m 33s, retry Order is running since 21m 38s, retry Order is running since 21m 44s, retry Order is running since 21m 49s, retry Order is running since 21m 54s, retry Order is running since 21m 59s, retry Order is running since 22m 05s, retry Order is running since 22m 10s, retry Order is running since 22m 15s, retry Order is running since 22m 20s, retry Order is running since 22m 25s, retry Order is running since 22m 31s, retry Order is running since 22m 36s, retry Order is running since 22m 41s, retry Order is running since 22m 46s, retry Order is running since 22m 51s, retry Order is running since 22m 57s, retry Order is running since 23m 02s, retry Order is running since 23m 07s, retry Order is running since 23m 12s, retry Order is running since 23m 18s, retry Order is running since 23m 23s, retry Order is running since 23m 28s, retry Order is running since 23m 33s, retry Order is running since 23m 38s, retry Order is running since 23m 44s, retry Order is running since 23m 49s, retry Order is running since 23m 54s, retry Order is running since 23m 59s, retry Order is running since 24m 05s, retry Order is running since 24m 10s, retry Order is running since 24m 15s, retry Order is running since 24m 20s, retry Order is running since 24m 25s, retry Order is running since 24m 31s, retry Order is running since 24m 36s, retry Order is running since 24m 41s, retry Order is running since 24m 46s, retry Order is running since 24m 51s, retry Order is running since 24m 57s, retry Order is running since 25m 02s, retry Order is running since 25m 07s, retry Order is running since 25m 12s, retry Order is running since 25m 18s, retry Order is running since 25m 23s, retry Order is running since 25m 28s, retry Order is running since 25m 33s, retry Order is running since 25m 38s, retry Order is running since 25m 44s, retry Order is running since 25m 49s, retry Order is running since 25m 54s, retry Order is running since 25m 59s, retry Order is running since 26m 05s, retry Order is running since 26m 10s, retry Order is running since 26m 15s, retry Order is running since 26m 20s, retry Order is running since 26m 25s, retry Order is running since 26m 31s, retry Order is running since 26m 36s, retry Order is running since 26m 41s, retry Order is running since 26m 46s, retry Order is running since 26m 51s, retry Order is running since 26m 57s, retry Order is running since 27m 02s, retry Order is running since 27m 07s, retry Order is running since 27m 12s, retry Order is running since 27m 18s, retry Order is running since 27m 23s, retry Order is running since 27m 28s, retry Order is running since 27m 33s, retry Order is running since 27m 38s, retry Order is running since 27m 44s, retry Order is running since 27m 49s, retry Order is running since 27m 54s, retry Order is running since 27m 59s, retry Order is running since 28m 05s, retry Order is running since 28m 10s, retry Order is running since 28m 15s, retry Order is running since 28m 20s, retry Order is running since 28m 25s, retry Order is running since 28m 31s, retry Order is running since 28m 36s, retry Order is running since 28m 41s, retry Order is running since 28m 46s, retry Order is running since 28m 52s, retry Order is running since 28m 57s, retry Order is running since 29m 02s, retry Order is running since 29m 07s, retry Order is running since 29m 12s, retry Order is running since 29m 18s, retry Order is running since 29m 23s, retry Order is running since 29m 28s, retry Order is running since 29m 33s, retry Order is running since 29m 38s, retry Order is running since 29m 44s, retry Order is running since 29m 49s, retry Order is running since 29m 54s, retry Order is running since 29m 59s, retry Order is running since 30m 04s, retry Order is running since 30m 10s, retry Order is running since 30m 15s, retry Order is running since 30m 20s, retry Order is running since 30m 25s, retry Order is running since 30m 31s, retry Order is running since 30m 36s, retry Order is running since 30m 41s, retry Order is running since 30m 46s, retry Order is running since 30m 51s, retry Order is running since 30m 57s, retry Order is running since 31m 02s, retry Order is running since 31m 07s, retry Order is running since 31m 12s, retry Order is running since 31m 17s, retry Order is running since 31m 23s, retry Order is running since 31m 28s, retry Order is running since 31m 33s, retry Order is running since 31m 38s, retry Order is running since 31m 44s, retry Order is running since 31m 49s, retry Order is running since 31m 54s, retry Order is running since 31m 59s, retry Order is running since 32m 04s, retry Order is running since 32m 10s, retry Order is running since 32m 15s, retry Order is running since 32m 20s, retry Order is running since 32m 25s, retry Order is running since 32m 31s, retry Order is running since 32m 36s, retry Order is running since 32m 41s, retry Order is running since 32m 46s, retry Order is running since 32m 51s, retry Order is running since 32m 57s, retry Order is running since 33m 02s, retry Order is running since 33m 07s, retry Order is running since 33m 12s, retry Order is running since 33m 17s, retry Order is running since 33m 23s, retry Order is running since 33m 28s, retry Order is running since 33m 33s, retry Order is running since 33m 38s, retry Order is running since 33m 44s, retry Order is running since 33m 49s, retry Order is running since 33m 54s, retry Order is running since 33m 59s, retry Order is running since 34m 04s, retry Order is running since 34m 10s, retry Order is running since 34m 15s, retry Order is running since 34m 20s, retry Order is running since 34m 25s, retry Order is running since 34m 30s, retry Order is running since 34m 36s, retry Order is running since 34m 41s, retry Order is running since 34m 46s, retry Order is running since 34m 51s, retry Order is running since 34m 57s, retry Order is running since 35m 02s, retry Order is running since 35m 07s, retry Order is running since 35m 12s, retry Order is running since 35m 17s, retry Order is running since 35m 23s, retry Order is running since 35m 28s, retry Order is running since 35m 33s, retry Order is running since 35m 38s, retry Order is running since 35m 43s, retry Order is running since 35m 49s, retry Order is running since 35m 54s, retry Order is running since 35m 59s, retry Order is running since 36m 04s, retry Order is running since 36m 10s, retry Order is running since 36m 15s, retry Order is running since 36m 20s, retry Order is running since 36m 25s, retry Order is running since 36m 30s, retry Order is running since 36m 36s, retry Order is running since 36m 41s, retry Order is running since 36m 46s, retry Order is running since 36m 51s, retry Order is running since 36m 57s, retry Order is running since 37m 02s, retry Order is running since 37m 07s, retry Order is running since 37m 12s, retry Order is running since 37m 17s, retry Order is running since 37m 23s, retry Order is running since 37m 28s, retry Order is running since 37m 33s, retry Order is running since 37m 38s, retry Order is running since 37m 43s, retry Order is running since 37m 49s, retry Order is running since 37m 54s, retry Order is running since 37m 59s, retry Order is running since 38m 04s, retry Order is running since 38m 10s, retry Order is running since 38m 15s, retry Order is running since 38m 20s, retry Order is running since 38m 25s, retry Order is running since 38m 30s, retry Order is running since 38m 36s, retry Order is running since 38m 41s, retry Order is running since 38m 46s, retry Order is running since 38m 51s, retry Order is running since 38m 56s, retry Order is running since 39m 02s, retry Order is running since 39m 07s, retry Order is running since 39m 12s, retry Order is running since 39m 17s, retry Order is running since 39m 23s, retry Order is running since 39m 28s, retry Order is running since 39m 33s, retry Order is running since 39m 38s, retry Order is running since 39m 43s, retry Order is running since 39m 49s, retry Order is running since 39m 54s, retry Order is running since 39m 59s, retry Order is running since 40m 04s, retry Order is running since 40m 09s, retry Order is running since 40m 15s, retry Order is running since 40m 20s, retry Order is running since 40m 25s, retry Order is running since 40m 30s, retry Order is running since 40m 36s, retry Order is running since 40m 41s, retry Order is running since 40m 46s, retry Order is running since 40m 51s, retry Order is running since 40m 56s, retry Order is running since 41m 02s, retry Order is running since 41m 07s, retry Order is running since 41m 12s, retry Order is running since 41m 17s, retry Order is running since 41m 22s, retry Order is running since 41m 28s, retry Order is running since 41m 33s, retry Order is running since 41m 38s, retry Order is running since 41m 43s, retry Order is running since 41m 49s, retry Order is running since 41m 54s, retry Order is running since 41m 59s, retry Order is running since 42m 04s, retry Order is running since 42m 09s, retry Order is running since 42m 15s, retry Order is running since 42m 20s, retry Order is running since 42m 25s, retry Order is running since 42m 30s, retry Order is running since 42m 35s, retry Order is running since 42m 41s, retry Order is running since 42m 46s, retry Order is running since 42m 51s, retry Order is running since 42m 56s, retry Order is running since 43m 01s, retry Order is running since 43m 07s, retry Order is running since 43m 12s, retry Order is running since 43m 17s, retry Order is running since 43m 22s, retry Order is running since 43m 28s, retry Order is running since 43m 33s, retry Order is running since 43m 38s, retry Order is running since 43m 43s, retry Order is running since 43m 48s, retry Order is running since 43m 54s, retry Order is running since 43m 59s, retry Order is running since 44m 04s, retry Order is running since 44m 09s, retry Order is running since 44m 15s, retry Order is running since 44m 20s, retry Order is running since 44m 25s, retry Order is running since 44m 30s, retry Order is running since 44m 35s, retry Order is running since 44m 41s, retry Order is running since 44m 46s, retry Order is running since 44m 51s, retry Order is running since 44m 56s, retry Order is running since 45m 02s, retry Order is running since 45m 07s, retry Order is running since 45m 12s, retry Order is running since 45m 17s, retry Order is running since 45m 22s, retry Order is running since 45m 28s, retry Order is running since 45m 33s, retry Order is running since 45m 38s, retry Order is running since 45m 43s, retry Order is running since 45m 48s, retry Order is running since 45m 54s, retry Order is running since 45m 59s, retry Order is running since 46m 04s, retry Order is running since 46m 09s, retry Order is running since 46m 15s, retry Order is running since 46m 20s, retry Order is running since 46m 25s, retry Order is running since 46m 30s, retry Order is running since 46m 35s, retry Order is running since 46m 41s, retry Order is running since 46m 46s, retry Order is running since 46m 51s, retry Order is running since 46m 56s, retry Order is running since 47m 01s, retry Order is running since 47m 07s, retry Order is running since 47m 12s, retry Order is running since 47m 17s, retry Order is running since 47m 22s, retry Order is running since 47m 28s, retry Order is running since 47m 33s, retry Order is running since 47m 38s, retry Order is running since 47m 43s, retry Order is running since 47m 48s, retry Order is running since 47m 54s, retry Order is running since 47m 59s, retry Order is running since 48m 04s, retry Order is running since 48m 09s, retry Order is running since 48m 15s, retry Order is running since 48m 20s, retry Order is running since 48m 25s, retry Order is running since 48m 30s, retry Order is running since 48m 35s, retry Order is running since 48m 41s, retry Order is running since 48m 46s, retry Order is running since 48m 51s, retry Order is running since 48m 56s, retry Order is running since 49m 01s, retry Order is running since 49m 07s, retry Order is running since 49m 12s, retry Order is running since 49m 17s, retry Order is running since 49m 22s, retry Order is running since 49m 28s, retry Order is running since 49m 33s, retry Order is running since 49m 38s, retry Order is running since 49m 43s, retry Order is running since 49m 48s, retry Order is running since 49m 54s, retry Order is running since 49m 59s, retry Order is running since 50m 04s, retry Order is running since 50m 09s, retry Order is running since 50m 15s, retry Order is running since 50m 20s, retry Order is running since 50m 25s, retry Order is running since 50m 30s, retry Order is running since 50m 35s, retry Order is running since 50m 41s, retry Order is running since 50m 46s, retry Order is running since 50m 51s, retry Order is running since 50m 56s, retry Order is running since 51m 01s, retry Order is running since 51m 07s, retry Order is running since 51m 12s, retry Order is running since 51m 17s, retry Order is running since 51m 22s, retry Order is running since 51m 28s, retry Order is running since 51m 33s, retry Order is running since 51m 38s, retry Order is running since 51m 43s, retry Order is running since 51m 48s, retry Order is running since 51m 54s, retry Order is running since 51m 59s, retry Order is running since 52m 04s, retry Order is running since 52m 09s, retry Order is running since 52m 14s, retry Order is running since 52m 20s, retry Order is running since 52m 25s, retry Order is running since 52m 30s, retry Order is running since 52m 35s, retry Order is running since 52m 41s, retry Order is running since 52m 46s, retry Order is running since 52m 51s, retry Order is running since 52m 56s, retry Order is running since 53m 01s, retry Order is running since 53m 07s, retry Order is running since 53m 12s, retry Order is running since 53m 17s, retry Order is running since 53m 22s, retry Order is running since 53m 27s, retry Order is running since 53m 33s, retry Order is running since 53m 38s, retry Order is running since 53m 43s, retry Order is running since 53m 48s, retry Order is running since 53m 54s, retry Order is running since 53m 59s, retry Order is running since 54m 04s, retry Order is running since 54m 09s, retry Order is running since 54m 14s, retry Order is running since 54m 20s, retry Order is running since 54m 25s, retry Order is running since 54m 30s, retry Order is running since 54m 35s, retry Order is running since 54m 40s, retry Order is running since 54m 46s, retry Order is running since 54m 51s, retry Order is running since 54m 56s, retry Order is running since 55m 01s, retry Order is running since 55m 07s, retry Order is running since 55m 12s, retry Order is running since 55m 17s, retry Order is running since 55m 22s, retry Order is running since 55m 27s, retry Order is running since 55m 33s, retry Order is running since 55m 38s, retry Order is running since 55m 43s, retry Order is running since 55m 48s, retry Order is running since 55m 53s, retry Order is running since 55m 59s, retry Order is running since 56m 04s, retry Order is running since 56m 09s, retry Order is running since 56m 14s, retry Order is running since 56m 20s, retry Order is running since 56m 25s, retry Order is running since 56m 30s, retry Order is running since 56m 35s, retry Order is running since 56m 40s, retry Order is running since 56m 46s, retry Order is running since 56m 51s, retry Order is running since 56m 56s, retry Order is running since 57m 01s, retry Order is running since 57m 06s, retry Order is running since 57m 12s, retry Order is running since 57m 17s, retry Order is running since 57m 22s, retry Order is running since 57m 27s, retry Order is running since 57m 33s, retry Order is running since 57m 38s, retry Order is running since 57m 43s, retry Order is running since 57m 48s, retry Order is running since 57m 53s, retry Order is running since 57m 59s, retry Order is running since 58m 04s, retry Order is running since 58m 09s, retry Order is running since 58m 14s, retry Order is running since 58m 20s, retry Order is running since 58m 25s, retry Order is running since 58m 30s, retry Order is running since 58m 35s, retry Order is running since 58m 40s, retry Order is running since 58m 46s, retry Order is running since 58m 51s, retry Order is running since 58m 56s, retry Order is running since 59m 01s, retry Order is running since 59m 06s, retry Order is running since 59m 12s, retry Order is running since 59m 17s, retry Order is running since 59m 22s, retry Order is running since 59m 27s, retry Order is running since 59m 32s, retry Order is running since 59m 38s, retry Order is running since 59m 43s, retry Order is running since 59m 48s, retry Order is running since 59m 53s, retry PASS : Order stopped by itself after 59m 59s and before timeout (1h 12m) ________________________________________________________________________________ [2024-10-17 05:26:36] benchmark stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-10-17 05:26:36,468 INFO 2024-10-17 05:26:36,468 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-10-17 05:26:36,468 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:36,757 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:36,757 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:36,757 DEBUG --- stdout --- 2024-10-17 05:26:36,757 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:36,757 DEBUG --- stderr --- 2024-10-17 05:26:36,757 DEBUG 2024-10-17 05:26:36,757 INFO 2024-10-17 05:26:36,757 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j -- rm -f /results/orders/order.json 2024-10-17 05:26:36,757 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 05:26:37,509 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:37,509 DEBUG --- stdout --- 2024-10-17 05:26:37,509 DEBUG 2024-10-17 05:26:37,509 DEBUG --- stderr --- 2024-10-17 05:26:37,509 DEBUG Order ran during 1h ________________________________________________________________________________ [2024-10-17 05:26:37] benchmark download_logs : Download individual order files ________________________________________________________________________________ 2024-10-17 05:26:37 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/order.json 2024-10-17 05:26:37,510 INFO 2024-10-17 05:26:37,510 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-10-17 05:26:37,510 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:37,781 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:37,781 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:37,781 DEBUG --- stdout --- 2024-10-17 05:26:37,781 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:37,781 DEBUG --- stderr --- 2024-10-17 05:26:37,781 DEBUG Checking pod: overseer-0-68b86489-ztj5j for file exists, if not wait. 2024-10-17 05:26:37,782 INFO 2024-10-17 05:26:37,782 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-10-17 05:26:37,782 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:38,050 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:38,050 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:38,050 DEBUG --- stdout --- 2024-10-17 05:26:38,050 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:38,050 DEBUG --- stderr --- 2024-10-17 05:26:38,050 DEBUG 2024-10-17 05:26:38,051 INFO 2024-10-17 05:26:38,051 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- bash -c 'if [ -f "/results/orders/benchmark/rc.txt" ]; then echo "/results/orders/benchmark/rc.txt file found"; exit 0; else echo "/results/orders/benchmark/rc.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark/rc.txt file found" 2024-10-17 05:26:38,051 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 05:26:38,823 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-10-17 05:26:38,823 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:38,823 DEBUG --- stdout --- 2024-10-17 05:26:38,823 DEBUG /results/orders/benchmark/rc.txt file found 2024-10-17 05:26:38,823 DEBUG --- stderr --- 2024-10-17 05:26:38,823 DEBUG 2024-10-17 05:26:38,824 INFO 2024-10-17 05:26:38,824 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-10-17 05:26:38,824 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:39,093 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:39,093 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:39,093 DEBUG --- stdout --- 2024-10-17 05:26:39,093 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:39,093 DEBUG --- stderr --- 2024-10-17 05:26:39,093 DEBUG 2024-10-17 05:26:39,093 INFO 2024-10-17 05:26:39,093 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- du -k /results/orders/benchmark/rc.txt 2024-10-17 05:26:39,866 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-10-17 05:26:39,866 DEBUG --- stdout --- 2024-10-17 05:26:39,866 DEBUG 4 /results/orders/benchmark/rc.txt 2024-10-17 05:26:39,866 DEBUG --- stderr --- 2024-10-17 05:26:39,866 DEBUG 2024-10-17 05:26:39,866 INFO - Download file (size 4k) 2024-10-17 05:26:39,867 INFO 2024-10-17 05:26:39,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-10-17 05:26:39,867 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:40,136 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:40,136 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:40,136 DEBUG --- stdout --- 2024-10-17 05:26:40,136 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:40,136 DEBUG --- stderr --- 2024-10-17 05:26:40,136 DEBUG source : /results/orders/benchmark/rc.txt @ overseer-0-68b86489-ztj5j destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/rc.txt 2024-10-17 05:26:40,137 INFO 2024-10-17 05:26:40,137 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-10-17 05:26:40,137 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:40,407 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:40,407 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:40,407 DEBUG --- stdout --- 2024-10-17 05:26:40,407 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:40,407 DEBUG --- stderr --- 2024-10-17 05:26:40,407 DEBUG 2024-10-17 05:26:40,407 INFO 2024-10-17 05:26:40,407 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68b86489-ztj5j:/results/orders/benchmark/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/rc.txt 2024-10-17 05:26:40,407 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-10-17 05:26:41,144 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:41,144 DEBUG --- stdout --- 2024-10-17 05:26:41,144 DEBUG tar: Removing leading `/' from member names 2024-10-17 05:26:41,144 DEBUG --- stderr --- 2024-10-17 05:26:41,144 DEBUG 2024-10-17 05:26:41,144 INFO 2024-10-17 05:26:41,145 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-10-17 05:26:41,145 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:41,412 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:41,412 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:41,412 DEBUG --- stdout --- 2024-10-17 05:26:41,412 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:41,412 DEBUG --- stderr --- 2024-10-17 05:26:41,412 DEBUG Checking pod: overseer-0-68b86489-ztj5j for file exists, if not wait. 2024-10-17 05:26:41,412 INFO 2024-10-17 05:26:41,412 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-10-17 05:26:41,412 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:41,681 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:41,681 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:41,681 DEBUG --- stdout --- 2024-10-17 05:26:41,681 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:41,681 DEBUG --- stderr --- 2024-10-17 05:26:41,681 DEBUG 2024-10-17 05:26:41,682 INFO 2024-10-17 05:26:41,682 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- bash -c 'if [ -f "/results/orders/benchmark/stderr.txt" ]; then echo "/results/orders/benchmark/stderr.txt file found"; exit 0; else echo "/results/orders/benchmark/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark/stderr.txt file found" 2024-10-17 05:26:41,682 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 05:26:42,451 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-10-17 05:26:42,451 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:42,451 DEBUG --- stdout --- 2024-10-17 05:26:42,451 DEBUG /results/orders/benchmark/stderr.txt file found 2024-10-17 05:26:42,451 DEBUG --- stderr --- 2024-10-17 05:26:42,451 DEBUG 2024-10-17 05:26:42,452 INFO 2024-10-17 05:26:42,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-10-17 05:26:42,452 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:42,718 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:42,719 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:42,719 DEBUG --- stdout --- 2024-10-17 05:26:42,719 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:42,719 DEBUG --- stderr --- 2024-10-17 05:26:42,719 DEBUG 2024-10-17 05:26:42,719 INFO 2024-10-17 05:26:42,719 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- du -k /results/orders/benchmark/stderr.txt 2024-10-17 05:26:43,538 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-10-17 05:26:43,538 DEBUG --- stdout --- 2024-10-17 05:26:43,538 DEBUG 0 /results/orders/benchmark/stderr.txt 2024-10-17 05:26:43,538 DEBUG --- stderr --- 2024-10-17 05:26:43,538 DEBUG 2024-10-17 05:26:43,538 INFO - Download file (size 0k) 2024-10-17 05:26:43,539 INFO 2024-10-17 05:26:43,539 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-10-17 05:26:43,539 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:43,806 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:43,806 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:43,806 DEBUG --- stdout --- 2024-10-17 05:26:43,806 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:43,806 DEBUG --- stderr --- 2024-10-17 05:26:43,806 DEBUG source : /results/orders/benchmark/stderr.txt @ overseer-0-68b86489-ztj5j destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/stderr.txt 2024-10-17 05:26:43,806 INFO 2024-10-17 05:26:43,806 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-10-17 05:26:43,806 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:44,073 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:44,073 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:44,073 DEBUG --- stdout --- 2024-10-17 05:26:44,073 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:44,073 DEBUG --- stderr --- 2024-10-17 05:26:44,073 DEBUG 2024-10-17 05:26:44,074 INFO 2024-10-17 05:26:44,074 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68b86489-ztj5j:/results/orders/benchmark/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/stderr.txt 2024-10-17 05:26:44,074 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-10-17 05:26:44,813 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:44,813 DEBUG --- stdout --- 2024-10-17 05:26:44,813 DEBUG tar: Removing leading `/' from member names 2024-10-17 05:26:44,813 DEBUG --- stderr --- 2024-10-17 05:26:44,813 DEBUG 2024-10-17 05:26:44,813 INFO 2024-10-17 05:26:44,813 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-10-17 05:26:44,813 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:45,080 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:45,081 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:45,081 DEBUG --- stdout --- 2024-10-17 05:26:45,081 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:45,081 DEBUG --- stderr --- 2024-10-17 05:26:45,081 DEBUG Checking pod: overseer-0-68b86489-ztj5j for file exists, if not wait. 2024-10-17 05:26:45,081 INFO 2024-10-17 05:26:45,081 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-10-17 05:26:45,081 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:45,353 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:45,353 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:45,353 DEBUG --- stdout --- 2024-10-17 05:26:45,353 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:45,353 DEBUG --- stderr --- 2024-10-17 05:26:45,353 DEBUG 2024-10-17 05:26:45,353 INFO 2024-10-17 05:26:45,353 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- bash -c 'if [ -f "/results/orders/benchmark/stdout.txt" ]; then echo "/results/orders/benchmark/stdout.txt file found"; exit 0; else echo "/results/orders/benchmark/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark/stdout.txt file found" 2024-10-17 05:26:45,354 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 05:26:46,127 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-10-17 05:26:46,127 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:46,127 DEBUG --- stdout --- 2024-10-17 05:26:46,127 DEBUG /results/orders/benchmark/stdout.txt file found 2024-10-17 05:26:46,127 DEBUG --- stderr --- 2024-10-17 05:26:46,127 DEBUG 2024-10-17 05:26:46,128 INFO 2024-10-17 05:26:46,128 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-10-17 05:26:46,128 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:46,405 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:46,406 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:46,406 DEBUG --- stdout --- 2024-10-17 05:26:46,406 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:46,406 DEBUG --- stderr --- 2024-10-17 05:26:46,406 DEBUG 2024-10-17 05:26:46,406 INFO 2024-10-17 05:26:46,406 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- du -k /results/orders/benchmark/stdout.txt 2024-10-17 05:26:47,208 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-10-17 05:26:47,208 DEBUG --- stdout --- 2024-10-17 05:26:47,208 DEBUG 302120 /results/orders/benchmark/stdout.txt 2024-10-17 05:26:47,208 DEBUG --- stderr --- 2024-10-17 05:26:47,208 DEBUG 2024-10-17 05:26:47,208 INFO - Download file (size 302120k) 2024-10-17 05:26:47,208 INFO 2024-10-17 05:26:47,208 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-10-17 05:26:47,208 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:47,478 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:47,479 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:47,479 DEBUG --- stdout --- 2024-10-17 05:26:47,479 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:47,479 DEBUG --- stderr --- 2024-10-17 05:26:47,479 DEBUG source : /results/orders/benchmark/stdout.txt @ overseer-0-68b86489-ztj5j destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/stdout.txt 2024-10-17 05:26:47,479 INFO 2024-10-17 05:26:47,479 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-10-17 05:26:47,479 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:47,747 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:47,747 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:47,747 DEBUG --- stdout --- 2024-10-17 05:26:47,747 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:47,747 DEBUG --- stderr --- 2024-10-17 05:26:47,747 DEBUG 2024-10-17 05:26:47,748 INFO 2024-10-17 05:26:47,748 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68b86489-ztj5j:/results/orders/benchmark/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/stdout.txt 2024-10-17 05:26:47,748 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-10-17 05:26:57,225 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:57,226 DEBUG --- stdout --- 2024-10-17 05:26:57,226 DEBUG tar: Removing leading `/' from member names 2024-10-17 05:26:57,226 DEBUG --- stderr --- 2024-10-17 05:26:57,226 DEBUG ________________________________________________________________________________ [2024-10-17 05:26:57] benchmark show_cmd : Display order command ________________________________________________________________________________ 2024-10-17 05:26:57,226 INFO 2024-10-17 05:26:57,226 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-10-17 05:26:57,226 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:57,495 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:57,495 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:57,495 DEBUG --- stdout --- 2024-10-17 05:26:57,496 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:57,496 DEBUG --- stderr --- 2024-10-17 05:26:57,496 DEBUG Checking pod: overseer-0-68b86489-ztj5j for file exists, if not wait. 2024-10-17 05:26:57,496 INFO 2024-10-17 05:26:57,496 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-10-17 05:26:57,496 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:57,767 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:57,767 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:57,767 DEBUG --- stdout --- 2024-10-17 05:26:57,767 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:57,767 DEBUG --- stderr --- 2024-10-17 05:26:57,767 DEBUG 2024-10-17 05:26:57,768 INFO 2024-10-17 05:26:57,768 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- bash -c 'if [ -f "/results/orders/benchmark/cmd.txt" ]; then echo "/results/orders/benchmark/cmd.txt file found"; exit 0; else echo "/results/orders/benchmark/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark/cmd.txt file found" 2024-10-17 05:26:57,768 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-10-17 05:26:58,540 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-10-17 05:26:58,540 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:58,540 DEBUG --- stdout --- 2024-10-17 05:26:58,540 DEBUG /results/orders/benchmark/cmd.txt file found 2024-10-17 05:26:58,540 DEBUG --- stderr --- 2024-10-17 05:26:58,540 DEBUG 2024-10-17 05:26:58,540 INFO 2024-10-17 05:26:58,540 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-10-17 05:26:58,540 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:58,810 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:58,810 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:58,810 DEBUG --- stdout --- 2024-10-17 05:26:58,810 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:58,810 DEBUG --- stderr --- 2024-10-17 05:26:58,810 DEBUG 2024-10-17 05:26:58,810 INFO 2024-10-17 05:26:58,810 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68b86489-ztj5j --stdin -- du -k /results/orders/benchmark/cmd.txt 2024-10-17 05:26:59,586 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-10-17 05:26:59,586 DEBUG --- stdout --- 2024-10-17 05:26:59,586 DEBUG 4 /results/orders/benchmark/cmd.txt 2024-10-17 05:26:59,586 DEBUG --- stderr --- 2024-10-17 05:26:59,586 DEBUG 2024-10-17 05:26:59,586 INFO - Download file (size 4k) 2024-10-17 05:26:59,586 INFO 2024-10-17 05:26:59,586 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-10-17 05:26:59,586 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:26:59,854 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:26:59,854 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:26:59,854 DEBUG --- stdout --- 2024-10-17 05:26:59,854 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:26:59,854 DEBUG --- stderr --- 2024-10-17 05:26:59,854 DEBUG source : /results/orders/benchmark/cmd.txt @ overseer-0-68b86489-ztj5j destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/cmd.txt 2024-10-17 05:26:59,855 INFO 2024-10-17 05:26:59,855 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-10-17 05:26:59,855 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-10-17 05:27:00,125 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-10-17 05:27:00,125 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:27:00,125 DEBUG --- stdout --- 2024-10-17 05:27:00,125 DEBUG overseer-0-68b86489-ztj5j 2024-10-17 05:27:00,125 DEBUG --- stderr --- 2024-10-17 05:27:00,125 DEBUG 2024-10-17 05:27:00,125 INFO 2024-10-17 05:27:00,125 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68b86489-ztj5j:/results/orders/benchmark/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/cmd.txt 2024-10-17 05:27:00,125 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-10-17 05:27:00,865 INFO [loop_until]: OK (rc = 0) 2024-10-17 05:27:00,865 DEBUG --- stdout --- 2024-10-17 05:27:00,865 DEBUG tar: Removing leading `/' from member names 2024-10-17 05:27:00,865 DEBUG --- stderr --- 2024-10-17 05:27:00,865 DEBUG 2024-10-17 05:27:00,865 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/cmd.txt is small (1 lines), printing all lines: 2024-10-17 05:27:00,865 DEBUG ----- output ----- 2024-10-17 05:27:00,865 DEBUG /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling/ --run-description "idc.benchmark.CH2023@perf-benchmark" --results-folder /results/gatling/benchmark --extra-run-jvm-options "-Xmx4G" --no-reports 2024-10-17 05:27:00,865 INFO ________________________________________________________________________________ [2024-10-17 05:27:00] benchmark show_rc : Display rc order ________________________________________________________________________________ 2024-10-17 05:27:00,865 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/rc.txt is small (1 lines), printing all lines: 2024-10-17 05:27:00,866 DEBUG ----- output ----- 2024-10-17 05:27:00,866 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-10-17 05:27:00,866 INFO ________________________________________________________________________________ [2024-10-17 05:27:00] benchmark show_stdout : Display stdout order ________________________________________________________________________________ 2024-10-17 05:27:01,209 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_ch2023/07_Scenario_benchmark/01_benchmark/stdout.txt is 2444013 lines): 2024-10-17 05:27:01,209 DEBUG ----- output ----- 2024-10-17 05:27:01,209 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-10-17 05:27:01,209 INFO Gatling 3.12.0 is available! (you're using 3.9.5) 2024-10-17 05:27:01,209 INFO System property think_time_multiplier not set. No think time emulation will be done in the simulation. 2024-10-17 05:27:01,209 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-10-17 05:27:01,209 INFO 05:26:38.179 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'createOrganization' failed for user 11: status.find.in([200, 209], 304), found 404 2024-10-17 05:27:01,209 INFO 05:26:38.185 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-10-17 05:27:01,209 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-10-17 05:27:01,209 INFO Request: 2024-10-17 05:27:01,209 INFO createOrganization: KO status.find.in([200, 209], 304), found 404 2024-10-17 05:27:01,209 INFO ========================= 2024-10-17 05:27:01,209 INFO Session: 2024-10-17 05:27:01,209 INFO Session(idc.benchmark.CH2023,11,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiIydHIwZkZTc3l5SS81Sm9mR0lWL1Z3MVJJSEk9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiI2MGRlMjliNi01NDk3LTQ1ZjUtYWZkOC0xNjdlZjQ5YTBlZmUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiZjAwZWY1YzQtMGVmZC00ZGY1LWJlNWItZTdlODJjNWY0M2YwLTMyMzkzNjAzIiwic3VibmFtZSI6IjYwZGUyOWI2LTU0OTctNDVmNS1hZmQ4LTE2N2VmNDlhMGVmZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiNUJPak9OYldjV1lUVFdYTXUtazQ0d1p2ay1ZIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiaWRtQWRtaW5DbGllbnQiLCJhdWQiOiJpZG1BZG1pbkNsaWVudCIsIm5iZiI6MTcyOTEzOTE5OCwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIiwib3BlbmlkIl0sImF1dGhfdGltZSI6MTcyOTEzOTE5NywicmVhbG0iOiIvIiwiZXhwIjoxNzI5MTQyNzk4LCJpYXQiOjE3MjkxMzkxOTgsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6Im9WLVJRclF3eUFQMlkycDJmZ19KZkxsNzhVWSJ9.Yf5xN-eRKYU3nrKbJyHL62-joTrhVX6-REq750zY0YSH_RWp47BU8TFwl7-c3WCDrRXRNlnXDvAkbdoD5XMbGYzlWFR4XgGcqWcZiQK1KPn3xUHxfS-NKVEfZXZgFblPasoo7WeMqt4zv-vU-2Hi6yHpcJnivLm0CiRXY0eTObVAxJfYRblz6N5z6Lleca3NQS17GkxrSEmhQRk8wQb75l1qukPvQPXMHJvd7l9jTzuHWPTSmzbJM6OVedIR2M6qhWRyd_VXvA2iO_qAZv0bgOdpqxdHlwf-brBvQnOk-ivjVejZG2vyqRYCT0OYCBFSAreEcV1W6W022QvfRccR0w, username -> user.236333, tokenIdCookieName -> 9b75a55744995d0, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@388e1a6f, gatling.http.referer -> https://openam-perf-benchmark.forgeblocks.com/admin/sessionCheck.html, authcode -> YQqlHOZ36APbvkLtDQBJPDt7w8o, useAdminRealm -> true, callbacks -> {"tokenId":"tyRF9Z0ZniiPZdydpaQysPqApgs.*AAJTSQACMDIAAlNLABxwV3BESDJKLzF1MEVwcDdSYkNrSG1tc3A3UGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","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,1729139197910), CookieKey(9b75a55744995d0,openam-perf-benchmark.forgeblocks.com,/) -> StoredCookie(9b75a55744995d0=tyRF9Z0ZniiPZdydpaQysPqApgs.*AAJTSQACMDIAAlNLABxwV3BESDJKLzF1MEVwcDdSYkNrSG1tc3A3UGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*,true,false,1729139198029))), password -> Pa_ssw0rd, challenge -> zugT1Z4w7IGDW6fEJkmAx_wV9-2jK-BXvUdSeP09S8w, gatling.http.cache.baseUrl -> https://openam-perf-benchmark.forgeblocks.com:443, fake-ip -> 42.42.42.42, verifier -> LTQwODAwNDU4MTQ0ODE1OTAyNzE, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@31a4893f, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@1923a143, tokenId -> tyRF9Z0ZniiPZdydpaQysPqApgs.*AAJTSQACMDIAAlNLABxwV3BESDJKLzF1MEVwcDdSYkNrSG1tc3A3UGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, 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$895/0x00007e0a086e94d8@2a0978e6,io.netty.channel.epoll.EpollEventLoop@2e27d72f) 2024-10-17 05:27:01,210 INFO ========================= 2024-10-17 05:27:01,210 INFO HTTP request: 2024-10-17 05:27:01,210 INFO POST https://openam-perf-benchmark.forgeblocks.com/openidm/managed/root/realms/alpha_organization?_action=create 2024-10-17 05:27:01,210 INFO headers: 2024-10-17 05:27:01,210 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-10-17 05:27:01,210 INFO content-type: application/json 2024-10-17 05:27:01,210 INFO referer: https://openam-perf-benchmark.forgeblocks.com/admin/sessionCheck.html 2024-10-17 05:27:01,210 INFO authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiIydHIwZkZTc3l5SS81Sm9mR0lWL1Z3MVJJSEk9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiI2MGRlMjliNi01NDk3LTQ1ZjUtYWZkOC0xNjdlZjQ5YTBlZmUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiZjAwZWY1YzQtMGVmZC00ZGY1LWJlNWItZTdlODJjNWY0M2YwLTMyMzkzNjAzIiwic3VibmFtZSI6IjYwZGUyOWI2LTU0OTctNDVmNS1hZmQ4LTE2N2VmNDlhMGVmZSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiNUJPak9OYldjV1lUVFdYTXUtazQ0d1p2ay1ZIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiaWRtQWRtaW5DbGllbnQiLCJhdWQiOiJpZG1BZG1pbkNsaWVudCIsIm5iZiI6MTcyOTEzOTE5OCwiZ3JhbnRfdHlwZSI6ImF1dGhvcml6YXRpb25fY29kZSIsInNjb3BlIjpbImZyOmlkbToqIiwib3BlbmlkIl0sImF1dGhfdGltZSI6MTcyOTEzOTE5NywicmVhbG0iOiIvIiwiZXhwIjoxNzI5MTQyNzk4LCJpYXQiOjE3MjkxMzkxOTgsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6Im9WLVJRclF3eUFQMlkycDJmZ19KZkxsNzhVWSJ9.Yf5xN-eRKYU3nrKbJyHL62-joTrhVX6-REq750zY0YSH_RWp47BU8TFwl7-c3WCDrRXRNlnXDvAkbdoD5XMbGYzlWFR4XgGcqWcZiQK1KPn3xUHxfS-NKVEfZXZgFblPasoo7WeMqt4zv-vU-2Hi6yHpcJnivLm0CiRXY0eTObVAxJfYRblz6N5z6Lleca3NQS17GkxrSEmhQRk8wQb75l1qukPvQPXMHJvd7l9jTzuHWPTSmzbJM6OVedIR2M6qhWRyd_VXvA2iO_qAZv0bgOdpqxdHlwf-brBvQnOk-ivjVejZG2vyqRYCT0OYCBFSAreEcV1W6W022QvfRccR0w 2024-10-17 05:27:01,210 INFO accept: */* 2024-10-17 05:27:01,210 INFO cookie: amlbcookie=01; 9b75a55744995d0=tyRF9Z0ZniiPZdydpaQysPqApgs.*AAJTSQACMDIAAlNLABxwV3BESDJKLzF1MEVwcDdSYkNrSG1tc3A3UGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-10-17 05:27:01,210 INFO origin: https://openam-perf-benchmark.forgeblocks.com 2024-10-17 05:27:01,210 INFO host: openam-perf-benchmark.forgeblocks.com 2024-10-17 05:27:01,210 INFO content-length: 62 2024-10-17 05:27:01,210 INFO cookies: 2024-10-17 05:27:01,210 INFO amlbcookie=01, domain=openam-perf-benchmark.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-10-17 05:27:01,210 INFO 9b75a55744995d0=tyRF9Z0ZniiPZdydpaQysPqApgs.*AAJTSQACMDIAAlNLABxwV3BESDJKLzF1MEVwcDdSYkNrSG1tc3A3UGs9AAR0eXBlAANDVFMAAlMxAAIwMQ..* 2024-10-17 05:27:01,210 INFO body:StringChunksRequestBody{charset=UTF-8, content={"description":"Test Organization","name":"Test Organization"}} 2024-10-17 05:27:01,210 INFO ========================= 2024-10-17 05:27:01,210 INFO HTTP response: 2024-10-17 05:27:01,210 INFO status: 2024-10-17 05:27:01,210 INFO 404 Not Found 2024-10-17 05:27:01,210 INFO headers: 2024-10-17 05:27:01,210 INFO date: Thu, 17 Oct 2024 04:26:38 GMT 2024-10-17 05:27:01,210 INFO access-control-allow-origin: https://openam-perf-benchmark.forgeblocks.com 2024-10-17 05:27:01,210 INFO vary: Origin 2024-10-17 05:27:01,210 INFO access-control-expose-headers: WWW-Authenticate 2024-10-17 05:27:01,210 INFO cache-control: no-store 2024-10-17 05:27:01,210 INFO content-security-policy: default-src 'none';frame-ancestors 'none';sandbox 2024-10-17 05:27:01,210 INFO content-type: application/json;charset=utf-8 2024-10-17 05:27:01,210 INFO cross-origin-opener-policy: same-origin 2024-10-17 05:27:01,210 INFO cross-origin-resource-policy: same-origin 2024-10-17 05:27:01,210 INFO expires: 0 2024-10-17 05:27:01,210 INFO pragma: no-cache 2024-10-17 05:27:01,210 INFO x-content-type-options: nosniff 2024-10-17 05:27:01,210 INFO x-frame-options: DENY 2024-10-17 05:27:01,210 INFO Content-Length: 113 2024-10-17 05:27:01,210 INFO x-forgerock-transactionid: fb159e9b-643c-440a-b9b1-11af2db54f0a 2024-10-17 05:27:01,210 INFO strict-transport-security: max-age=31536000; includeSubDomains; preload; 2024-10-17 05:27:01,210 INFO x-robots-tag: none 2024-10-17 05:27:01,210 INFO Via: 1.1 google 2024-10-17 05:27:01,210 INFO Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 2024-10-17 05:27:01,210 INFO 2024-10-17 05:27:01,210 INFO body: 2024-10-17 05:27:01,210 INFO {"code":404,"reason":"Not Found","message":"Resource 'managed/root/realms/alpha_organization' not found"} 2024-10-17 05:27:01,210 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-10-17 05:27:01,210 INFO 05:26:38.186 [ERROR] i.g.h.a.HttpRequestAction - 'queryOrganization' failed to execute: No attribute named 'organization_id' is defined 2024-10-17 05:27:01,210 INFO 05:26:38.186 [ERROR] i.g.h.a.HttpRequestAction - 'deleteOrganization' failed to execute: No attribute named 'organization_id' is defined 2024-10-17 05:27:01,210 INFO 2024-10-17 05:27:01,210 INFO ================================================================================ 2024-10-17 05:27:01,210 INFO 2024-10-17 05:26:40 5s elapsed 2024-10-17 05:27:01,210 INFO ---- Requests ------------------------------------------------------------------ 2024-10-17 05:27:01,210 INFO > Global (OK=381 KO=1 ) 2024-10-17 05:27:01,210 INFO > restLoginInitiate (OK=36 KO=0 ) 2024-10-17 05:27:01,210 INFO > restLoginUsernamePasswordCallback (OK=35 KO=0 ) 2024-10-17 05:27:01,210 INFO > Skip 2FA (OK=24 KO=0 ) 2024-10-17 05:27:01,210 INFO > User Authorize PKCE stage (OK=34 KO=0 ) 2024-10-17 05:27:01,210 INFO > User AccessToken PKCE stage (OK=34 KO=0 ) 2024-10-17 05:27:01,210 INFO > RootUserinfo (OK=53 KO=0 ) 2024-10-17 05:27:01,210 INFO > selfService: login existing user and patch its telNum... (OK=5 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=5 KO=0 ) 2024-10-17 05:27:01,211 INFO > tokenUserinfo (OK=6 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=8 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=5 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=5 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > getIdToken (OK=1 KO=0 ) 2024-10-17 05:27:01,211 INFO > getIdToken Redirect 1 (OK=1 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > createOrganization (OK=0 KO=1 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=7 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=7 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=4 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > UI-Post-Login - stage 1 (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > UI-Post-Login - stage 1 Redirect 1 (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > UI AM validateGoto (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > UI AM idFromSession (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO > selfService: login existing user and patch its telNum... (OK=3 KO=0 ) 2024-10-17 05:27:01,211 INFO [...] 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45696 KO=0 ) 2024-10-17 05:27:01,775 INFO > UI-Post-Login - stage 2 (OK=14327 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=45694 KO=0 ) 2024-10-17 05:27:01,775 INFO > UI-Post-Login - stage 2 Redirect 1 (OK=14327 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=25017 KO=0 ) 2024-10-17 05:27:01,775 INFO > UI Enduser appAuthHelper2 (OK=14327 KO=0 ) 2024-10-17 05:27:01,775 INFO > UI Enduser appAuthHelper1 (OK=14327 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=25017 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=25017 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=25017 KO=0 ) 2024-10-17 05:27:01,775 INFO > selfService: login existing user and patch its telNum... (OK=25017 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI-Post-Login - stage 3 (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI-Post-Login - stage 3 Redirect 1 (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI Enduser sessioncheck (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM uiconfig (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM version (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM features (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM privilege (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM login (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM dashboard (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM managed user schema (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM user (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI IDM oidcToken (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > userinfo (OK=14327 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI-Logout (OK=14326 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI-Logout Redirect 1 (OK=14325 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI AM revoke2 (OK=14325 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI AM revoke1 (OK=14325 KO=0 ) 2024-10-17 05:27:01,776 INFO > UI AM endsession (OK=14325 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / registration... (OK=11554 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / registration... (OK=11554 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11554 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11554 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI AM idFro... (OK=11551 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI AM valid... (OK=11551 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / User Authori... (OK=23100 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / User AccessT... (OK=23099 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11550 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI Enduser ... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI Enduser ... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI-Post-Logi... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI Enduser ... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM uico... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM vers... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM feat... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM priv... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM logi... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM dash... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM mana... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM user (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: register and view profile / UI IDM oidc... (OK=11549 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: login existing user and patch its telNum... (OK=18126 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: login existing user and patch its telNum... (OK=18126 KO=0 ) 2024-10-17 05:27:01,776 INFO > selfService: login existing user and patch its telNum... (OK=139 KO=0 ) 2024-10-17 05:27:01,776 INFO > restloginProgressiveProfileCallback (OK=34 KO=0 ) 2024-10-17 05:27:01,776 INFO ---- Errors -------------------------------------------------------------------- 2024-10-17 05:27:01,776 INFO > status.find.in([200, 209], 304), found 404 42922 (33.28%) 2024-10-17 05:27:01,776 INFO > queryOrganization: Failed to build request: No attribute named 42922 (33.28%) 2024-10-17 05:27:01,776 INFO 'organization_id' is defined 2024-10-17 05:27:01,776 INFO > deleteOrganization: Failed to build request: No attribute name 42922 (33.28%) 2024-10-17 05:27:01,776 INFO d 'organization_id' is defined 2024-10-17 05:27:01,776 INFO > tokenUserinfo: Failed to build request: No attribute named 'ac 205 ( 0.16%) 2024-10-17 05:27:01,776 INFO cess_token' is defined 2024-10-17 05:27:01,776 INFO > status.find.in([200, 209], 304), found 502 2 ( 0.00%) 2024-10-17 05:27:01,776 INFO > status.find.is(200), but actually found 502 1 ( 0.00%) 2024-10-17 05:27:01,776 INFO 2024-10-17 05:27:01,776 INFO ---- idc.benchmark.CH2023 ------------------------------------------------------ 2024-10-17 05:27:01,776 INFO [#########################################################################-] 99% 2024-10-17 05:27:01,776 INFO waiting: 3025 / active: 301 / done: 357620 2024-10-17 05:27:01,777 INFO ================================================================================ 2024-10-17 05:27:01,777 INFO 2024-10-17 05:27:01,777 INFO Simulation com.forgerock.gatling.Loadtest completed in 3600 seconds 2024-10-17 05:27:01,777 INFO 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO [17/Oct/2024 06:26:35] Create tar file benchmark.tar.gz 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO RESULTS_FOLDER=/results/gatling/ 2024-10-17 05:27:01,777 INFO RESULT_FOLDER=benchmark 2024-10-17 05:27:01,777 INFO SIMULATION_PATH=benchmark/loadtest-20241017042634640 2024-10-17 05:27:01,777 INFO PWD=/results/gatling/benchmark/loadtest-20241017042634640 2024-10-17 05:27:01,777 INFO [cmd] tar -czvf /results/gatling//benchmark.tar.gz --exclude=simulation.log * 2024-10-17 05:27:01,777 INFO /results/gatling 2024-10-17 05:27:01,777 INFO 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO [17/Oct/2024 06:26:35] Update /results/gatling//latest 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO [17/Oct/2024 06:26:35] Update /results/gatling//latest.tar.gz 2024-10-17 05:27:01,777 INFO ---------------------- 2024-10-17 05:27:01,777 INFO ________________________________________________________________________________ [2024-10-17 05:27:01] benchmark show_stderr : Display stderr order ________________________________________________________________________________ 2024-10-17 05:27:01,777 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark_ch2023/07_Scenario_benchmark/01_benchmark/stderr.txt is small (0 lines), printing all lines: 2024-10-17 05:27:01,777 DEBUG ----- output ----- 2024-10-17 05:27:01,777 DEBUG 2024-10-17 05:27:01,777 INFO ________________________________________________________________________________ [2024-10-17 05:27:01] benchmark 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-10-17 05:27:06] benchmark print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-10-17 05:27:06] benchmark post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped