Skip to content

Instantly share code, notes, and snippets.

@grahamhayes

grahamhayes/tf-apply-1.log

Last active July 12, 2017 15:59
Show Gist options
  • Save grahamhayes/02c6b5a80543de66fedfcd7993f3c056 to your computer and use it in GitHub Desktop.
Save grahamhayes/02c6b5a80543de66fedfcd7993f3c056 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
tf-apply-1.log
➜ terraform-test terraform apply
libvirt_volume.node: Creating...
base_volume_id: "" => "/var/lib/libvirt/images/opensuse-VAGRANTSLASH-openSUSE-42.1-x86_64_vagrant_box_image_1.0.0.img"
name: "" => "node.qcow2"
pool: "" => "default"
size: "" => "<computed>"
libvirt_cloudinit.node: Creating...
name: "" => "node_cloud_init.iso"
pool: "" => "default"
user_data: "" => "#cloud-config\n\n# set locale\nlocale: en_GB.UTF-8\n\n# set timezone\ntimezone: Etc/UTC\n\n# Set hostname and FQDN\nhostname: node\nfqdn: node.exmaple.com\n\n# set root password\nchpasswd:\n list: |\n root:linux\n expire: False\n\n# setup and enable ntp\nntp:\n servers:\n - ntp1.suse.de\n - ntp2.suse.de\n - ntp3.suse.de\n\nruncmd:\n - /usr/bin/systemctl enable --now ntpd"
libvirt_volume.node: Creation complete (ID: /var/lib/libvirt/images/node.qcow2)
libvirt_cloudinit.node: Creation complete (ID: /var/lib/libvirt/images/node_cloud_init.iso;59663410-71e5-7b7d-b409-047273349fd5)
libvirt_domain.node: Creating...
cloudinit: "" => "/var/lib/libvirt/images/node_cloud_init.iso;59663410-71e5-7b7d-b409-047273349fd5"
disk.#: "" => "1"
disk.0.%: "" => "1"
disk.0.volume_id: "" => "/var/lib/libvirt/images/node.qcow2"
graphics.%: "" => "2"
graphics.listen_type: "" => "address"
graphics.type: "" => "vnc"
memory: "" => "2048"
name: "" => "test_node"
network_interface.#: "" => "1"
network_interface.0.addresses.#: "" => "<computed>"
network_interface.0.hostname: "" => "node"
network_interface.0.mac: "" => "<computed>"
network_interface.0.network_id: "" => "9d1891f1-b68d-4753-a7d2-395229ac5151"
network_interface.0.network_name: "" => "<computed>"
network_interface.0.wait_for_lease: "" => "true"
running: "" => "true"
vcpu: "" => "2"
libvirt_domain.node: Still creating... (10s elapsed)
libvirt_domain.node: Still creating... (20s elapsed)
libvirt_domain.node: Still creating... (30s elapsed)
libvirt_domain.node: Creation complete (ID: 01d6489a-1648-4517-876d-4135def7617d)
Apply complete! Resources: 3 added, 0 changed, 0 destroyed.
The state of your infrastructure has been saved to the path
below. This state is required to modify and destroy your
infrastructure, so keep it safe. To inspect the complete state
use the `terraform show` command.
Raw
tf-apply-2-trace.log
➜ terraform-test TF_LOG=DEBUG terraform apply
2017/07/12 16:58:57 [INFO] Terraform version: 0.9.4
2017/07/12 16:58:57 [INFO] Go runtime version: go1.8.3
2017/07/12 16:58:57 [INFO] CLI args: []string{"/usr/bin/terraform", "apply"}
2017/07/12 16:58:57 [DEBUG] Detected home directory from env var: /root
2017/07/12 16:58:57 [DEBUG] Discovered plugin: libvirt = /usr/bin/terraform-provider-libvirt
2017/07/12 16:58:57 [DEBUG] Detected home directory from env var: /root
2017/07/12 16:58:57 [DEBUG] Attempting to open CLI config file: /root/.terraformrc
2017/07/12 16:58:57 [INFO] Local libvirt provider configuration '/home/graham/go/bin/terraform-provider-libvirt' overrides '/usr/bin/terraform-provider-libvirt'
2017/07/12 16:58:57 [INFO] CLI command args: []string{"apply"}
2017/07/12 16:58:57 [DEBUG] Detected home directory from env var: /root
2017/07/12 16:58:57 [DEBUG] command: loading backend config file: /home/graham/terraform-test
2017/07/12 16:58:57 [DEBUG] command: no data state file found for backend config
2017/07/12 16:58:57 [DEBUG] New state was assigned lineage "13efa209-f9fb-473f-8412-2b9a081dac0f"
2017/07/12 16:58:57 [INFO] command: backend initialized: <nil>
2017/07/12 16:58:57 [INFO] command: backend <nil> is not enhanced, wrapping in local
2017/07/12 16:58:57 [INFO] backend/local: starting Apply operation
2017/07/12 16:58:57 [INFO] terraform: building graph: GraphTypeInput
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9630), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4203f9680), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9540), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: [libvirt_cloudinit.node libvirt_volume.node]
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "provider.libvirt" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] Starting graph walk: walkInput
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_volume.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "provider.libvirt (close)" waiting on "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_volume.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "provider.libvirt (close)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_domain.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInitProvider
2017/07/12 16:58:57 [DEBUG] plugin: starting plugin: /home/graham/go/bin/terraform-provider-libvirt []string{"/home/graham/go/bin/terraform-provider-libvirt"}
2017/07/12 16:58:57 [DEBUG] plugin: waiting for RPC address for: /home/graham/go/bin/terraform-provider-libvirt
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] plugin: plugin address: unix /tmp/plugin993581336
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalBuildProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInputProvider
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [TRACE] [walkInput] Exiting eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCloseProvider
2017/07/12 16:58:57 [INFO] terraform: building graph: GraphTypeValidate
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4203f9680), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9540), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9630), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: [libvirt_cloudinit.node libvirt_volume.node]
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "provider.libvirt" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] Starting graph walk: walkValidate
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_volume.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "provider.libvirt (close)" waiting on "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "provider.libvirt (close)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_volume.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_domain.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalBuildProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSetProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [TRACE] [walkValidate] Exiting eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': evaluating
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateCount
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateCount
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9630), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [TRACE] [walkValidate] Exiting eval tree: libvirt_volume.node
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResourceSelfRef
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4203f9540), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateCount
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4203f9680), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: []
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResourceSelfRef
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCloseProvider
2017/07/12 16:58:57 [INFO] backend/local: apply calling Refresh
2017/07/12 16:58:57 [INFO] terraform: building graph: GraphTypeRefresh
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4201bac80), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4201bacd0), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4201bad20), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: [libvirt_cloudinit.node libvirt_volume.node]
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "provider.libvirt" references: []
2017/07/12 16:58:57 [DEBUG] Starting graph walk: walkRefresh
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_volume.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "provider.libvirt (close)" waiting on "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_volume.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "provider.libvirt (close)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_domain.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInitProvider
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalBuildProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSetProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalConfigProvider
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [INFO] Created libvirt client
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': evaluating
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalRefresh
2017/07/12 16:58:57 [TRACE] [walkRefresh] Entering eval tree: libvirt_cloudinit.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalRefresh
libvirt_volume.node: Refreshing state... (ID: /var/lib/libvirt/images/node.qcow2)
libvirt_cloudinit.node: Refreshing state... (ID: /var/lib/libvirt/images/node_cloud_init.iso;596646ed-07c5-4dc6-ee80-701d8d469810)
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 374784 bytes downloaded
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO reader: processing file /meta_dat.
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO reader: processing file /user_dat.
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 Read cloud-init from file: {Name:node_cloud_init.iso PoolName:default Metadata:{LocalHostname: InstanceID:created-at-2017-07-12 16:57:33.600126152 +0100 BST} UserDataRaw: UserData:{SSHAuthorizedKeys:[]}}
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalRefresh
libvirt_domain.node: Refreshing state... (ID: 01d6489a-1648-4517-876d-4135def7617d)
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] Check if resource libvirt_domain exists
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] Read resource libvirt_domain
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] read: obtained XML desc for domain:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <domain type='kvm' id='204'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <name>test_node</name>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <uuid>01d6489a-1648-4517-876d-4135def7617d</uuid>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <metadata>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <user_data xmlns="http://github.com/dmacvicar/terraform-provider-libvirt/"/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </metadata>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <memory unit='KiB'>2097152</memory>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <currentMemory unit='KiB'>2097152</currentMemory>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <vcpu placement='static'>2</vcpu>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <resource>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <partition>/machine</partition>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </resource>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <os>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <type arch='x86_64' machine='pc-i440fx-2.6'>hvm</type>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <boot dev='hd'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </os>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <features>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <acpi/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <apic/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <pae/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </features>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <clock offset='utc'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <on_poweroff>destroy</on_poweroff>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <on_reboot>restart</on_reboot>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <on_crash>destroy</on_crash>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <devices>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <emulator>/usr/bin/qemu-kvm</emulator>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <disk type='file' device='disk'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <driver name='qemu' type='qcow2'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <source file='/var/lib/libvirt/images/node.qcow2'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <backingStore type='file' index='1'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <format type='qcow2'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <source file='/var/lib/libvirt/images/opensuse-VAGRANTSLASH-openSUSE-42.1-x86_64_vagrant_box_image_1.0.0.img'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <backingStore/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </backingStore>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <target dev='vda' bus='virtio'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='virtio-disk0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </disk>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <disk type='file' device='cdrom'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <driver name='qemu' type='raw'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <source file='/var/lib/libvirt/images/node_cloud_init.iso'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <backingStore/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <target dev='hda' bus='ide'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <readonly/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='ide0-0-0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='drive' controller='0' bus='0' target='0' unit='0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </disk>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <controller type='usb' index='0'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='usb'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x2'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </controller>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <controller type='pci' index='0' model='pci-root'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='pci.0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </controller>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <controller type='ide' index='0'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='ide'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </controller>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <controller type='virtio-serial' index='0'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='virtio-serial0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </controller>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <interface type='network'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <mac address='d2:63:ac:60:8a:6d'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <source network='vagrant-libvirt' bridge='virbr2'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <target dev='vnet8'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <model type='virtio'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='net0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </interface>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <channel type='unix'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <source mode='bind' path='/var/lib/libvirt/qemu/channel/target/domain-204-test_node/org.qemu.guest_agent.0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <target type='virtio' name='org.qemu.guest_agent.0' state='disconnected'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='channel0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='virtio-serial' controller='0' bus='0' port='1'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </channel>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <input type='mouse' bus='ps2'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='input0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </input>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <input type='keyboard' bus='ps2'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='input1'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </input>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <graphics type='vnc' port='5907' autoport='yes' listen='127.0.0.1'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <listen type='address' address='127.0.0.1'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </graphics>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <video>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <model type='cirrus' vram='16384' heads='1' primary='yes'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='video0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </video>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <memballoon model='virtio'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='balloon0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </memballoon>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <rng model='virtio'>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <backend model='random'>/dev/random</backend>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <alias name='rng0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </rng>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </devices>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: <seclabel type='none' model='none'/>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: </domain>
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] get network interfaces using qemu agent
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] fetching networking interfaces using libvirt API
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] Interfaces: ([]libvirt.DomainInterface) (len=1 cap=1) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (libvirt.DomainInterface) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Name: (string) (len=5) "vnet8",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Hwaddr: (string) (len=17) "d2:63:ac:60:8a:6d",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Addrs: ([]libvirt.DomainIPAddress) (len=1 cap=1) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (libvirt.DomainIPAddress) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Type: (int) 0,
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Addr: (string) (len=15) "192.168.121.234",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: Prefix: (uint) 24
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] read: addresses for 'D2:63:AC:60:8A:6D': [192.168.121.234]
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] read: ifaces for 'test_node':
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: ([]map[string]interface {}) (len=1 cap=1) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (map[string]interface {}) (len=10) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=9) "addresses": ([]string) (len=1 cap=1) {
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=15) "192.168.121.234"
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: },
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=10) "network_id": (string) (len=36) "9d1891f1-b68d-4753-a7d2-395229ac5151",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=11) "passthrough": (string) "",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=3) "mac": (string) (len=17) "D2:63:AC:60:8A:6D",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=14) "wait_for_lease": (bool) true,
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=8) "hostname": (string) "",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=12) "network_name": (string) (len=15) "vagrant-libvirt",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=6) "bridge": (string) "",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=4) "vepa": (string) "",
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: (string) (len=7) "macvtap": (string) ""
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: }
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt (close)': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCloseProvider
2017/07/12 16:58:57 [INFO] backend/local: apply calling Plan
2017/07/12 16:58:57 [INFO] terraform: building graph: GraphTypePlan
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4207b6690), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4207b6780), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4207b67d0), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: [libvirt_cloudinit.node libvirt_volume.node]
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "provider.libvirt" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] Starting graph walk: walkPlan
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "provider.libvirt (close)" waiting on "libvirt_domain.node"
libvirt_cloudinit.node: Destroying... (ID: /var/lib/libvirt/images/node_cloud_init.iso;596646ed-07c5-4dc6-ee80-701d8d469810)
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_volume.node" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "provider.libvirt (close)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_volume.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_domain.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInitProvider
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalBuildProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSetProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalConfigProvider
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [INFO] Created libvirt client
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: libvirt_cloudinit.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: libvirt_volume.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountCheckComputed
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: libvirt_cloudinit.node
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ResourceCountTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Starting...
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Checking: libvirt_cloudinit.node
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.OrphanResourceCountTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountCheckComputed
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4207b6780), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.AttachStateTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.TargetsTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ReferenceTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.RootTransformer:
libvirt_cloudinit.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': walking
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: libvirt_volume.node
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ResourceCountTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Starting...
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Checking: libvirt_volume.node
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.OrphanResourceCountTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: libvirt_cloudinit.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_volume.node": &terraform.ResourceState{Type:"libvirt_volume", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc4207b6690), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.AttachStateTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.TargetsTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_volume.node" references: []
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ReferenceTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.RootTransformer:
libvirt_volume.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_volume.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_volume.node': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: libvirt_volume.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalDiff
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] Instance Diff is nil in Diff()
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCheckPreventDestroy
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteDiff
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: libvirt_volume.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCheckPreventDestroy
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteDiff
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: libvirt_cloudinit.node
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': evaluating
2017/07/12 16:58:57 [TRACE] [walkPlan] Entering eval tree: libvirt_domain.node
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountCheckComputed
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCountFixZeroOneBoundary
2017/07/12 16:58:57 [TRACE] [walkPlan] Exiting eval tree: libvirt_domain.node
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': expanding/walking dynamic subgraph
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ResourceCountTransformer:
libvirt_domain.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Starting...
2017/07/12 16:58:57 [TRACE] OrphanResourceCount: Checking: libvirt_domain.node
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.OrphanResourceCountTransformer:
libvirt_domain.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc4207b67d0), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.AttachStateTransformer:
libvirt_domain.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.TargetsTransformer:
libvirt_domain.node - *terraform.NodePlannableResourceInstance
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_domain.node" references: []
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.ReferenceTransformer:
libvirt_domain.nodlibvirt_cloudinit.node: Destruction complete
Name:"node", Type:"libvirt_cloudinit", RawCount:(*config.RawConfig)(0xc42033c3c0), RawConfig:(*config.RawConfig)(0xc42033c0c0), Provisioners:[]*config.Provisioner(nil), Provider:"", DependsOn:[]string(nil), Lifecycle:config.ResourceLifecycle{CreateBeforeDestroy:false, PreventDestroy:false, IgnoreChanges:[]string(nil)}}
2017/07/12 16:58:57 [TRACE] AttachResourceConfigTransformer: Attach resource config request: libvirt_domain.node
2017/07/12 16:58:57 [TRACE] Attaching resource config: &config.Resource{Mode:0, Name:"node", Type:"libvirt_domain", RawCount:(*config.RawConfig)(0xc42033d140), RawConfig:(*config.RawConfig)(0xc42033c5a0), Provisioners:[]*config.Provisioner(nil), Provider:"", DependsOn:[]string(nil), Lifecycle:config.ResourceLifecycle{CreateBeforeDestroy:false, PreventDestroy:false, IgnoreChanges:[]string(nil)}}
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.AttachResourceConfigTransformer:
libvirt_cloudinit.node - *terraform.NodeApplyableResource
libvirt_cloudinit.node (destroy) - *terraform.NodeDestroyResource
libvirt_domain.node - *terraform.NodeApplyableResource
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node (destroy)": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc420276e60), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc420276e60), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_domain.node": &terraform.ResourceState{Type:"libvirt_domain", Dependencies:[]string{"libvirt_cloudinit.node", "libvirt_volume.node"}, Primary:(*terraform.InstanceState)(0xc420276f00), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58e, PreventDestroy:false, IgnoreChanges:[]string(nil)}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc420276e60), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [DEBUG] Attaching resource state to "libvirt_cloudinit.node (destroy)": &terraform.ResourceState{Type:"libvirt_cloudinit", Dependencies:[]string{}, Primary:(*terraform.InstanceState)(0xc420276e60), Deposed:[]*terraform.InstanceState{}, Provider:"", mu:sync.Mutex{state:0, sema:0x0}}
2017/07/12 16:58:57 [TRACE] Attach provider request: []string{} libvirt
2017/07/12 16:58:57 [TRACE] Attaching provider config: *config.ProviderConfig{Name:"libvirt", Alias:"", RawConfig:(*config.RawConfig)(0xc4202aad20)}
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "libvirt_cloudinit.node (destroy)" references: []
2017/07/12 16:58:57 [DEBUG] ReferenceTransformer: "provider.libvirt" references: []
2017/07/12 16:58:57 [TRACE] DestroyEdgeTransformer: reference graph: libvirt_cloudinit.node
provider.libvirt
libvirt_cloudinit.node (destroy)
provider.libvirt
provider.libvirt
2017/07/12 16:58:57 [TRACE] DestroyEdgeTransformer: creation node "libvirt_cloudinit.node" references [provider.libvirt]
2017/07/12 16:58:57 [TRACE] DestroyEdgeTransformer: creation node "libvirt_cloudinit.node (destroy)" references [provider.libvirt]
2017/07/12 16:58:57 [TRACE] Graph after step *terraform.DestroyEdgeTransformer:
libvirt_cloudinit.node - *terraform.NodeApplyableResource
libvirt_cloudinit.node (destroy) - *terraform.NodeDestroyResource
provider.libvirt - *terraform.NodeApplyableProvider
libvirt_cloudinit.node (destroy) - *terraform.NodeDestroyResource
provider.libvirt - *terraform.NodeApplyableProvider
libvirt_domain.node - *terraform.NodeApplyableResource
provider.libvirt - *terraform.Noterraform.NodeDestroyResource
libvirt_cloudinit.node (destroy) - *terraform.NodeDestroyResource
provider.libvirt - *terraform.NodeApplyableProvider
libvirt_domain.node - *terraform.NodeApplyableResource
libvirt_cloudinit.node - *terraform.NodeApplyableResource
meta.count-boundary (count boundary fixup) - *terraform.NodeCountBoundary
libvirt_domain.node - *terraform.NodeApplyableResource
provider.libvirt - *terraform.NodeApplyableProvider
provider.libvirt (close) - *terraform.graphNodeCloseProvider
libvirt_domain.node - *terraform.NodeApplyableResource
root - terraform.graphNodeRoot
meta.count-boundary (count boundary fixup) - *terraform.NodeCountBoundary
provider.libvirt (close) - *terraform.graphNodeCloseProvider
2017/07/12 16:58:57 [DEBUG] Starting graph walk: walkApply
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node (destroy)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_cloudinit.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "meta.count-boundary (count boundary fixup)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added new vertex: "root"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node (destroy)" waiting on "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_cloudinit.node" waiting on "libvirt_cloudinit.node (destroy)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "meta.count-boundary (count boundary fixup)" waiting on "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "provider.libvirt (close)" waiting on "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "root" waiting on "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: added edge: "libvirt_domain.node" waiting on "libvirt_cloudinit.node"
2017libvirt_cloudinit.node: Creating...
/07/12 16:58:57 [DEBUG] dag/walk: added edge: "root" waiting on "meta.count-boundary (count boundary fixup)"
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "root", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_domain.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node (destroy)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "libvirt_cloudinit.node", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "meta.count-boundary (count boundary fixup)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: dependencies changed for "provider.libvirt (close)", sending new deps
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "provider.libvirt"
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.provider.libvirt': evaluating
2017/07/12 16:58:57 [TRACE] [walkApply] Entering eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInitProvider
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalBuildProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSetProviderConfig
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalConfigProvider
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [INFO] Created libvirt client
2017/07/12 16:58:57 [TRACE] [walkApply] name: "" => "node_cloud_init.iso"
Exiting eval tree: provider.libvirt
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_cloudinit.node (destroy)"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node (destroy)': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_cloudinit.node (destroy)': evaluating
2017/07/12 16:58:57 [TRACE] [walkApply] Entering eval tree: libvirt_cloudinit.node (destroy)
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalOpFilter
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalFilterDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInstanceInfo
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalRequireState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyPre
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyProvisioners
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApply
2017/07/12 16:58:57 [DEBUG] apply: libvirt_cloudinit.node: executing Apply
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] No meta timeoutkey found in Apply()
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyPost
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalUpdateStateHook
2017/07/12 16:58:57 [TRACE] Preserving existing state lineage "d7c8692e-293c-4151-9f63-6640e218ee5d"
pool: "" => "default"
rraform.EvalApplyPre
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApply
2017/07/12 16:58:57 [DEBUG] apply: libvirt_cloudinit.node: executing Apply
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] No meta timeoutkey found in Apply()
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] creating cloudinit
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [INFO] cloudInit: {Name:node_cloud_init.iso PoolName:default Metadata:{LocalHostname: InstanceID:created-at-2017-07-12 16:58:57.643288045 +0100 BST} UserDataRaw:#cloud-config
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: # set locale
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: locale: en_GB.UTF-8
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: # set timezone
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: timezone: Etc/UTC
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: # Set hostname and FQDN
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: hostname: node
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: fqdn: node.exmaple.com
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: # set root password
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: chpasswd:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: list: |
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: root:linux
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: expire: False
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: # setup and enable ntp
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: ntp:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: servers:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: - ntp1.suse.de
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: - ntp2.suse.de
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: - ntp3.suse.de
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: runcmd:
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: - /usr/bin/systemctl enable --now ntpd UserData:{SSHAuthorizedKeys:[]}}
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 Creating new ISO
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 Creating ISO contents
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO contents created
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 About to execute cmd: %+v&{/usr/bin/genisoimage [genisoimage -output /tmp/cloudinit333082634/node_cloud_init.iso -volid cidata -joliet -rock /tmp/cloudinit333082634/user-data /tmp/cloudinit333082634/meta-data] [] <nil> <nil> <nil> [] <nil> <nil> <nil> <nil> <nil> false [] [] [] [] <nil> <nil>}
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO created at /tmp/cloudinit333082634/node_cloud_init.iso
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 374784 bytes uploaded
user_data: "" => "#cloud-config\n\n# set locale\nlocale: en_GB.UTF-8\n\n# set timezone\ntimezone: Etc/UTC\n\n# Set hostname and FQDN\nhostname: node\nfqdn: node.exmaple.com\n\n# set root password\nchpasswd:\n list: |\n root:linux\n expire: False\n\n# setup and enable ntp\nntp:\n servers:\n - ntp1.suse.de\n - ntp2.suse.de\n - ntp3.suse.de\n\nruncmd:\n - /usr/bin/systemctl enable --now ntpd"
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 374784 bytes downloaded
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO reader: processing file /meta_dat.
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 ISO reader: processing file /user_dat.
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 Read cloud-init from file: {Name:node_cloud_init.iso PoolName:default Metadata:{LocalHostname: InstanceID:created-at-2017-07-12 16:58:57.643288045 +0100 BST} UserDataRaw: UserData:{SSHAuthorizedKeys:[]}}
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyProvisioners
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyPost
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalUpdateStateHook
libvirt_cloudinit.node: Creation complete (ID: /var/lib/libvirt/images/node_cloud_init.iso;59664741-704b-67b5-cc03-a7520106d4a3)
2017/07/12 16:58:57 [DEBUG] dag/walk: walking "libvirt_domain.node"
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': walking
2017/07/12 16:58:57 [DEBUG] vertex 'root.libvirt_domain.node': evaluating
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalSequence
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInstanceInfo
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: terraform.EvalNoop
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalInterpolate
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalValidateResource
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalCompareDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalGetProvider
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalReadState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyPre
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApply
2017/07/12 16:58:57 [DEBUG] apply: libvirt_domain.node: executing Apply
libvirt_domain.node: Modifying... (ID: 01d6489a-1648-4517-876d-4135def7617d)
2017/07/12 16:58:57 [DEBUG] plugin: terraform-provider-libvirt: 2017/07/12 16:58:57 [DEBUG] Update resource libvirt_domain
cloudinit: "/var/lib/libvirt/images/node_cloud_init.iso;59663410-71e5-7b7d-b409-047273349fd5" => "/var/lib/libvirt/images/node_cloud_init.iso;59664741-704b-67b5-cc03-a7520106d4a3"
network_interface.0.hostname: "" => "node"
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyProvisioners
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalIf
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteState
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalWriteDiff
2017/07/12 16:58:57 [DEBUG] root: eval: *terraform.EvalApplyPost
2017/07/12 16:58:57 [ERROR] root: eval: *terraform.EvalApplyPost, err: 1 error(s) occurred:
* libvirt_domain.node: Can't retrieve volume /var/lib/libvirt/images/node_cloud_init.iso;59664741-704b-67b5-cc03-a7520106d4a3
2017/07/12 16:58:57 [ERROR] root: eval: *terraform.EvalSequence, err: 1 error(s) occurred:
* libvirt_domain.node: Can't retrieve volume /var/lib/libvirt/images/node_cloud_init.iso;59664741-704b-67b5-cc03-a7520106d4a3
2017/07/12 16:58:57 [TRACE] [walkApply] Exiting eval tree: libvirt_domain.node
2017/07/12 16:58:57 [DEBUG] dag/walk: upstream errored, not walking "provider.libvirt (close)"
2017/07/12 16:58:57 [DEBUG] dag/walk: upstream errored, not walking "meta.count-boundary (count boundary fixup)"
2017/07/12 16:58:57 [DEBUG] dag/walk: upstream errored, not walking "root"
2017/07/12 16:58:57 [DEBUG] plugin: waiting for all plugin processes to complete...
Error applying plan:
1 error(s) occurred:
* libvirt_domain.node: 1 error(s) occurred:
* libvirt_domain.node: Can't retrieve volume /var/lib/libvirt/images/node_cloud_init.iso;59664741-704b-67b5-cc03-a7520106d4a3
Terraform does not automatically rollback in the face of errors.
Instead, your Terraform state file has been partially updated with
any resources that successfully completed. Please address the error
above and apply again to incrementally change your infrastructure.
2017/07/12 16:58:57 [DEBUG] plugin: /home/graham/go/bin/terraform-provider-libvirt: plugin process exited
Raw
tf-apply-2.log
➜ terraform apply
libvirt_cloudinit.node: Refreshing state... (ID: /var/lib/libvirt/images/node_cloud_init.iso;596634b5-7adb-0d33-606d-a8fdf6d359d6)
libvirt_volume.node: Refreshing state... (ID: /var/lib/libvirt/images/node.qcow2)
libvirt_domain.node: Refreshing state... (ID: 01d6489a-1648-4517-876d-4135def7617d)
libvirt_cloudinit.node: Destroying... (ID: /var/lib/libvirt/images/node_cloud_init.iso;596634b5-7adb-0d33-606d-a8fdf6d359d6)
libvirt_cloudinit.node: Destruction complete
libvirt_cloudinit.node: Creating...
name: "" => "node_cloud_init.iso"
pool: "" => "default"
user_data: "" => "#cloud-config\n\n# set locale\nlocale: en_GB.UTF-8\n\n# set timezone\ntimezone: Etc/UTC\n\n# Set hostname and FQDN\nhostname: node\nfqdn: node.exmaple.com\n\n# set root password\nchpasswd:\n list: |\n root:linux\n expire: False\n\n# setup and enable ntp\nntp:\n servers:\n - ntp1.suse.de\n - ntp2.suse.de\n - ntp3.suse.de\n\nruncmd:\n - /usr/bin/systemctl enable --now ntpd"
libvirt_cloudinit.node: Creation complete (ID: /var/lib/libvirt/images/node_cloud_init.iso;596644d6-5d5f-4f93-2d70-d30a79e7ad5d)
libvirt_domain.node: Modifying... (ID: 01d6489a-1648-4517-876d-4135def7617d)
cloudinit: "/var/lib/libvirt/images/node_cloud_init.iso;59663410-71e5-7b7d-b409-047273349fd5" => "/var/lib/libvirt/images/node_cloud_init.iso;596644d6-5d5f-4f93-2d70-d30a79e7ad5d"
network_interface.0.hostname: "" => "node"
Error applying plan:
1 error(s) occurred:
* libvirt_domain.node: 1 error(s) occurred:
* libvirt_domain.node: Can't retrieve volume /var/lib/libvirt/images/node_cloud_init.iso;596644d6-5d5f-4f93-2d70-d30a79e7ad5d
Terraform does not automatically rollback in the face of errors.
Instead, your Terraform state file has been partially updated with
any resources that successfully completed. Please address the error
above and apply again to incrementally change your infrastructure.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment