dacbd/action.yml

2021-09-22T18:48:13.6825399Z ##[group]Run cml-runner \
2021-09-22T18:48:13.6826084Z �[36;1mcml-runner \�[0m
2021-09-22T18:48:13.6826657Z �[36;1m  --log=debug \�[0m
2021-09-22T18:48:13.6827188Z �[36;1m  --single \�[0m
2021-09-22T18:48:13.6827767Z �[36;1m  --idle-timeout=1800 \�[0m
2021-09-22T18:48:13.6828911Z �[36;1m  --token=*** \�[0m
2021-09-22T18:48:13.6829583Z �[36;1m  --cloud=gcp \�[0m
2021-09-22T18:48:13.6830204Z �[36;1m  --cloud-region=us-west \�[0m
2021-09-22T18:48:13.6830856Z �[36;1m  --cloud-type=m \�[0m
2021-09-22T18:48:13.6831472Z �[36;1m  --cloud-gpu=nogpu \�[0m
2021-09-22T18:48:13.6832114Z �[36;1m  --cloud-hdd-size=10�[0m
2021-09-22T18:48:13.6879996Z shell: /usr/bin/bash -e ***0***
2021-09-22T18:48:13.6880512Z env:
2021-09-22T18:48:13.6905337Z   GOOGLE_APPLICATION_CREDENTIALS_DATA: ***
2021-09-22T18:48:13.6905955Z ##[endgroup]
2021-09-22T18:48:13.6949453Z ##[debug]/usr/bin/bash -e /home/runner/work/_temp/fe3c1be5-e5ad-436a-8b3a-ece8934680f8.sh
2021-09-22T18:48:15.3337533Z ***"level":"info","message":"Preparing workdir /home/runner/.cml/cml-0lb6umdjde..."***
2021-09-22T18:48:15.3350256Z ***"level":"info","message":"Deploying cloud runner plan..."***
2021-09-22T18:48:15.3353486Z ***"level":"info","message":"Terraform apply..."***
2021-09-22T18:48:24.1779408Z ***"level":"error"***
2021-09-22T18:48:24.1781609Z ***"level":"error","status":"terminated"***
2021-09-22T18:48:44.2034492Z ##[error]Process completed with exit code 1.

dacbd · 2021-09-22T21:52:02Z

FAILED GITHUB ACTIONS RUN:

  deploy-runner:
    runs-on: ubuntu-latest
    steps:
      - uses: DanielBarnes/setup-cml@2970b7282efdade5a071a7be526162a4edcb149b
      - uses: actions/checkout@v2
      - name: Deploy runner on GCP # https://cml.dev/doc/self-hosted-runners#cloud-compute-resource-credentials
        env:
          GOOGLE_APPLICATION_CREDENTIALS_DATA: ${{ secrets.GCP_CML_RUNNER_KEY }}
        run: |
          touch /tmp/terraform.log
          TF_LOG=TRACE TF_LOG_PATH=/tmp/terraform.log cml-runner \
            --single \
            --log=debug \
            --idle-timeout=1800 \
            --token=${{ secrets.PAT_DCB }} \
            --cloud=gcp \
            --cloud-region=us-west \
            --cloud-type=m \
            --cloud-gpu=nogpu \
            --cloud-hdd-size=10 & tail -f /tmp/terraform.log

LOG:

##[debug]Evaluating: secrets.GCP_CML_RUNNER_KEY
##[debug]Evaluating Index:
##[debug]..Evaluating secrets:
##[debug]..=> Object
##[debug]..Evaluating String:
##[debug]..=> 'GCP_CML_RUNNER_KEY'
##[debug]=> '***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]***'
##[debug]Result: '***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]  ***
##[debug]***'
##[debug]Evaluating condition for step: 'Deploy runner on GCP'
##[debug]Evaluating: success()
##[debug]Evaluating success:
##[debug]=> true
##[debug]Result: true
##[debug]Starting: Deploy runner on GCP
##[debug]Loading inputs
##[debug]Evaluating: format('touch /tmp/terraform.log
##[debug]TF_LOG=TRACE TF_LOG_PATH=/tmp/terraform.log cml-runner \
##[debug]  --single \
##[debug]  --log=debug \
##[debug]  --idle-timeout=1800 \
##[debug]  --token=***0*** \
##[debug]  --cloud=gcp \
##[debug]  --cloud-region=us-west \
##[debug]  --cloud-type=m \
##[debug]  --cloud-gpu=nogpu \
##[debug]  --cloud-hdd-size=10 & tail -f /tmp/terraform.log
##[debug]', secrets.PAT_DCB)
##[debug]Evaluating format:
##[debug]..Evaluating String:
##[debug]..=> 'touch /tmp/terraform.log
##[debug]TF_LOG=TRACE TF_LOG_PATH=/tmp/terraform.log cml-runner \
##[debug]  --single \
##[debug]  --log=debug \
##[debug]  --idle-timeout=1800 \
##[debug]  --token=***0*** \
##[debug]  --cloud=gcp \
##[debug]  --cloud-region=us-west \
##[debug]  --cloud-type=m \
##[debug]  --cloud-gpu=nogpu \
##[debug]  --cloud-hdd-size=10 & tail -f /tmp/terraform.log
##[debug]'
##[debug]..Evaluating Index:
##[debug]....Evaluating secrets:
##[debug]....=> Object
##[debug]....Evaluating String:
##[debug]....=> 'PAT_DCB'
##[debug]..=> '***'
##[debug]=> 'touch /tmp/terraform.log
##[debug]TF_LOG=TRACE TF_LOG_PATH=/tmp/terraform.log cml-runner \
##[debug]  --single \
##[debug]  --log=debug \
##[debug]  --idle-timeout=1800 \
##[debug]  --token=*** \
##[debug]  --cloud=gcp \
##[debug]  --cloud-region=us-west \
##[debug]  --cloud-type=m \
##[debug]  --cloud-gpu=nogpu \
##[debug]  --cloud-hdd-size=10 & tail -f /tmp/terraform.log
##[debug]'
##[debug]Result: 'touch /tmp/terraform.log
##[debug]TF_LOG=TRACE TF_LOG_PATH=/tmp/terraform.log cml-runner \
##[debug]  --single \
##[debug]  --log=debug \
##[debug]  --idle-timeout=1800 \
##[debug]  --token=*** \
##[debug]  --cloud=gcp \
##[debug]  --cloud-region=us-west \
##[debug]  --cloud-type=m \
##[debug]  --cloud-gpu=nogpu \
##[debug]  --cloud-hdd-size=10 & tail -f /tmp/terraform.log
##[debug]'
##[debug]Loading env
Run touch /tmp/terraform.log
##[debug]/usr/bin/bash -e /home/runner/work/_temp/6e5931a9-1179-4c71-a61c-6c7f4ce8d803.sh
2021-09-22T21:35:47.822Z [DEBUG] Adding temp file log sink: /tmp/terraform-log445738605
2021-09-22T21:35:47.822Z [INFO]  Terraform version: 1.0.6
2021-09-22T21:35:47.822Z [INFO]  Go runtime version: go1.16.4
2021-09-22T21:35:47.822Z [INFO]  CLI args: []string***"/usr/local/bin/terraform", "version", "-json"***
2021-09-22T21:35:47.822Z [TRACE] Stdout is not a terminal
2021-09-22T21:35:47.822Z [TRACE] Stderr is not a terminal
2021-09-22T21:35:47.822Z [TRACE] Stdin is not a terminal
2021-09-22T21:35:47.822Z [DEBUG] Attempting to open CLI config file: /home/runner/.terraformrc
2021-09-22T21:35:47.822Z [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2021-09-22T21:35:47.823Z [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2021-09-22T21:35:47.824Z [DEBUG] ignoring non-existing provider search directory /home/runner/.terraform.d/plugins
2021-09-22T21:35:47.824Z [DEBUG] ignoring non-existing provider search directory /home/runner/.local/share/terraform/plugins
2021-09-22T21:35:47.824Z [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2021-09-22T21:35:47.825Z [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2021-09-22T21:35:47.859Z [INFO]  CLI command args: []string***"version", "-json"***
***"level":"info","message":"Preparing workdir /home/runner/.cml/cml-xv2hfhmygd..."***
***"level":"info","message":"Deploying cloud runner plan..."***
***"level":"info","message":"Terraform apply..."***
2021-09-22T21:35:48.753Z [DEBUG] Adding temp file log sink: /tmp/terraform-log341615476
2021-09-22T21:35:48.753Z [INFO]  Terraform version: 1.0.6
2021-09-22T21:35:48.755Z [INFO]  Go runtime version: go1.16.4
2021-09-22T21:35:48.755Z [INFO]  CLI args: []string***"/usr/local/bin/terraform", "-chdir=/home/runner/.cml/cml-xv2hfhmygd", "init"***
2021-09-22T21:35:48.755Z [TRACE] Stdout is not a terminal
2021-09-22T21:35:48.755Z [TRACE] Stderr is not a terminal
2021-09-22T21:35:48.755Z [TRACE] Stdin is not a terminal
2021-09-22T21:35:48.755Z [DEBUG] Attempting to open CLI config file: /home/runner/.terraformrc
2021-09-22T21:35:48.755Z [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2021-09-22T21:35:48.755Z [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2021-09-22T21:35:48.755Z [DEBUG] ignoring non-existing provider search directory /home/runner/.terraform.d/plugins
2021-09-22T21:35:48.755Z [DEBUG] ignoring non-existing provider search directory /home/runner/.local/share/terraform/plugins
2021-09-22T21:35:48.755Z [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2021-09-22T21:35:48.755Z [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2021-09-22T21:35:48.758Z [INFO]  CLI command args: []string***"init"***
2021-09-22T21:35:48.928Z [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2021-09-22T21:35:48.928Z [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2021-09-22T21:35:48.935Z [DEBUG] New state was assigned lineage "305ec041-e8a3-a32c-cd37-266f6e48919f"
2021-09-22T21:35:48.935Z [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2021-09-22T21:35:48.935Z [TRACE] Meta.Backend: instantiated backend of type <nil>
2021-09-22T21:35:48.936Z [DEBUG] checking for provisioner in "."
2021-09-22T21:35:48.936Z [DEBUG] checking for provisioner in "/usr/local/bin"
2021-09-22T21:35:48.936Z [INFO]  Failed to read plugin lock file .terraform/plugins/linux_amd64/lock.json: open .terraform/plugins/linux_amd64/lock.json: no such file or directory
2021-09-22T21:35:48.937Z [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2021-09-22T21:35:48.937Z [TRACE] backend/local: state manager for workspace "default" will:
 - read initial snapshot from terraform.tfstate
 - write new snapshots to terraform.tfstate
 - create any backup at terraform.tfstate.backup
2021-09-22T21:35:48.937Z [TRACE] statemgr.Filesystem: reading initial snapshot from terraform.tfstate
2021-09-22T21:35:48.937Z [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2021-09-22T21:35:48.937Z [TRACE] statemgr.Filesystem: read nil snapshot
2021-09-22T21:35:48.939Z [DEBUG] Service discovery for registry.terraform.io at https://registry.terraform.io/.well-known/terraform.json
2021-09-22T21:35:48.939Z [TRACE] HTTP client GET request to https://registry.terraform.io/.well-known/terraform.json
2021-09-22T21:35:48.996Z [DEBUG] GET https://registry.terraform.io/v1/providers/iterative/iterative/versions
2021-09-22T21:35:48.996Z [TRACE] HTTP client GET request to https://registry.terraform.io/v1/providers/iterative/iterative/versions
2021-09-22T21:35:49.086Z [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2021-09-22T21:35:49.087Z [TRACE] getproviders.SearchLocalDirectory: failed to resolve symlinks for .terraform/providers: lstat .terraform: no such file or directory
2021-09-22T21:35:49.087Z [TRACE] providercache.fillMetaCache: error while scanning directory .terraform/providers: cannot search .terraform/providers: lstat .terraform/providers: no such file or directory
2021-09-22T21:35:49.087Z [DEBUG] GET https://registry.terraform.io/v1/providers/iterative/iterative/0.7.3/download/linux/amd64
2021-09-22T21:35:49.087Z [TRACE] HTTP client GET request to https://registry.terraform.io/v1/providers/iterative/iterative/0.7.3/download/linux/amd64
2021-09-22T21:35:49.114Z [DEBUG] GET https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_SHA256SUMS
2021-09-22T21:35:49.114Z [TRACE] HTTP client GET request to https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_SHA256SUMS
2021-09-22T21:35:49.298Z [TRACE] HTTP client GET request to https://releases.521000.best/292388086/dfe4d008-8aff-473a-81e4-fb1985d22236?X-Amz-Algorithm=AWS4-HMAC-SHA256&X-Amz-Credential=AKIAIWNJYAX4CSVEH53A%2F20210922%2Fus-east-1%2Fs3%2Faws4_request&X-Amz-Date=20210922T213549Z&X-Amz-Expires=300&X-Amz-Signature=a1bf1179c307aec58a1a09acea1676ab9f92b2f004fd1575cd426d1bed06942d&X-Amz-SignedHeaders=host&actor_id=0&key_id=0&repo_id=292388086&response-content-disposition=attachment%3B%20filename%3Dterraform-provider-iterative_0.7.3_SHA256SUMS&response-content-type=application%2Foctet-stream
2021-09-22T21:35:49.396Z [DEBUG] GET https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_SHA256SUMS.sig
2021-09-22T21:35:49.396Z [TRACE] HTTP client GET request to https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_SHA256SUMS.sig
2021-09-22T21:35:49.550Z [TRACE] HTTP client GET request to https://releases.521000.best/292388086/e4d68c54-251a-4d3b-a346-ab0b697ac998?X-Amz-Algorithm=AWS4-HMAC-SHA256&X-Amz-Credential=AKIAIWNJYAX4CSVEH53A%2F20210922%2Fus-east-1%2Fs3%2Faws4_request&X-Amz-Date=20210922T213549Z&X-Amz-Expires=300&X-Amz-Signature=62f775a0246d6925aff48946294a847b18b82bed61a2c1f67738a6c1daa104ce&X-Amz-SignedHeaders=host&actor_id=0&key_id=0&repo_id=292388086&response-content-disposition=attachment%3B%20filename%3Dterraform-provider-iterative_0.7.3_SHA256SUMS.sig&response-content-type=application%2Foctet-stream
2021-09-22T21:35:49.637Z [TRACE] providercache.Dir.InstallPackage: installing registry.terraform.io/iterative/iterative v0.7.3 from https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_linux_amd64.zip
2021-09-22T21:35:49.637Z [TRACE] HTTP client GET request to https://github.com/iterative/terraform-provider-iterative/releases/download/v0.7.3/terraform-provider-iterative_0.7.3_linux_amd64.zip
2021-09-22T21:35:49.832Z [TRACE] HTTP client GET request to https://releases.521000.best/292388086/22ffa97f-357c-44f9-9089-0cd0284ba7ad?X-Amz-Algorithm=AWS4-HMAC-SHA256&X-Amz-Credential=AKIAIWNJYAX4CSVEH53A%2F20210922%2Fus-east-1%2Fs3%2Faws4_request&X-Amz-Date=20210922T213549Z&X-Amz-Expires=300&X-Amz-Signature=5c9c859e8bb9c42d8fb6d8593ca75fe6b97cf814f2c831dc38c9bd90d27ca60e&X-Amz-SignedHeaders=host&actor_id=0&key_id=0&repo_id=292388086&response-content-disposition=attachment%3B%20filename%3Dterraform-provider-iterative_0.7.3_linux_amd64.zip&response-content-type=application%2Foctet-stream
2021-09-22T21:35:50.291Z [DEBUG] Provider signed by 910A9EF2910B1E37 Iterative (Terraform provider key) <eng@iterative.ai>
2021-09-22T21:35:50.775Z [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2021-09-22T21:35:50.775Z [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/iterative/iterative v0.7.3 for linux_amd64 at .terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64
2021-09-22T21:35:50.775Z [TRACE] providercache.fillMetaCache: including .terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64 as a candidate package for registry.terraform.io/iterative/iterative 0.7.3
2021-09-22T21:35:51.021Z [DEBUG] Adding temp file log sink: /tmp/terraform-log867697031
2021-09-22T21:35:51.022Z [INFO]  Terraform version: 1.0.6
2021-09-22T21:35:51.022Z [INFO]  Go runtime version: go1.16.4
2021-09-22T21:35:51.023Z [INFO]  CLI args: []string***"/usr/local/bin/terraform", "-chdir=/home/runner/.cml/cml-xv2hfhmygd", "apply", "-auto-approve"***
2021-09-22T21:35:51.023Z [TRACE] Stdout is not a terminal
2021-09-22T21:35:51.023Z [TRACE] Stderr is not a terminal
2021-09-22T21:35:51.024Z [TRACE] Stdin is not a terminal
2021-09-22T21:35:51.024Z [DEBUG] Attempting to open CLI config file: /home/runner/.terraformrc
2021-09-22T21:35:51.024Z [DEBUG] File doesn't exist, but doesn't need to. Ignoring.
2021-09-22T21:35:51.025Z [DEBUG] ignoring non-existing provider search directory terraform.d/plugins
2021-09-22T21:35:51.025Z [DEBUG] ignoring non-existing provider search directory /home/runner/.terraform.d/plugins
2021-09-22T21:35:51.025Z [DEBUG] ignoring non-existing provider search directory /home/runner/.local/share/terraform/plugins
2021-09-22T21:35:51.025Z [DEBUG] ignoring non-existing provider search directory /usr/local/share/terraform/plugins
2021-09-22T21:35:51.025Z [DEBUG] ignoring non-existing provider search directory /usr/share/terraform/plugins
2021-09-22T21:35:51.025Z [INFO]  CLI command args: []string***"apply", "-auto-approve"***
2021-09-22T21:35:51.027Z [TRACE] Meta.Backend: no config given or present on disk, so returning nil config
2021-09-22T21:35:51.027Z [TRACE] Meta.Backend: backend has not previously been initialized in this working directory
2021-09-22T21:35:51.027Z [DEBUG] New state was assigned lineage "ccc22c7a-41db-cc6e-6e51-b22a80c14dbf"
2021-09-22T21:35:51.027Z [TRACE] Meta.Backend: using default local state only (no backend configuration, and no existing initialized backend)
2021-09-22T21:35:51.027Z [TRACE] Meta.Backend: instantiated backend of type <nil>
2021-09-22T21:35:51.027Z [TRACE] providercache.fillMetaCache: scanning directory .terraform/providers
2021-09-22T21:35:51.028Z [TRACE] getproviders.SearchLocalDirectory: found registry.terraform.io/iterative/iterative v0.7.3 for linux_amd64 at .terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64
2021-09-22T21:35:51.028Z [TRACE] providercache.fillMetaCache: including .terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64 as a candidate package for registry.terraform.io/iterative/iterative 0.7.3
2021-09-22T21:35:51.200Z [DEBUG] checking for provisioner in "."
2021-09-22T21:35:51.201Z [DEBUG] checking for provisioner in "/usr/local/bin"
2021-09-22T21:35:51.201Z [INFO]  Failed to read plugin lock file .terraform/plugins/linux_amd64/lock.json: open .terraform/plugins/linux_amd64/lock.json: no such file or directory
2021-09-22T21:35:51.201Z [TRACE] Meta.Backend: backend <nil> does not support operations, so wrapping it in a local backend
2021-09-22T21:35:51.201Z [INFO]  backend/local: starting Apply operation
2021-09-22T21:35:51.202Z [TRACE] backend/local: requesting state manager for workspace "default"
2021-09-22T21:35:51.202Z [TRACE] backend/local: state manager for workspace "default" will:
 - read initial snapshot from terraform.tfstate
 - write new snapshots to terraform.tfstate
 - create any backup at terraform.tfstate.backup
2021-09-22T21:35:51.202Z [TRACE] backend/local: requesting state lock for workspace "default"
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: preparing to manage state snapshots at terraform.tfstate
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: no previously-stored snapshot exists
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: locking terraform.tfstate using fcntl flock
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: writing lock metadata to .terraform.tfstate.lock.info
2021-09-22T21:35:51.202Z [TRACE] backend/local: reading remote state for workspace "default"
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2021-09-22T21:35:51.202Z [TRACE] statemgr.Filesystem: read nil snapshot
2021-09-22T21:35:51.202Z [TRACE] backend/local: retrieving local state snapshot for workspace "default"
2021-09-22T21:35:51.202Z [TRACE] backend/local: building context for current working directory
2021-09-22T21:35:51.202Z [TRACE] terraform.NewContext: starting
2021-09-22T21:35:51.231Z [TRACE] terraform.NewContext: loading provider schemas
2021-09-22T21:35:51.300Z [TRACE] LoadSchemas: retrieving schema for provider type "registry.terraform.io/iterative/iterative"
2021-09-22T21:35:51.301Z [DEBUG] created provider logger: level=trace
2021-09-22T21:35:51.301Z [INFO]  provider: configuring client automatic mTLS
2021-09-22T21:35:51.358Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 args=[.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3]
2021-09-22T21:35:51.358Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2470
2021-09-22T21:35:51.364Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3
2021-09-22T21:35:51.385Z [INFO]  provider.terraform-provider-iterative_v0.7.3: configuring server automatic mTLS: timestamp=2021-09-22T21:35:51.385Z
2021-09-22T21:35:51.446Z [DEBUG] provider: using plugin: version=5
2021-09-22T21:35:51.446Z [DEBUG] provider.terraform-provider-iterative_v0.7.3: plugin address: address=/tmp/plugin480542569 network=unix timestamp=2021-09-22T21:35:51.445Z
2021-09-22T21:35:51.561Z [TRACE] GRPCProvider: GetProviderSchema
2021-09-22T21:35:51.561Z [TRACE] provider.stdio: waiting for stdio data
2021-09-22T21:35:51.575Z [TRACE] GRPCProvider: Close
2021-09-22T21:35:51.576Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2021-09-22T21:35:51.578Z [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2470
2021-09-22T21:35:51.578Z [DEBUG] provider: plugin exited
2021-09-22T21:35:51.578Z [TRACE] terraform.NewContext: complete
2021-09-22T21:35:51.578Z [TRACE] backend/local: finished building terraform.Context
2021-09-22T21:35:51.578Z [TRACE] backend/local: requesting interactive input, if necessary
2021-09-22T21:35:51.578Z [TRACE] Context.Input: Prompting for provider arguments
2021-09-22T21:35:51.578Z [TRACE] Context.Input: Provider provider.iterative declared at main.tf:11,1-21
2021-09-22T21:35:51.578Z [TRACE] Context.Input: Input for provider.iterative: map[string]cty.Value***
2021-09-22T21:35:51.578Z [TRACE] backend/local: running validation operation
2021-09-22T21:35:51.587Z [INFO]  terraform: building graph: GraphTypeValidate
2021-09-22T21:35:51.588Z [TRACE] Executing graph transform *terraform.ConfigTransformer
2021-09-22T21:35:51.588Z [TRACE] ConfigTransformer: Starting for path:
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
  ------
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.RootVariableTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.LocalTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.OutputTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.StateTransformer
2021-09-22T21:35:51.594Z [TRACE] StateTransformer: state is empty, so nothing to do
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2021-09-22T21:35:51.594Z [TRACE] AttachResourceConfigTransformer: attaching to "iterative_cml_runner.runner" (*terraform.NodeValidatableResource) config from main.tf:14,1-41
2021-09-22T21:35:51.594Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to iterative_cml_runner.runner
2021-09-22T21:35:51.594Z [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2021-09-22T21:35:51.594Z [TRACE] Executing graph transform *terraform.graphTransformerMulti
2021-09-22T21:35:51.594Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2021-09-22T21:35:51.601Z [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/iterative/iterative\"]" provider configuration from main.tf:11,1-21
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2021-09-22T21:35:51.602Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/iterative/iterative"] serving iterative_cml_runner.runner
2021-09-22T21:35:51.602Z [DEBUG] ProviderTransformer: "iterative_cml_runner.runner" (*terraform.NodeValidatableResource) needs provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2021-09-22T21:35:51.602Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2021-09-22T21:35:51.602Z [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.602Z [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2021-09-22T21:35:51.602Z [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2021-09-22T21:35:51.602Z [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2021-09-22T21:35:51.602Z [TRACE] AttachSchemaTransformer: attaching resource schema to iterative_cml_runner.runner
2021-09-22T21:35:51.602Z [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:51.602Z [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2021-09-22T21:35:51.602Z [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2021-09-22T21:35:51.602Z [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2021-09-22T21:35:51.602Z [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-09-22T21:35:51.602Z [DEBUG] ReferenceTransformer: "iterative_cml_runner.runner" references: []
2021-09-22T21:35:51.602Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/iterative/iterative\"]" references: []
2021-09-22T21:35:51.602Z [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.attachDataResourceDependsOnTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.attachDataResourceDependsOnTransformer (no changes)
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:51.603Z [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2021-09-22T21:35:51.603Z [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeValidatableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeValidatableResource
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:51.603Z [DEBUG] Starting graph walk: walkValidate
2021-09-22T21:35:51.603Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": starting visit (*terraform.NodeApplyableProvider)
2021-09-22T21:35:51.604Z [DEBUG] created provider logger: level=trace
2021-09-22T21:35:51.604Z [INFO]  provider: configuring client automatic mTLS
2021-09-22T21:35:51.665Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 args=[.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3]
2021-09-22T21:35:51.666Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2477
2021-09-22T21:35:51.667Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3
2021-09-22T21:35:51.690Z [INFO]  provider.terraform-provider-iterative_v0.7.3: configuring server automatic mTLS: timestamp=2021-09-22T21:35:51.689Z
2021-09-22T21:35:51.742Z [DEBUG] provider.terraform-provider-iterative_v0.7.3: plugin address: address=/tmp/plugin755807092 network=unix timestamp=2021-09-22T21:35:51.742Z
2021-09-22T21:35:51.742Z [DEBUG] provider: using plugin: version=5
2021-09-22T21:35:51.816Z [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/iterative/iterative\"]" provider for provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:51.816Z [TRACE] buildProviderConfig for provider["registry.terraform.io/iterative/iterative"]: using explicit config only
2021-09-22T21:35:51.816Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": visit complete
2021-09-22T21:35:51.817Z [TRACE] vertex "iterative_cml_runner.runner": starting visit (*terraform.NodeValidatableResource)
2021-09-22T21:35:51.817Z [TRACE] GRPCProvider: ValidateResourceConfig
2021-09-22T21:35:51.817Z [TRACE] GRPCProvider: GetProviderSchema
2021-09-22T21:35:51.817Z [TRACE] provider.stdio: waiting for stdio data
2021-09-22T21:35:51.821Z [TRACE] vertex "iterative_cml_runner.runner": visit complete
2021-09-22T21:35:51.821Z [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2021-09-22T21:35:51.821Z [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2021-09-22T21:35:51.821Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2021-09-22T21:35:51.821Z [TRACE] GRPCProvider: Close
2021-09-22T21:35:51.822Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2021-09-22T21:35:51.824Z [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2477
2021-09-22T21:35:51.824Z [DEBUG] provider: plugin exited
2021-09-22T21:35:51.824Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"] (close)": visit complete
2021-09-22T21:35:51.824Z [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2021-09-22T21:35:51.825Z [TRACE] vertex "root": visit complete
2021-09-22T21:35:51.825Z [INFO]  backend/local: apply calling Plan
2021-09-22T21:35:51.825Z [INFO]  terraform: building graph: GraphTypePlan
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.ConfigTransformer
2021-09-22T21:35:51.825Z [TRACE] ConfigTransformer: Starting for path:
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
  ------
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.RootVariableTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.LocalTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.OutputTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.OrphanResourceInstanceTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.OrphanResourceInstanceTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.StateTransformer
2021-09-22T21:35:51.825Z [TRACE] StateTransformer: state is empty, so nothing to do
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.StateTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2021-09-22T21:35:51.825Z [TRACE] AttachResourceConfigTransformer: attaching to "iterative_cml_runner.runner (expand)" (*terraform.nodeExpandPlannableResource) config from main.tf:14,1-41
2021-09-22T21:35:51.825Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to iterative_cml_runner.runner (expand)
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.graphTransformerMulti
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2021-09-22T21:35:51.825Z [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/iterative/iterative\"]" provider configuration from main.tf:11,1-21
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2021-09-22T21:35:51.825Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/iterative/iterative"] serving iterative_cml_runner.runner (expand)
2021-09-22T21:35:51.825Z [DEBUG] ProviderTransformer: "iterative_cml_runner.runner (expand)" (*terraform.nodeExpandPlannableResource) needs provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2021-09-22T21:35:51.825Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2021-09-22T21:35:51.825Z [TRACE] AttachSchemaTransformer: attaching resource schema to iterative_cml_runner.runner (expand)
2021-09-22T21:35:51.825Z [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-09-22T21:35:51.825Z [DEBUG] ReferenceTransformer: "iterative_cml_runner.runner (expand)" references: []
2021-09-22T21:35:51.825Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/iterative/iterative\"]" references: []
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2021-09-22T21:35:51.825Z [TRACE] AttachDependenciesTransformer: iterative_cml_runner.runner depends on []
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.attachDataResourceDependsOnTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.attachDataResourceDependsOnTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-09-22T21:35:51.825Z [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-09-22T21:35:51.825Z [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2021-09-22T21:35:51.825Z [TRACE] ForcedCBDTransformer: "iterative_cml_runner.runner (expand)" (*terraform.nodeExpandPlannableResource) has no CBD descendent, so skipping
2021-09-22T21:35:51.826Z [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2021-09-22T21:35:51.826Z [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2021-09-22T21:35:51.826Z [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.826Z [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2021-09-22T21:35:51.826Z [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:51.826Z [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2021-09-22T21:35:51.826Z [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:51.826Z [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2021-09-22T21:35:51.826Z [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandPlannableResource
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:51.826Z [DEBUG] Starting graph walk: walkPlan
2021-09-22T21:35:51.826Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": starting visit (*terraform.NodeApplyableProvider)
2021-09-22T21:35:51.826Z [DEBUG] created provider logger: level=trace
2021-09-22T21:35:51.826Z [INFO]  provider: configuring client automatic mTLS
2021-09-22T21:35:51.897Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 args=[.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3]
2021-09-22T21:35:51.898Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2484
2021-09-22T21:35:51.898Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3
2021-09-22T21:35:51.923Z [INFO]  provider.terraform-provider-iterative_v0.7.3: configuring server automatic mTLS: timestamp=2021-09-22T21:35:51.923Z
2021-09-22T21:35:51.985Z [DEBUG] provider.terraform-provider-iterative_v0.7.3: plugin address: address=/tmp/plugin574024968 network=unix timestamp=2021-09-22T21:35:51.985Z
2021-09-22T21:35:51.985Z [DEBUG] provider: using plugin: version=5
2021-09-22T21:35:52.050Z [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/iterative/iterative\"]" provider for provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:52.050Z [TRACE] buildProviderConfig for provider["registry.terraform.io/iterative/iterative"]: using explicit config only
2021-09-22T21:35:52.050Z [TRACE] GRPCProvider: GetProviderSchema
2021-09-22T21:35:52.050Z [TRACE] provider.stdio: waiting for stdio data
2021-09-22T21:35:52.056Z [TRACE] GRPCProvider: ValidateProviderConfig
2021-09-22T21:35:52.057Z [TRACE] GRPCProvider: ConfigureProvider
2021-09-22T21:35:52.058Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": visit complete
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner (expand)": starting visit (*terraform.nodeExpandPlannableResource)
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner (expand)": expanding dynamic subgraph
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner (expand)": entering dynamic subgraph
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner": starting visit (*terraform.NodePlannableResource)
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner": expanding dynamic subgraph
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.ResourceCountTransformer
2021-09-22T21:35:52.058Z [TRACE] ResourceCountTransformer: adding iterative_cml_runner.runner as *terraform.NodePlannableResourceInstance
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.ResourceCountTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodePlannableResourceInstance
  ------
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.OrphanResourceInstanceCountTransformer
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.OrphanResourceInstanceCountTransformer (no changes)
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-09-22T21:35:52.058Z [DEBUG] Resource instance state not found for node "iterative_cml_runner.runner", instance iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-09-22T21:35:52.058Z [DEBUG] ReferenceTransformer: "iterative_cml_runner.runner" references: []
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-09-22T21:35:52.058Z [TRACE] Executing graph transform *terraform.RootTransformer
2021-09-22T21:35:52.058Z [TRACE] Completed graph transform *terraform.RootTransformer (no changes)
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner": entering dynamic subgraph
2021-09-22T21:35:52.058Z [TRACE] vertex "iterative_cml_runner.runner": starting visit (*terraform.NodePlannableResourceInstance)
2021-09-22T21:35:52.058Z [TRACE] readResourceInstanceState: reading state for iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] readResourceInstanceState: no state present for iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to prevRunState for iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: removing state object for iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to refreshState for iterative_cml_runner.runner
2021-09-22T21:35:52.058Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: removing state object for iterative_cml_runner.runner
2021-09-22T21:35:52.077Z [TRACE] NodeAbstractResourceInstance.refresh for iterative_cml_runner.runner
2021-09-22T21:35:52.077Z [DEBUG] refresh: iterative_cml_runner.runner: no state, so not refreshing
2021-09-22T21:35:52.077Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to refreshState for iterative_cml_runner.runner
2021-09-22T21:35:52.077Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: removing state object for iterative_cml_runner.runner
2021-09-22T21:35:52.078Z [TRACE] Re-validating config for "iterative_cml_runner.runner"
2021-09-22T21:35:52.078Z [TRACE] GRPCProvider: ValidateResourceConfig
2021-09-22T21:35:52.079Z [TRACE] GRPCProvider: PlanResourceChange
2021-09-22T21:35:52.081Z [WARN]  Provider "registry.terraform.io/iterative/iterative" produced an invalid plan for iterative_cml_runner.runner, but we are tolerating it because it is using the legacy plugin SDK.
    The following problems may be the cause of any confusing errors from downstream operations:
      - .spot: planned value cty.False for a non-computed attribute
2021-09-22T21:35:52.081Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for iterative_cml_runner.runner
2021-09-22T21:35:52.081Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for iterative_cml_runner.runner
2021-09-22T21:35:52.081Z [TRACE] writeChange: recorded Create change for iterative_cml_runner.runner
2021-09-22T21:35:52.081Z [TRACE] vertex "iterative_cml_runner.runner": visit complete
2021-09-22T21:35:52.081Z [TRACE] vertex "iterative_cml_runner.runner": dynamic subgraph completed successfully
2021-09-22T21:35:52.081Z [TRACE] vertex "iterative_cml_runner.runner": visit complete
2021-09-22T21:35:52.081Z [TRACE] vertex "iterative_cml_runner.runner (expand)": dynamic subgraph completed successfully
2021-09-22T21:35:52.081Z [TRACE] vertex "iterative_cml_runner.runner (expand)": visit complete
2021-09-22T21:35:52.081Z [TRACE] vertex "meta.count-boundary (EachMode fixup)": starting visit (*terraform.NodeCountBoundary)
2021-09-22T21:35:52.081Z [TRACE] vertex "meta.count-boundary (EachMode fixup)": visit complete
2021-09-22T21:35:52.081Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"] (close)": starting visit (*terraform.graphNodeCloseProvider)
2021-09-22T21:35:52.081Z [TRACE] GRPCProvider: Close
2021-09-22T21:35:52.082Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2021-09-22T21:35:52.083Z [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2484
2021-09-22T21:35:52.083Z [DEBUG] provider: plugin exited
2021-09-22T21:35:52.083Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"] (close)": visit complete
2021-09-22T21:35:52.083Z [TRACE] vertex "root": starting visit (*terraform.nodeCloseModule)
2021-09-22T21:35:52.083Z [TRACE] vertex "root": visit complete
2021-09-22T21:35:52.085Z [INFO]  backend/local: apply calling Apply
2021-09-22T21:35:52.085Z [INFO]  terraform: building graph: GraphTypeApply
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.ConfigTransformer
2021-09-22T21:35:52.085Z [TRACE] ConfigTransformer: Starting for path:
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.ConfigTransformer with new graph:
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  ------
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.RootVariableTransformer
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.RootVariableTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.ModuleVariableTransformer
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.ModuleVariableTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.LocalTransformer
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.LocalTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.OutputTransformer
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.OutputTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.DiffTransformer
2021-09-22T21:35:52.085Z [TRACE] DiffTransformer starting
2021-09-22T21:35:52.085Z [TRACE] DiffTransformer: found Create change for iterative_cml_runner.runner
2021-09-22T21:35:52.085Z [TRACE] DiffTransformer: iterative_cml_runner.runner will be represented by iterative_cml_runner.runner
2021-09-22T21:35:52.085Z [TRACE] DiffTransformer complete
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.DiffTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  ------
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.AttachStateTransformer
2021-09-22T21:35:52.085Z [DEBUG] Resource state not found for node "iterative_cml_runner.runner", instance iterative_cml_runner.runner
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.AttachStateTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.OrphanOutputTransformer
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.OrphanOutputTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.AttachResourceConfigTransformer
2021-09-22T21:35:52.085Z [TRACE] AttachResourceConfigTransformer: attaching to "iterative_cml_runner.runner" (*terraform.NodeApplyableResourceInstance) config from main.tf:14,1-41
2021-09-22T21:35:52.085Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to iterative_cml_runner.runner
2021-09-22T21:35:52.085Z [TRACE] AttachResourceConfigTransformer: attaching to "iterative_cml_runner.runner (expand)" (*terraform.nodeExpandApplyableResource) config from main.tf:14,1-41
2021-09-22T21:35:52.085Z [TRACE] AttachResourceConfigTransformer: attaching provider meta configs to iterative_cml_runner.runner (expand)
2021-09-22T21:35:52.085Z [TRACE] Completed graph transform *terraform.AttachResourceConfigTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] Executing graph transform *terraform.graphTransformerMulti
2021-09-22T21:35:52.085Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderConfigTransformer
2021-09-22T21:35:52.085Z [TRACE] ProviderConfigTransformer: attaching to "provider[\"registry.terraform.io/iterative/iterative\"]" provider configuration from main.tf:11,1-21
2021-09-22T21:35:52.085Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderConfigTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:52.085Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.MissingProviderTransformer
2021-09-22T21:35:52.085Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.MissingProviderTransformer (no changes)
2021-09-22T21:35:52.085Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.ProviderTransformer
2021-09-22T21:35:52.085Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/iterative/iterative"] serving iterative_cml_runner.runner
2021-09-22T21:35:52.086Z [DEBUG] ProviderTransformer: "iterative_cml_runner.runner" (*terraform.NodeApplyableResourceInstance) needs provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:52.086Z [TRACE] ProviderTransformer: exact match for provider["registry.terraform.io/iterative/iterative"] serving iterative_cml_runner.runner (expand)
2021-09-22T21:35:52.086Z [DEBUG] ProviderTransformer: "iterative_cml_runner.runner (expand)" (*terraform.nodeExpandApplyableResource) needs provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:52.086Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.ProviderTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:52.086Z [TRACE] (graphTransformerMulti) Executing graph transform *terraform.PruneProviderTransformer
2021-09-22T21:35:52.086Z [TRACE] (graphTransformerMulti) Completed graph transform *terraform.PruneProviderTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.graphTransformerMulti with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.RemovedModuleTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.RemovedModuleTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.AttachSchemaTransformer
2021-09-22T21:35:52.086Z [TRACE] AttachSchemaTransformer: attaching resource schema to iterative_cml_runner.runner (expand)
2021-09-22T21:35:52.086Z [TRACE] AttachSchemaTransformer: attaching resource schema to iterative_cml_runner.runner
2021-09-22T21:35:52.086Z [TRACE] AttachSchemaTransformer: attaching provider config schema to provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.AttachSchemaTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.ModuleExpansionTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.ModuleExpansionTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.ReferenceTransformer
2021-09-22T21:35:52.086Z [DEBUG] ReferenceTransformer: "iterative_cml_runner.runner (expand)" references: []
2021-09-22T21:35:52.086Z [DEBUG] ReferenceTransformer: "iterative_cml_runner.runner" references: []
2021-09-22T21:35:52.086Z [DEBUG] ReferenceTransformer: "provider[\"registry.terraform.io/iterative/iterative\"]" references: []
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.ReferenceTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.AttachDependenciesTransformer
2021-09-22T21:35:52.086Z [TRACE] AttachDependenciesTransformer: iterative_cml_runner.runner depends on []
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.AttachDependenciesTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.ForcedCBDTransformer
2021-09-22T21:35:52.086Z [TRACE] ForcedCBDTransformer: "iterative_cml_runner.runner" (*terraform.NodeApplyableResourceInstance) has no CBD descendent, so skipping
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.ForcedCBDTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.DestroyEdgeTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.DestroyEdgeTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.CBDEdgeTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.CBDEdgeTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.pruneUnusedNodesTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.pruneUnusedNodesTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.TargetsTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.TargetsTransformer (no changes)
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.CountBoundaryTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.CountBoundaryTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.CloseProviderTransformer
2021-09-22T21:35:52.086Z [TRACE] Completed graph transform *terraform.CloseProviderTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  ------
2021-09-22T21:35:52.086Z [TRACE] Executing graph transform *terraform.CloseRootModuleTransformer
2021-09-22T21:35:52.087Z [TRACE] Completed graph transform *terraform.CloseRootModuleTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:52.087Z [TRACE] Executing graph transform *terraform.TransitiveReductionTransformer
2021-09-22T21:35:52.087Z [TRACE] Completed graph transform *terraform.TransitiveReductionTransformer with new graph:
  iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
    iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
  iterative_cml_runner.runner (expand) - *terraform.nodeExpandApplyableResource
    provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
  provider["registry.terraform.io/iterative/iterative"] - *terraform.NodeApplyableProvider
  provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
    iterative_cml_runner.runner - *terraform.NodeApplyableResourceInstance
  root - *terraform.nodeCloseModule
    meta.count-boundary (EachMode fixup) - *terraform.NodeCountBoundary
    provider["registry.terraform.io/iterative/iterative"] (close) - *terraform.graphNodeCloseProvider
  ------
2021-09-22T21:35:52.087Z [DEBUG] Starting graph walk: walkApply
2021-09-22T21:35:52.087Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": starting visit (*terraform.NodeApplyableProvider)
2021-09-22T21:35:52.087Z [DEBUG] created provider logger: level=trace
2021-09-22T21:35:52.087Z [INFO]  provider: configuring client automatic mTLS
2021-09-22T21:35:52.145Z [DEBUG] provider: starting plugin: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 args=[.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3]
2021-09-22T21:35:52.146Z [DEBUG] provider: plugin started: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2491
2021-09-22T21:35:52.146Z [DEBUG] provider: waiting for RPC address: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3
2021-09-22T21:35:52.171Z [INFO]  provider.terraform-provider-iterative_v0.7.3: configuring server automatic mTLS: timestamp=2021-09-22T21:35:52.170Z
2021-09-22T21:35:52.233Z [DEBUG] provider: using plugin: version=5
2021-09-22T21:35:52.233Z [DEBUG] provider.terraform-provider-iterative_v0.7.3: plugin address: address=/tmp/plugin929307216 network=unix timestamp=2021-09-22T21:35:52.233Z
2021-09-22T21:35:52.303Z [TRACE] BuiltinEvalContext: Initialized "provider[\"registry.terraform.io/iterative/iterative\"]" provider for provider["registry.terraform.io/iterative/iterative"]
2021-09-22T21:35:52.304Z [TRACE] buildProviderConfig for provider["registry.terraform.io/iterative/iterative"]: using explicit config only
2021-09-22T21:35:52.303Z [TRACE] provider.stdio: waiting for stdio data
2021-09-22T21:35:52.304Z [TRACE] GRPCProvider: GetProviderSchema
2021-09-22T21:35:52.306Z [TRACE] GRPCProvider: ValidateProviderConfig
2021-09-22T21:35:52.307Z [TRACE] GRPCProvider: ConfigureProvider
2021-09-22T21:35:52.308Z [TRACE] vertex "provider[\"registry.terraform.io/iterative/iterative\"]": visit complete
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner (expand)": starting visit (*terraform.nodeExpandApplyableResource)
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner (expand)": expanding dynamic subgraph
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner (expand)": entering dynamic subgraph
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner": starting visit (*terraform.NodeApplyableResource)
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner": visit complete
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner (expand)": dynamic subgraph completed successfully
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner (expand)": visit complete
2021-09-22T21:35:52.308Z [TRACE] vertex "iterative_cml_runner.runner": starting visit (*terraform.NodeApplyableResourceInstance)
2021-09-22T21:35:52.308Z [TRACE] readDiff: Read Create change from plan for iterative_cml_runner.runner
2021-09-22T21:35:52.308Z [TRACE] readResourceInstanceState: reading state for iterative_cml_runner.runner
2021-09-22T21:35:52.308Z [TRACE] readResourceInstanceState: no state present for iterative_cml_runner.runner
2021-09-22T21:35:52.308Z [TRACE] readDiff: Read Create change from plan for iterative_cml_runner.runner
2021-09-22T21:35:52.308Z [TRACE] Re-validating config for "iterative_cml_runner.runner"
2021-09-22T21:35:52.308Z [TRACE] GRPCProvider: ValidateResourceConfig
2021-09-22T21:35:52.310Z [TRACE] GRPCProvider: PlanResourceChange
2021-09-22T21:35:52.312Z [WARN]  Provider "registry.terraform.io/iterative/iterative" produced an invalid plan for iterative_cml_runner.runner, but we are tolerating it because it is using the legacy plugin SDK.
    The following problems may be the cause of any confusing errors from downstream operations:
      - .spot: planned value cty.False for a non-computed attribute
2021-09-22T21:35:52.312Z [TRACE] checkPlannedChange: Verifying that actual change (action Create) matches planned change (action Create)
2021-09-22T21:35:52.312Z [TRACE] readResourceInstanceState: reading state for iterative_cml_runner.runner
2021-09-22T21:35:52.312Z [TRACE] readResourceInstanceState: no state present for iterative_cml_runner.runner
2021-09-22T21:35:52.312Z [INFO]  Starting apply for iterative_cml_runner.runner
2021-09-22T21:35:52.313Z [DEBUG] iterative_cml_runner.runner: applying the planned Create change
2021-09-22T21:35:52.313Z [TRACE] GRPCProvider: ApplyResourceChange
2021-09-22T21:35:54.518Z [TRACE] maybeTainted: iterative_cml_runner.runner encountered an error during creation, so it is now marked as tainted
2021-09-22T21:35:54.518Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for iterative_cml_runner.runner
2021-09-22T21:35:54.518Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for iterative_cml_runner.runner
2021-09-22T21:35:54.518Z [TRACE] evalApplyProvisioners: iterative_cml_runner.runner is tainted, so skipping provisioning
2021-09-22T21:35:54.519Z [TRACE] maybeTainted: iterative_cml_runner.runner was already tainted, so nothing to do
2021-09-22T21:35:54.519Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState to workingState for iterative_cml_runner.runner
2021-09-22T21:35:54.519Z [TRACE] NodeAbstractResouceInstance.writeResourceInstanceState: writing state object for iterative_cml_runner.runner
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: snapshot file has nil snapshot, but that's okay
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: read nil snapshot
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: no original state snapshot to back up
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: state has changed since last snapshot, so incrementing serial to 1
2021-09-22T21:35:54.519Z [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2021-09-22T21:35:54.529Z [TRACE] vertex "iterative_cml_runner.runner": visit complete
2021-09-22T21:35:54.529Z [TRACE] dag/walk: upstream of "meta.count-boundary (EachMode fixup)" errored, so skipping
2021-09-22T21:35:54.529Z [TRACE] dag/walk: upstream of "provider[\"registry.terraform.io/iterative/iterative\"] (close)" errored, so skipping
2021-09-22T21:35:54.529Z [TRACE] dag/walk: upstream of "root" errored, so skipping
2021-09-22T21:35:54.529Z [TRACE] statemgr.Filesystem: reading latest snapshot from terraform.tfstate
2021-09-22T21:35:54.530Z [TRACE] statemgr.Filesystem: read snapshot with lineage "397eeb8c-729d-3a7a-949b-e7589b64075a" serial 1
2021-09-22T21:35:54.530Z [TRACE] statemgr.Filesystem: no original state snapshot to back up
2021-09-22T21:35:54.530Z [TRACE] statemgr.Filesystem: no state changes since last snapshot
2021-09-22T21:35:54.530Z [TRACE] statemgr.Filesystem: writing snapshot at terraform.tfstate
2021-09-22T21:35:54.534Z [TRACE] statemgr.Filesystem: removing lock metadata file .terraform.tfstate.lock.info
2021-09-22T21:35:54.534Z [TRACE] statemgr.Filesystem: unlocking terraform.tfstate using fcntl flock
2021-09-22T21:35:54.535Z [DEBUG] provider.stdio: received EOF, stopping recv loop: err="rpc error: code = Unavailable desc = transport is closing"
2021-09-22T21:35:54.537Z [DEBUG] provider: plugin process exited: path=.terraform/providers/registry.terraform.io/iterative/iterative/0.7.3/linux_amd64/terraform-provider-iterative_v0.7.3 pid=2491
2021-09-22T21:35:54.537Z [DEBUG] provider: plugin exited
***"level":"error"***
***"level":"error","status":"terminated"***
##[debug]Re-evaluate condition on job cancellation for step: 'Deploy runner on GCP'.
Error: The operation was canceled.
##[debug]System.OperationCanceledException: The operation was canceled.
##[debug]   at System.Threading.CancellationToken.ThrowOperationCanceledException()
##[debug]   at GitHub.Runner.Sdk.ProcessInvoker.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, Channel`1 redirectStandardIn, Boolean inheritConsoleHandler, Boolean keepStandardInOpen, Boolean highPriorityProcess, CancellationToken cancellationToken)
##[debug]   at GitHub.Runner.Common.ProcessInvokerWrapper.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, Channel`1 redirectStandardIn, Boolean inheritConsoleHandler, Boolean keepStandardInOpen, Boolean highPriorityProcess, CancellationToken cancellationToken)
##[debug]   at GitHub.Runner.Worker.Handlers.DefaultStepHost.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, Boolean inheritConsoleHandler, CancellationToken cancellationToken)
##[debug]   at GitHub.Runner.Worker.Handlers.ScriptHandler.RunAsync(ActionRunStage stage)
##[debug]   at GitHub.Runner.Worker.ActionRunner.RunAsync()
##[debug]   at GitHub.Runner.Worker.StepsRunner.RunStepAsync(IStep step, CancellationToken jobCancellationToken)
##[debug]Finishing: Deploy runner on GCP

GCP activity:

dacbd/action.yml

Select an option

No results found

Select an option

No results found

dacbd commented Sep 22, 2021

Uh oh!

	deploy-runner:
	runs-on: ubuntu-latest
	steps:
	- uses: DanielBarnes/setup-cml@2970b7282efdade5a071a7be526162a4edcb149b
	- uses: actions/checkout@v2
	- name: Deploy runner on GCP # https://cml.dev/doc/self-hosted-runners#cloud-compute-resource-credentials
	env:
	GOOGLE_APPLICATION_CREDENTIALS_DATA: ${{ secrets.GCP_CML_RUNNER_KEY }}
	run: \|
	cml-runner \
	--log=debug \
	--single \
	--idle-timeout=1800 \
	--token=${{ secrets.PAT_DCB }} \
	--cloud=gcp \
	--cloud-region=us-west \
	--cloud-type=m \
	--cloud-gpu=nogpu \
	--cloud-hdd-size=10