--Task-- name: Verification-am enabled: True class_name: VerificationTask source_name: am 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 bellow loop: False interval: None dependencies: [] wait_for: [] preceding_task: None options: {} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-25 17:42:22] Verification-am pre : N/A ________________________________________________________________________________ [2024-04-25 17:42:22] - INFO: Timeout for this Task has changed to 5m (300 seconds) [2024-04-25 17:42:22] - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset ________________________________________________________________________________ [2024-04-25 17:42:22] Verification-am step1 : Wait until pods are in Running state and check number of running pods ________________________________________________________________________________ 2024-04-25 17:42:22,065 INFO 2024-04-25 17:42:22,065 INFO --------------------- Get expected number of pods --------------------- 2024-04-25 17:42:22,066 INFO 2024-04-25 17:42:22,066 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get deployments --selector app=am --output jsonpath={.items[*].spec.replicas} 2024-04-25 17:42:22,066 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-25 17:42:23,156 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:23,156 DEBUG --- stdout --- 2024-04-25 17:42:23,156 DEBUG 3 2024-04-25 17:42:23,156 DEBUG --- stderr --- 2024-04-25 17:42:23,156 DEBUG 2024-04-25 17:42:23,156 INFO 2024-04-25 17:42:23,157 INFO -------------- Waiting for 3 expected pod(s) to be ready -------------- 2024-04-25 17:42:23,157 INFO 2024-04-25 17:42:23,157 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get deployments am --output jsonpath="ready:{.status.readyReplicas} replicas:{.status.replicas}" | grep "ready:3 replicas:3" 2024-04-25 17:42:23,157 INFO [loop_until]: (max_time=900, interval=30, expected_rc=[0] 2024-04-25 17:42:24,091 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-25 17:42:24,095 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:24,096 DEBUG --- stdout --- 2024-04-25 17:42:24,101 DEBUG ready:3 replicas:3 2024-04-25 17:42:24,124 DEBUG --- stderr --- 2024-04-25 17:42:24,125 DEBUG ________________________________________________________________________________ [2024-04-25 17:42:24] Verification-am step2 : Discovering pods ________________________________________________________________________________ 2024-04-25 17:42:24,127 INFO 2024-04-25 17:42:24,149 INFO --------------------- Get expected number of pods --------------------- 2024-04-25 17:42:24,151 INFO 2024-04-25 17:42:24,151 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get deployments --selector app=am --output jsonpath={.items[*].spec.replicas} 2024-04-25 17:42:24,151 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-25 17:42:25,127 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:25,128 DEBUG --- stdout --- 2024-04-25 17:42:25,128 DEBUG 3 2024-04-25 17:42:25,128 DEBUG --- stderr --- 2024-04-25 17:42:25,128 DEBUG 2024-04-25 17:42:25,128 INFO 2024-04-25 17:42:25,128 INFO ---------------------------- Get pod list ---------------------------- 2024-04-25 17:42:25,128 INFO 2024-04-25 17:42:25,128 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=am --output jsonpath={.items[*].metadata.name}` | grep 3 2024-04-25 17:42:25,129 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-25 17:42:25,745 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-25 17:42:25,745 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:25,745 DEBUG --- stdout --- 2024-04-25 17:42:25,745 DEBUG am-769b98f8d5-4ftrv am-769b98f8d5-phmxx am-769b98f8d5-zbtk2 2024-04-25 17:42:25,745 DEBUG --- stderr --- 2024-04-25 17:42:25,745 DEBUG ________________________________________________________________________________ [2024-04-25 17:42:25] Verification-am step3 : Check component is alive ________________________________________________________________________________ 2024-04-25 17:42:25,746 INFO Livecheck to https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/health/ready 2024-04-25 17:42:25,748 INFO [http_cmd]: curl -L --request GET "https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/health/ready" 2024-04-25 17:42:26,020 INFO [http_cmd]: http status code OK 2024-04-25 17:42:26,020 DEBUG --- status code --- 2024-04-25 17:42:26,020 DEBUG http status code is 200 (expected 200) 2024-04-25 17:42:26,020 DEBUG --- http response --- 2024-04-25 17:42:26,020 DEBUG 2024-04-25 17:42:26,020 INFO Authenticate user amadmin via REST 2024-04-25 17:42:26,020 INFO [http_cmd]: curl -L --request POST "https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/authenticate?realm=/" 2024-04-25 17:42:26,247 INFO [http_cmd]: http status code OK 2024-04-25 17:42:26,247 DEBUG --- status code --- 2024-04-25 17:42:26,247 DEBUG http status code is 200 (expected 200) 2024-04-25 17:42:26,247 DEBUG --- http response --- 2024-04-25 17:42:26,247 DEBUG { "tokenId": "HSjugrjwZ3bQVlf2xyH1BNNdcfI.*AAJTSQACMDIAAlNLABxaRVZKVTRCUzFQRDhSWUFWK09tM3NDYnFleEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*", "successUrl": "/am/console", "realm": "/" } PASS : component am is alive ________________________________________________________________________________ [2024-04-25 17:42:26] Verification-am step4 : Record version ________________________________________________________________________________ 2024-04-25 17:42:26,252 INFO 2024-04-25 17:42:26,252 INFO ----------------------- Get AM software version ----------------------- 2024-04-25 17:42:26,252 INFO Getting product version from https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/serverinfo/version 2024-04-25 17:42:26,252 INFO [LoginSession] Get "token_id" token for user "amadmin" 2024-04-25 17:42:26,252 INFO [LoginSession] Obtaining new "token_id" token from server because it has expired 2024-04-25 17:42:26,252 INFO Authenticate user amadmin via REST 2024-04-25 17:42:26,252 INFO [http_cmd]: curl -L --request POST "https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/authenticate?realm=/" 2024-04-25 17:42:26,478 INFO [http_cmd]: http status code OK 2024-04-25 17:42:26,479 DEBUG --- status code --- 2024-04-25 17:42:26,479 DEBUG http status code is 200 (expected 200) 2024-04-25 17:42:26,479 DEBUG --- http response --- 2024-04-25 17:42:26,479 DEBUG { "tokenId": "Cis9kw-BOvawTGugU4OKyJ2Mu3U.*AAJTSQACMDIAAlNLABxEdmhHNFFjaElxT3FMaGJ1RC94OGhmMHE3d3c9AAR0eXBlAANDVFMAAlMxAAIwMQ..*", "successUrl": "/am/console", "realm": "/" } 2024-04-25 17:42:26,479 INFO [LoginSession] Obtaining session info 2024-04-25 17:42:26,479 INFO [http_cmd]: curl -L --request POST "https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/realms/root/sessions?_action=getSessionInfo" 2024-04-25 17:42:26,752 INFO [http_cmd]: http status code OK 2024-04-25 17:42:26,752 DEBUG --- status code --- 2024-04-25 17:42:26,752 DEBUG http status code is 200 (expected 200) 2024-04-25 17:42:26,753 DEBUG --- http response --- 2024-04-25 17:42:26,753 DEBUG { "username": "amadmin", "universalId": "id=amadmin,ou=user,ou=am-config", "realm": "/", "latestAccessTime": "2024-04-25T17:42:26Z", "maxIdleExpirationTime": "2024-04-25T17:45:26Z", "maxSessionExpirationTime": "2024-04-25T17:45:25Z", "properties": { "AMCtxId": "0fe231b0-7e3e-4f09-90b1-0be042b20466-771" } } 2024-04-25 17:42:26,758 INFO [http_cmd]: curl -L --request GET --cookie "amlbcookie=01" --cookie "iPlanetDirectoryPro=Cis9kw-BOvawTGugU4OKyJ2Mu3U.*AAJTSQACMDIAAlNLABxEdmhHNFFjaElxT3FMaGJ1RC94OGhmMHE3d3c9AAR0eXBlAANDVFMAAlMxAAIwMQ..*" --cookie "route=1714066947.431.9874.705178|f60edb382037eb2df1e800d563ad78a7" "https://xlou.iam.xlou-cdm.engineeringpit.com/am/json/serverinfo/version" 2024-04-25 17:42:26,994 INFO [http_cmd]: http status code OK 2024-04-25 17:42:26,994 DEBUG --- status code --- 2024-04-25 17:42:26,994 DEBUG http status code is 200 (expected 200) 2024-04-25 17:42:26,994 DEBUG --- http response --- 2024-04-25 17:42:26,994 DEBUG { "_id": "version", "_rev": "-1467156544", "version": "7.6.0-SNAPSHOT", "fullVersion": "ForgeRock Access Management 7.6.0-SNAPSHOT Build 1ea0b707baef4b0816b74795e83665828894daed (2024-April-23 16:39)", "revision": "1ea0b707baef4b0816b74795e83665828894daed", "date": "2024-April-23 16:39" } Version is 7.6.0-SNAPSHOT Revision is 1ea0b707baef4b0816b74795e83665828894daed ________________________________________________________________________________ [2024-04-25 17:42:26] Verification-am step5 : Checking pod restart counts ________________________________________________________________________________ 2024-04-25 17:42:26,996 INFO 2024-04-25 17:42:26,996 INFO ------------- Check pod am-769b98f8d5-4ftrv restart count ------------- 2024-04-25 17:42:26,996 INFO 2024-04-25 17:42:26,996 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pod am-769b98f8d5-4ftrv --output jsonpath={.status.containerStatuses[*].restartCount} 2024-04-25 17:42:26,996 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-25 17:42:27,372 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:27,372 DEBUG --- stdout --- 2024-04-25 17:42:27,372 DEBUG 0 2024-04-25 17:42:27,372 DEBUG --- stderr --- 2024-04-25 17:42:27,373 DEBUG 2024-04-25 17:42:27,373 INFO Pod am-769b98f8d5-4ftrv has been restarted 0 times. SUCCESS : pod restart count (0) did not change between validation and verification phases 2024-04-25 17:42:27,373 INFO 2024-04-25 17:42:27,373 INFO ------------- Check pod am-769b98f8d5-phmxx restart count ------------- 2024-04-25 17:42:27,373 INFO 2024-04-25 17:42:27,373 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pod am-769b98f8d5-phmxx --output jsonpath={.status.containerStatuses[*].restartCount} 2024-04-25 17:42:27,373 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-25 17:42:27,903 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:27,903 DEBUG --- stdout --- 2024-04-25 17:42:27,904 DEBUG 0 2024-04-25 17:42:27,904 DEBUG --- stderr --- 2024-04-25 17:42:27,916 DEBUG 2024-04-25 17:42:27,917 INFO Pod am-769b98f8d5-phmxx has been restarted 0 times. SUCCESS : pod restart count (0) did not change between validation and verification phases 2024-04-25 17:42:27,918 INFO 2024-04-25 17:42:27,918 INFO ------------- Check pod am-769b98f8d5-zbtk2 restart count ------------- 2024-04-25 17:42:27,922 INFO 2024-04-25 17:42:27,922 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pod am-769b98f8d5-zbtk2 --output jsonpath={.status.containerStatuses[*].restartCount} 2024-04-25 17:42:27,922 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-25 17:42:28,515 INFO [loop_until]: OK (rc = 0) 2024-04-25 17:42:28,515 DEBUG --- stdout --- 2024-04-25 17:42:28,515 DEBUG 0 2024-04-25 17:42:28,515 DEBUG --- stderr --- 2024-04-25 17:42:28,515 DEBUG 2024-04-25 17:42:28,515 INFO Pod am-769b98f8d5-zbtk2 has been restarted 0 times. SUCCESS : pod restart count (0) did not change between validation and verification phases ________________________________________________________________________________ [2024-04-25 17:42:28] Verification-am post : Post method ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped