2019-01-11 10:26:04,773 DEBUG: Validating arguments for deployment 2019-01-11 10:26:04,776 INFO: Deploy settings are: {'deploy_options': {'ceph': True, 'congress': True, 'dataplane': 'ovs', 'gluon': False, 'odl_version': 'carbon', 'rt_kvm': False, 'sdn_controller': False, 'sfc': False, 'tacker': True, 'vpn': False, 'vpp': False}, 'global_params': {'ha_enabled': False}} 2019-01-11 10:26:04,821 INFO: admin enabled 2019-01-11 10:26:04,821 INFO: admin_cidr: 192.0.2.0/24 2019-01-11 10:26:04,822 INFO: Config IP Range: admin dhcp_range 2019-01-11 10:26:04,822 INFO: Config IP Range: admin introspection_range 2019-01-11 10:26:04,822 INFO: compute nic order specified for network admin 2019-01-11 10:26:04,822 INFO: controller nic order specified for network admin 2019-01-11 10:26:04,822 INFO: Config IP Range: admin overcloud_ip_range 2019-01-11 10:26:04,822 INFO: tenant enabled 2019-01-11 10:26:04,822 INFO: tenant_cidr: 11.0.0.0/24 2019-01-11 10:26:04,822 INFO: compute nic order specified for network tenant 2019-01-11 10:26:04,822 INFO: controller nic order specified for network tenant 2019-01-11 10:26:04,822 INFO: Config IP Range: tenant overcloud_ip_range 2019-01-11 10:26:04,823 INFO: external enabled 2019-01-11 10:26:04,823 INFO: external_cidr: 192.168.37.0/24 2019-01-11 10:26:04,823 INFO: Config IP Range: external floating_ip_range 2019-01-11 10:26:04,823 INFO: Config Gateway: external 192.168.37.1 2019-01-11 10:26:04,823 INFO: compute nic order specified for network external 2019-01-11 10:26:04,823 INFO: controller nic order specified for network external 2019-01-11 10:26:04,823 INFO: Config IP Range: external overcloud_ip_range 2019-01-11 10:26:04,823 INFO: storage enabled 2019-01-11 10:26:04,823 INFO: storage_cidr: 12.0.0.0/24 2019-01-11 10:26:04,823 INFO: compute nic order specified for network storage 2019-01-11 10:26:04,823 INFO: controller nic order specified for network storage 2019-01-11 10:26:04,824 INFO: Config IP Range: storage overcloud_ip_range 2019-01-11 10:26:04,824 INFO: api disabled, will collapse with admin network 2019-01-11 10:26:04,833 INFO: Network settings are: {'apex': {'networks': {'admin': {'introspection_range': ['192.0.2.100', '192.0.2.120']}}}, 'dns-domain': 'opnfvlf.org', 'dns-search': 'opnfvlf.org', 'dns_nameservers': ['8.8.8.8', '8.8.4.4'], 'dns_servers': ['8.8.8.8', '8.8.4.4'], 'domain_name': 'opnfvlf.org', 'network-config-metadata': {'comment': 'None', 'created': 'Mon Dec 28 2015', 'title': 'LF-POD-1 Network config', 'version': 0.1}, 'networks': {'admin': {'cidr': IPv4Network('192.0.2.0/24'), 'dhcp_range': ['192.0.2.2', '192.0.2.50'], 'enabled': True, 'gateway': '192.0.2.1', 'installer_vm': {'ip': '192.0.2.1', 'members': ['em1'], 'nic_type': 'interface', 'vlan': 'native'}, 'introspection_range': ['192.0.2.100', '192.0.2.120'], 'nic_mapping': {'compute': {'members': ['eth0'], 'phys_type': 'interface'}, 'controller': {'members': ['eth0'], 'phys_type': 'interface'}}, 'overcloud_ip_range': ['192.0.2.51', '192.0.2.99']}, 'api': {'cidr': 'fd00:fd00:fd00:4000::/64', 'enabled': False, 'mtu': 1500, 'nic_mapping': {'compute': {'members': ['eth4'], 'phys_type': 'interface', 'vlan': 'native'}, 'controller': {'members': ['eth4'], 'phys_type': 'interface', 'vlan': 'native'}}, 'vlan': 13}, 'external': [{'cidr': IPv4Network('192.168.37.0/24'), 'enabled': True, 'external_overlay': {'gateway': '192.168.37.1', 'name': 'Public_internet', 'type': 'flat'}, 'floating_ip_range': ['192.168.37.200', '192.168.37.220'], 'gateway': '192.168.37.1', 'installer_vm': {'ip': '192.168.37.1', 'members': ['em1'], 'nic_type': 'interface', 'vlan': 'native'}, 'mtu': 1500, 'nic_mapping': {'compute': {'members': ['eth2'], 'phys_type': 'interface', 'vlan': 'native'}, 'controller': {'members': ['eth2'], 'phys_type': 'interface', 'vlan': 'native'}}, 'overcloud_ip_range': ['192.168.37.10', '192.168.37.199'], 'public': None}, {'cidr': '192.168.38.0/24', 'enabled': False, 'external_overlay': {'gateway': '192.168.38.1', 'name': 'private_cloud', 'segmentation_id': 101, 'type': 'vlan'}, 'floating_ip_range': ['192.168.38.200', '192.168.38.220'], 'gateway': '192.168.38.1', 'installer_vm': {'ip': '192.168.38.1', 'members': ['em1'], 'nic_type': 'interface', 'vlan': 101}, 'mtu': 1500, 'nic_mapping': {'compute': {'members': ['eth3'], 'phys_type': 'interface', 'vlan': 101}, 'controller': {'members': ['eth3'], 'phys_type': 'interface', 'vlan': 101}}, 'overcloud_ip_range': ['192.168.38.10', '192.168.38.199'], 'private_cloud': None}], 'storage': {'cidr': IPv4Network('12.0.0.0/24'), 'enabled': True, 'mtu': 1500, 'nic_mapping': {'compute': {'members': ['eth3'], 'phys_type': 'interface', 'vlan': 'native'}, 'controller': {'members': ['eth3'], 'phys_type': 'interface', 'vlan': 'native'}}, 'overcloud_ip_range': ['12.0.0.21', '12.0.0.234']}, 'tenant': {'cidr': IPv4Network('11.0.0.0/24'), 'enabled': True, 'mtu': 1500, 'nic_mapping': {'compute': {'members': ['eth1'], 'phys_type': 'interface', 'uio_driver': 'uio_pci_generic', 'vlan': 'native'}, 'controller': {'members': ['eth1'], 'phys_type': 'interface', 'vlan': 'native'}}, 'overcloud_ip_range': ['11.0.0.21', '11.0.0.234'], 'overlay_id_range': '2,65535', 'segmentation_type': 'vxlan'}}, 'ntp': ['0.se.pool.ntp.org', '1.se.pool.ntp.org'], 'ntp_servers': ['0.se.pool.ntp.org', '1.se.pool.ntp.org'], 'syslog': {'server': '10.128.1.24', 'transport': 'tcp'}} 2019-01-11 10:26:04,884 DEBUG: Writing file /tmp/apex_tmph0diznve/network-environment.yaml with yaml data: parameter_defaults: ControlPlaneDefaultRoute: 192.0.2.1 ControlPlaneSubnetCidr: '24' DnsServers: [8.8.8.8, 8.8.4.4] EC2MetadataIp: 192.0.2.1 ExternalAllocationPools: - {end: 192.168.37.199, start: 192.168.37.10} ExternalInterfaceDefaultRoute: 192.168.37.1 ExternalNetCidr: 192.168.37.0/24 NeutronExternalNetworkBridge: br-ex ServiceNetMap: {AodhApiNetwork: internal_api, BlockStorageHostnameResolveNetwork: internal_api, CeilometerApiNetwork: internal_api, CephClusterNetwork: storage, CephPublicNetwork: storage, CephStorageHostnameResolveNetwork: storage, CinderApiNetwork: internal_api, CinderIscsiNetwork: storage, ComputeHostnameResolveNetwork: internal_api, CongressApiNetwork: internal_api, ControllerHostnameResolveNetwork: internal_api, GlanceApiNetwork: internal_api, GlanceRegistryNetwork: internal_api, HeatApiNetwork: internal_api, HorizonNetwork: internal_api, KeystoneAdminApiNetwork: ctlplane, KeystonePublicApiNetwork: internal_api, MemcachedNetwork: internal_api, MongoDbNetwork: internal_api, MysqlNetwork: internal_api, NeutronApiNetwork: internal_api, NeutronTenantNetwork: tenant, NovaApiNetwork: internal_api, NovaMetadataNetwork: internal_api, NovaVncProxyNetwork: internal_api, ObjectStorageHostnameResolveNetwork: internal_api, OpendaylightApiNetwork: internal_api, RabbitMqNetwork: internal_api, RedisNetwork: internal_api, SwiftMgmtNetwork: storage, SwiftProxyNetwork: storage, TackerApiNetwork: internal_api} StorageAllocationPools: - {end: 12.0.0.234, start: 12.0.0.21} StorageNetCidr: 12.0.0.0/24 TenantAllocationPools: - {end: 11.0.0.234, start: 11.0.0.21} TenantNetCidr: 11.0.0.0/24 resource_registry: {'OS::TripleO::Compute::Net::SoftwareConfig': nics/compute.yaml, 'OS::TripleO::Compute::Ports::ExternalPort': /usr/share/openstack-tripleo-heat-templates/network/ports/external.yaml, 'OS::TripleO::Compute::Ports::InternalApiPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Compute::Ports::StorageMgmtPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Compute::Ports::StoragePort': /usr/share/openstack-tripleo-heat-templates/network/ports/storage.yaml, 'OS::TripleO::Compute::Ports::TenantPort': /usr/share/openstack-tripleo-heat-templates/network/ports/tenant.yaml, 'OS::TripleO::ComputeExtraConfigPre': 'OS::Heat::None', 'OS::TripleO::Controller::Net::SoftwareConfig': nics/controller.yaml, 'OS::TripleO::Controller::Ports::ExternalPort': /usr/share/openstack-tripleo-heat-templates/network/ports/external.yaml, 'OS::TripleO::Controller::Ports::InternalApiPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Controller::Ports::StorageMgmtPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Controller::Ports::StoragePort': /usr/share/openstack-tripleo-heat-templates/network/ports/storage.yaml, 'OS::TripleO::Controller::Ports::TenantPort': /usr/share/openstack-tripleo-heat-templates/network/ports/tenant.yaml, 'OS::TripleO::ControllerExtraConfigPre': 'OS::Heat::None', 'OS::TripleO::Network::External': /usr/share/openstack-tripleo-heat-templates/network/external.yaml, 'OS::TripleO::Network::InternalApi': 'OS::Heat::None', 'OS::TripleO::Network::Ports::ExternalVipPort': /usr/share/openstack-tripleo-heat-templates/network/ports/external.yaml, 'OS::TripleO::Network::Ports::InternalApiVipPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Network::Ports::RedisVipPort': /usr/share/openstack-tripleo-heat-templates/network/ports/ctlplane_vip.yaml, 'OS::TripleO::Network::Ports::StorageMgmtVipPort': /usr/share/openstack-tripleo-heat-templates/network/ports/noop.yaml, 'OS::TripleO::Network::Ports::StorageVipPort': /usr/share/openstack-tripleo-heat-templates/network/ports/storage.yaml, 'OS::TripleO::Network::Storage': /usr/share/openstack-tripleo-heat-templates/network/storage.yaml, 'OS::TripleO::Network::StorageMgmt': 'OS::Heat::None', 'OS::TripleO::Network::Tenant': /usr/share/openstack-tripleo-heat-templates/network/tenant.yaml, 'OS::TripleO::Services::SwiftProxy': 'OS::Heat::None', 'OS::TripleO::Services::SwiftRingBuilder': 'OS::Heat::None', 'OS::TripleO::Services::SwiftStorage': 'OS::Heat::None'} 2019-01-11 10:26:05,068 DEBUG: Detected virsh default network ip: 192.168.122.1 2019-01-11 10:26:05,072 DEBUG: Writing file /tmp/apex_tmph0diznve/inventory-virt.yaml with yaml data: nodes: node0: {arch: x86_64, capabilities: 'profile:control', cpu: 8, disk: 41, ipmi_ip: 192.168.122.1, ipmi_pass: password, ipmi_user: admin, mac_address: '00:76:b6:9b:81:c5', memory: 16384, pm_port: 6230, pm_type: pxe_ipmitool} node1: {arch: x86_64, capabilities: 'profile:compute', cpu: 8, disk: 41, ipmi_ip: 192.168.122.1, ipmi_pass: password, ipmi_user: admin, mac_address: '00:7c:ec:9c:d0:ec', memory: 16384, pm_port: 6231, pm_type: pxe_ipmitool} 2019-01-11 10:26:05,075 INFO: Virtual environment file created: /tmp/apex_tmph0diznve/inventory-virt.yaml 2019-01-11 10:26:05,081 INFO: Executing ansible playbook: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml 2019-01-11 10:26:05,081 DEBUG: Ansible variables to be set: {'virsh_enabled_networks': ['admin', 'tenant', 'external', 'storage']} 2019-01-11 10:26:05,082 INFO: Executing playbook...this may take some time 2019-01-11 10:26:11,958 INFO: ansible-playbook 2.5.2 config file = /etc/ansible/ansible.cfg configured module search path = [u'/root/.ansible/plugins/modules', u'/usr/share/ansible/plugins/modules'] ansible python module location = /usr/lib/python2.7/site-packages/ansible executable location = /bin/ansible-playbook python version = 2.7.5 (default, Aug 4 2017, 00:39:18) [GCC 4.8.5 20150623 (Red Hat 4.8.5-16)] Using /etc/ansible/ansible.cfg as config file 2019-01-11 10:26:12,386 INFO: PLAYBOOK: deploy_dependencies.yml ********************************************** 1 plays in /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml 2019-01-11 10:26:12,582 INFO: PLAY [localhost] *************************************************************** 2019-01-11 10:26:14,059 INFO: TASK [Gathering Facts] ********************************************************* task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:2 ok: [localhost] META: ran handlers 2019-01-11 10:26:16,373 INFO: TASK [yum] ********************************************************************* task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:4 ok: [localhost] => (item=[u'python-lxml', u'libvirt-python']) => {"changed": false, "item": ["python-lxml", "libvirt-python"], "msg": "", "rc": 0, "results": ["python-lxml-3.2.1-4.el7.x86_64 providing python-lxml is already installed", "libvirt-python-3.2.0-3.el7_4.1.x86_64 providing libvirt-python is already installed"]} 2019-01-11 10:26:16,784 INFO: TASK [sysctl] ****************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:10 ok: [localhost] => {"changed": false} 2019-01-11 10:26:17,206 INFO: TASK [systemd] ***************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:15 fatal: [localhost]: FAILED! => {"changed": false, "msg": "Could not find the requested service dhcpd: host"} ...ignoring 2019-01-11 10:26:17,502 INFO: TASK [systemd] ***************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:20 ok: [localhost] => {"changed": false, "enabled": true, "name": "libvirtd", "state": "started", "status": {"ActiveEnterTimestamp": "Fri 2019-01-11 10:12:07 UTC", "ActiveEnterTimestampMonotonic": "29518523", "ActiveExitTimestampMonotonic": "0", "ActiveState": "active", "After": "virtlockd.service dbus.service virtlogd.socket local-fs.target remote-fs.target virtlockd.socket system.slice basic.target network.target systemd-journald.socket iscsid.service apparmor.service virtlogd.service", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "yes", "AssertTimestamp": "Fri 2019-01-11 10:12:06 UTC", "AssertTimestampMonotonic": "27982340", "Before": "multi-user.target shutdown.target libvirt-guests.service", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "yes", "ConditionTimestamp": "Fri 2019-01-11 10:12:06 UTC", "ConditionTimestampMonotonic": "27982339", "Conflicts": "shutdown.target", "ControlGroup": "/system.slice/libvirtd.service", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "Virtualization daemon", "DevicePolicy": "auto", "Documentation": "man:libvirtd(8) http://libvirt.org", "EnvironmentFile": "/etc/sysconfig/libvirtd (ignore_errors=yes)", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "1096", "ExecMainStartTimestamp": "Fri 2019-01-11 10:12:06 UTC", "ExecMainStartTimestampMonotonic": "27988400", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/kill ; argv[]=/bin/kill -HUP $MAINPID ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/sbin/libvirtd ; argv[]=/usr/sbin/libvirtd $LIBVIRTD_ARGS ; ignore_errors=no ; start_time=[Fri 2019-01-11 10:12:06 UTC] ; stop_time=[n/a] ; pid=1096 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/libvirtd.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "libvirtd.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestamp": "Fri 2019-01-11 10:12:06 UTC", "InactiveExitTimestampMonotonic": "27988450", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "process", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "8192", "LimitNPROC": "208608", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "208608", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "1096", "MemoryAccounting": "no", "MemoryCurrent": "27340800", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "libvirtd.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "main", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "Requires": "virtlockd.socket basic.target virtlogd.socket", "Restart": "on-failure", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "running", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "18", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "1min 30s", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "notify", "UMask": "0022", "UnitFilePreset": "enabled", "UnitFileState": "enabled", "WantedBy": "libvirt-guests.service multi-user.target", "Wants": "system.slice", "WatchdogTimestamp": "Fri 2019-01-11 10:12:07 UTC", "WatchdogTimestampMonotonic": "29518375", "WatchdogUSec": "0"}} 2019-01-11 10:26:17,783 INFO: TASK [systemd] ***************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:24 ok: [localhost] => {"changed": false, "enabled": true, "name": "openvswitch", "state": "started", "status": {"ActiveEnterTimestamp": "Fri 2019-01-11 10:12:05 UTC", "ActiveEnterTimestampMonotonic": "26738383", "ActiveExitTimestampMonotonic": "0", "ActiveState": "active", "After": "systemd-journald.socket basic.target system.slice network-pre.target ovsdb-server.service ovs-vswitchd.service", "AllowIsolate": "no", "AmbientCapabilities": "0", "AssertResult": "yes", "AssertTimestamp": "Fri 2019-01-11 10:12:05 UTC", "AssertTimestampMonotonic": "26725134", "Before": "multi-user.target network.service shutdown.target network.target", "BlockIOAccounting": "no", "BlockIOWeight": "18446744073709551615", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "18446744073709551615", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "18446744073709551615", "ConditionResult": "yes", "ConditionTimestamp": "Fri 2019-01-11 10:12:05 UTC", "ConditionTimestampMonotonic": "26725134", "Conflicts": "shutdown.target", "ConsistsOf": "ovsdb-server.service ovs-vswitchd.service", "ControlGroup": "/system.slice/openvswitch.service", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "Open vSwitch", "DevicePolicy": "auto", "ExecMainCode": "1", "ExecMainExitTimestamp": "Fri 2019-01-11 10:12:05 UTC", "ExecMainExitTimestampMonotonic": "26731114", "ExecMainPID": "797", "ExecMainStartTimestamp": "Fri 2019-01-11 10:12:05 UTC", "ExecMainStartTimestampMonotonic": "26726165", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/true ; argv[]=/bin/true ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/bin/true ; argv[]=/bin/true ; ignore_errors=no ; start_time=[Fri 2019-01-11 10:12:05 UTC] ; stop_time=[Fri 2019-01-11 10:12:05 UTC] ; pid=797 ; code=exited ; status=0 }", "ExecStop": "{ path=/bin/true ; argv[]=/bin/true ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FileDescriptorStoreMax": "0", "FragmentPath": "/usr/lib/systemd/system/openvswitch.service", "GuessMainPID": "yes", "IOScheduling": "0", "Id": "openvswitch.service", "IgnoreOnIsolate": "no", "IgnoreOnSnapshot": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestamp": "Fri 2019-01-11 10:12:05 UTC", "InactiveExitTimestampMonotonic": "26726195", "JobTimeoutAction": "none", "JobTimeoutUSec": "0", "KillMode": "control-group", "KillSignal": "15", "LimitAS": "18446744073709551615", "LimitCORE": "18446744073709551615", "LimitCPU": "18446744073709551615", "LimitDATA": "18446744073709551615", "LimitFSIZE": "18446744073709551615", "LimitLOCKS": "18446744073709551615", "LimitMEMLOCK": "65536", "LimitMSGQUEUE": "819200", "LimitNICE": "0", "LimitNOFILE": "4096", "LimitNPROC": "208608", "LimitRSS": "18446744073709551615", "LimitRTPRIO": "0", "LimitRTTIME": "18446744073709551615", "LimitSIGPENDING": "208608", "LimitSTACK": "18446744073709551615", "LoadState": "loaded", "MainPID": "0", "MemoryAccounting": "no", "MemoryCurrent": "0", "MemoryLimit": "18446744073709551615", "MountFlags": "0", "Names": "openvswitch.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "none", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "PartOf": "network.target", "PermissionsStartOnly": "no", "PrivateDevices": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "PropagatesReloadTo": "ovsdb-server.service", "ProtectHome": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "yes", "Requires": "ovsdb-server.service basic.target ovs-vswitchd.service", "Restart": "no", "RestartUSec": "100ms", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitInterval": "10000000", "StartupBlockIOWeight": "18446744073709551615", "StartupCPUShares": "18446744073709551615", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "exited", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "no", "TasksCurrent": "0", "TasksMax": "18446744073709551615", "TimeoutStartUSec": "0", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "oneshot", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "enabled", "WantedBy": "multi-user.target", "Wants": "system.slice", "WatchdogTimestampMonotonic": "0", "WatchdogUSec": "0"}} 2019-01-11 10:26:18,444 INFO: TASK [virt_net] **************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:28 ok: [localhost] => {"changed": false} 2019-01-11 10:26:19,733 INFO: TASK [openvswitch_bridge] ****************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:34 changed: [localhost] => (item=admin) => {"changed": true, "commands": ["/bin/ovs-vsctl -t 5 add-br br-admin"], "item": "admin"} changed: [localhost] => (item=tenant) => {"changed": true, "commands": ["/bin/ovs-vsctl -t 5 add-br br-tenant"], "item": "tenant"} changed: [localhost] => (item=external) => {"changed": true, "commands": ["/bin/ovs-vsctl -t 5 add-br br-external"], "item": "external"} changed: [localhost] => (item=storage) => {"changed": true, "commands": ["/bin/ovs-vsctl -t 5 add-br br-storage"], "item": "storage"} 2019-01-11 10:26:20,794 INFO: TASK [virt_net] **************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:38 changed: [localhost] => (item=admin) => {"changed": true, "created": "admin", "item": "admin"} changed: [localhost] => (item=tenant) => {"changed": true, "created": "tenant", "item": "tenant"} changed: [localhost] => (item=external) => {"changed": true, "created": "external", "item": "external"} changed: [localhost] => (item=storage) => {"changed": true, "created": "storage", "item": "storage"} 2019-01-11 10:26:21,872 INFO: TASK [virt_net] **************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:43 changed: [localhost] => (item=admin) => {"changed": true, "item": "admin", "msg": 0} changed: [localhost] => (item=tenant) => {"changed": true, "item": "tenant", "msg": 0} changed: [localhost] => (item=external) => {"changed": true, "item": "external", "msg": 0} changed: [localhost] => (item=storage) => {"changed": true, "item": "storage", "msg": 0} 2019-01-11 10:26:22,331 INFO: TASK [virt_pool] *************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:48 ok: [localhost] => {"changed": false} 2019-01-11 10:26:22,606 INFO: TASK [virt_pool] *************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:53 ok: [localhost] => {"changed": false} 2019-01-11 10:26:22,993 INFO: TASK [lineinfile] ************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:57 ok: [localhost] => {"backup": "", "changed": false, "msg": ""} 2019-01-11 10:26:23,601 INFO: TASK [modprobe] **************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:62 ok: [localhost] => (item=kvm) => {"changed": false, "item": "kvm", "name": "kvm", "params": "", "state": "present"} ok: [localhost] => (item=kvm_intel) => {"changed": false, "item": "kvm_intel", "name": "kvm_intel", "params": "", "state": "present"} 2019-01-11 10:26:23,991 INFO: TASK [Generate SSH key for root if missing] ************************************ task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:69 changed: [localhost] => {"changed": true, "cmd": "test -e ~/.ssh/id_rsa || ssh-keygen -t rsa -N \"\" -f ~/.ssh/id_rsa", "delta": "0:00:00.005719", "end": "2019-01-11 10:26:23.946105", "rc": 0, "start": "2019-01-11 10:26:23.940386", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:26:24,405 INFO: TASK [Check that /u/l/python3.4/site-packages/virtualbmc/vbmc.py exists] ******* task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:71 ok: [localhost] => {"changed": false, "stat": {"atime": 1525104731.3735354, "attr_flags": "", "attributes": [], "block_size": 4096, "blocks": 16, "charset": "us-ascii", "checksum": "1db8cef4cfadfdd69d3948758707ca4af65f5ed4", "ctime": 1523455108.606641, "dev": 2049, "device_type": 0, "executable": false, "exists": true, "gid": 0, "gr_name": "root", "inode": 21275, "isblk": false, "ischr": false, "isdir": false, "isfifo": false, "isgid": false, "islnk": false, "isreg": true, "issock": false, "isuid": false, "mimetype": "text/x-python", "mode": "0644", "mtime": 1523455108.606641, "nlink": 1, "path": "/usr/lib/python3.4/site-packages/virtualbmc/vbmc.py", "pw_name": "root", "readable": true, "rgrp": true, "roth": true, "rusr": true, "size": 6721, "uid": 0, "version": "18446744073087292393", "wgrp": false, "woth": false, "writeable": true, "wusr": true, "xgrp": false, "xoth": false, "xusr": false}} 2019-01-11 10:26:24,648 INFO: TASK [Manually patch vmbc to work with python3.x] ****************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:75 ok: [localhost] => {"backup": "", "changed": false, "msg": ""} 2019-01-11 10:26:24,993 INFO: TASK [Add ssh retry to Ansible config] ***************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/deploy_dependencies.yml:81 ok: [localhost] => {"changed": false, "gid": 0, "group": "root", "mode": "0644", "msg": "OK", "owner": "root", "path": "/etc/ansible/ansible.cfg", "secontext": "system_u:object_r:etc_t:s0", "size": 19191, "state": "file", "uid": 0} META: ran handlers META: ran handlers 2019-01-11 10:26:24,993 INFO: PLAY RECAP ********************************************************************* localhost : ok=18 changed=4 unreachable=0 failed=0 libvirt: Storage Driver error : Storage volume not found: no storage vol with matching name 'baremetal0.qcow2' 2019-01-11 10:26:25,540 DEBUG: Created new storage volume: baremetal0.qcow2 2019-01-11 10:26:25,570 DEBUG: libvirt template is baremetal0 16777216 8 hvm destroy restart restart 2019-01-11 10:26:25,648 INFO: Created machine baremetal0 with UUID bef4d4ff-bcf5-407e-8a8d-c0c14aba5994 2019-01-11 10:26:25,669 DEBUG: Detected virsh default network ip: 192.168.122.1 Warning: firewalld.service changed on disk. Run 'systemctl daemon-reload' to reload units. 2019-01-11 10:26:26,221 DEBUG: Started vbmc for domain baremetal0 2019-01-11 10:26:26,223 DEBUG: vmbcs setup: [{'port': 6230, 'username': 'admin', 'status': 'down', 'libvirt_sasl_password': '***', 'address': '192.168.122.1', 'password': '***', 'libvirt_uri': 'qemu:///system', 'libvirt_sasl_username': None, 'domain_name': 'baremetal0'}] libvirt: Storage Driver error : Storage volume not found: no storage vol with matching name 'baremetal1.qcow2' 2019-01-11 10:26:26,278.278 12022 INFO VirtualBMC [-] Virtual BMC for domain baremetal0 started 2019-01-11 10:26:26,365 DEBUG: Created new storage volume: baremetal1.qcow2 2019-01-11 10:26:26,367 DEBUG: libvirt template is baremetal1 16777216 8 hvm destroy restart restart 2019-01-11 10:26:26,413 INFO: Created machine baremetal1 with UUID cf1ea402-6ace-4571-bb47-99a50cfebde6 2019-01-11 10:26:26,434 DEBUG: Detected virsh default network ip: 192.168.122.1 Warning: firewalld.service changed on disk. Run 'systemctl daemon-reload' to reload units. 2019-01-11 10:26:26,971 DEBUG: Started vbmc for domain baremetal1 2019-01-11 10:26:26,973 DEBUG: vmbcs setup: [{'port': 6230, 'username': 'admin', 'status': 'running', 'libvirt_sasl_password': '***', 'address': '192.168.122.1', 'password': '***', 'libvirt_uri': 'qemu:///system', 'libvirt_sasl_username': None, 'domain_name': 'baremetal0'}, {'port': 6231, 'username': 'admin', 'status': 'down', 'libvirt_sasl_password': '***', 'address': '192.168.122.1', 'password': '***', 'libvirt_uri': 'qemu:///system', 'libvirt_sasl_username': None, 'domain_name': 'baremetal1'}] libvirt: QEMU Driver error : Domain not found: no domain with matching name 'undercloud' 2019-01-11 10:26:26,977 DEBUG: No undercloud VM exists 2019-01-11 10:26:26,977.977 12152 INFO VirtualBMC [-] Virtual BMC for domain baremetal1 started libvirt: Storage Driver error : Storage volume not found: no storage vol with matching name 'undercloud.qcow2' 2019-01-11 10:26:27,115 DEBUG: Created new storage volume: undercloud.qcow2 2019-01-11 10:26:27,117 DEBUG: libvirt template is undercloud 8388608 4 hvm /var/lib/libvirt/images/overcloud-full.vmlinuz /var/lib/libvirt/images/overcloud-full.initrd console=ttyS0 root=/dev/sda destroy restart restart 2019-01-11 10:26:27,149 INFO: Created machine undercloud with UUID 495bca08-6e2b-4a43-879e-d0af994dcd2e 2019-01-11 10:26:53,258 INFO: Virt customizing target disk: /var/lib/libvirt/images/undercloud.qcow2 2019-01-11 10:26:53,259 DEBUG: Virt-customizing with: ['virt-customize', '--root-password', 'password:opnfvapex', '--run-command', 'mkdir -p /root/.ssh', '--upload', '/root/.ssh/id_rsa.pub:/root/.ssh/authorized_keys', '--run-command', 'chmod 600 /root/.ssh/authorized_keys', '--run-command', 'restorecon /root/.ssh/authorized_keys', '--run-command', 'cp /root/.ssh/authorized_keys /home/stack/.ssh/', '--run-command', 'chown stack:stack /home/stack/.ssh/authorized_keys', '--run-command', 'chmod 600 /home/stack/.ssh/authorized_keys', '-a', '/var/lib/libvirt/images/undercloud.qcow2'] 2019-01-11 10:28:01,576 DEBUG: b'[ 0.0] Examining the guest ...\n[ 65.5] Setting a random seed\n[ 65.6] Running: mkdir -p /root/.ssh\n[ 65.7] Uploading: /root/.ssh/id_rsa.pub to /root/.ssh/authorized_keys\n[ 65.7] Running: chmod 600 /root/.ssh/authorized_keys\n[ 65.7] Running: restorecon /root/.ssh/authorized_keys\n[ 65.8] Running: cp /root/.ssh/authorized_keys /home/stack/.ssh/\n[ 65.8] Running: chown stack:stack /home/stack/.ssh/authorized_keys\n[ 65.8] Running: chmod 600 /home/stack/.ssh/authorized_keys\n[ 65.8] Setting passwords\n[ 68.1] Finishing off\n' 2019-01-11 10:28:01,579 INFO: Starting undercloud 2019-01-11 10:28:12,319 DEBUG: Did not find undercloud IP in 0 attempts... 2019-01-11 10:28:22,327 INFO: Undercloud started. IP Address: 192.168.122.93 2019-01-11 10:28:22,328 INFO: Creating template for compute 2019-01-11 10:28:22,447 DEBUG: Template output: heat_template_version: 2015-04-30 description: > Software Config to drive os-net-config to configure multiple interfaces for the compute role. parameters: ControlPlaneIp: default: '' description: IP address/subnet on the ctlplane network type: string ExternalIpSubnet: default: '' description: IP address/subnet on the external network type: string InternalApiIpSubnet: default: '' description: IP address/subnet on the internal API network type: string StorageIpSubnet: default: '' description: IP address/subnet on the storage network type: string StorageMgmtIpSubnet: default: '' description: IP address/subnet on the storage mgmt network type: string TenantIpSubnet: default: '' description: IP address/subnet on the tenant network type: string ManagementIpSubnet: # Only populated when including environments/network-management.yaml default: '' description: IP address/subnet on the management network type: string ExternalNetworkVlanID: default: 10 description: Vlan ID for the external network traffic. type: number InternalApiNetworkVlanID: default: 20 description: Vlan ID for the internal_api network traffic. type: number StorageNetworkVlanID: default: 30 description: Vlan ID for the storage network traffic. type: number StorageMgmtNetworkVlanID: default: 40 description: Vlan ID for the storage mgmt network traffic. type: number TenantNetworkVlanID: default: 50 description: Vlan ID for the tenant network traffic. type: number ManagementNetworkVlanID: default: 60 description: Vlan ID for the management network traffic. type: number ExternalInterfaceDefaultRoute: default: '10.0.0.1' description: default route for the external network type: string ControlPlaneSubnetCidr: # Override this via parameter_defaults default: '24' description: The subnet CIDR of the control plane network. type: string ControlPlaneDefaultRoute: # Override this via parameter_defaults description: The default route of the control plane network. type: string DnsServers: # Override this via parameter_defaults default: [] description: A list of DNS servers (2 max for some implementations) that will be added to resolv.conf. type: comma_delimited_list EC2MetadataIp: # Override this via parameter_defaults description: The IP address of the EC2 metadata server. type: string resources: OsNetConfigImpl: type: OS::Heat::StructuredConfig properties: group: os-apply-config config: os_net_config: network_config: - type: interface name: eth0 use_dhcp: false dns_servers: {get_param: DnsServers} addresses: - ip_netmask: list_join: - '/' - - {get_param: ControlPlaneIp} - {get_param: ControlPlaneSubnetCidr} routes: - ip_netmask: 169.254.169.254/32 next_hop: {get_param: EC2MetadataIp} - default: true next_hop: {get_param: ControlPlaneDefaultRoute} - type: interface name: eth1 use_dhcp: false addresses: - ip_netmask: {get_param: TenantIpSubnet} - type: ovs_bridge name: {get_input: bridge_name} use_dhcp: false members: - type: interface name: eth2 # force the MAC address of the bridge to this interface primary: true - type: interface name: eth3 use_dhcp: false addresses: - ip_netmask: {get_param: StorageIpSubnet} outputs: OS::stack_id: description: The OsNetConfigImpl resource. value: {get_resource: OsNetConfigImpl} 2019-01-11 10:28:22,448 INFO: Wrote template /tmp/apex_tmph0diznve/compute.yaml 2019-01-11 10:28:22,448 INFO: Creating template for controller 2019-01-11 10:28:22,506 DEBUG: Template output: heat_template_version: 2015-04-30 description: > Software Config to drive os-net-config to configure multiple interfaces for the controller role. parameters: ControlPlaneIp: default: '' description: IP address/subnet on the ctlplane network type: string ExternalIpSubnet: default: '' description: IP address/subnet on the external network type: string InternalApiIpSubnet: default: '' description: IP address/subnet on the internal API network type: string StorageIpSubnet: default: '' description: IP address/subnet on the storage network type: string StorageMgmtIpSubnet: default: '' description: IP address/subnet on the storage mgmt network type: string TenantIpSubnet: default: '' description: IP address/subnet on the tenant network type: string ManagementIpSubnet: # Only populated when including environments/network-management.yaml default: '' description: IP address/subnet on the management network type: string ExternalNetworkVlanID: default: 10 description: Vlan ID for the external network traffic. type: number InternalApiNetworkVlanID: default: 20 description: Vlan ID for the internal_api network traffic. type: number StorageNetworkVlanID: default: 30 description: Vlan ID for the storage network traffic. type: number StorageMgmtNetworkVlanID: default: 40 description: Vlan ID for the storage mgmt network traffic. type: number TenantNetworkVlanID: default: 50 description: Vlan ID for the tenant network traffic. type: number ManagementNetworkVlanID: default: 60 description: Vlan ID for the management network traffic. type: number ExternalInterfaceDefaultRoute: default: '10.0.0.1' description: default route for the external network type: string ControlPlaneSubnetCidr: # Override this via parameter_defaults default: '24' description: The subnet CIDR of the control plane network. type: string ControlPlaneDefaultRoute: # Override this via parameter_defaults description: The default route of the control plane network. type: string DnsServers: # Override this via parameter_defaults default: [] description: A list of DNS servers (2 max for some implementations) that will be added to resolv.conf. type: comma_delimited_list EC2MetadataIp: # Override this via parameter_defaults description: The IP address of the EC2 metadata server. type: string resources: OsNetConfigImpl: type: OS::Heat::StructuredConfig properties: group: os-apply-config config: os_net_config: network_config: - type: interface name: eth0 use_dhcp: false dns_servers: {get_param: DnsServers} addresses: - ip_netmask: list_join: - '/' - - {get_param: ControlPlaneIp} - {get_param: ControlPlaneSubnetCidr} routes: - ip_netmask: 169.254.169.254/32 next_hop: {get_param: EC2MetadataIp} - type: interface name: eth1 use_dhcp: false addresses: - ip_netmask: {get_param: TenantIpSubnet} - type: ovs_bridge name: {get_input: bridge_name} use_dhcp: false members: - type: interface name: eth2 # force the MAC address of the bridge to this interface primary: true dns_servers: {get_param: DnsServers} addresses: - ip_netmask: {get_param: ExternalIpSubnet} routes: - default: true ip_netmask: 0.0.0.0/0 next_hop: {get_param: ExternalInterfaceDefaultRoute} - type: interface name: eth3 use_dhcp: false addresses: - ip_netmask: {get_param: StorageIpSubnet} outputs: OS::stack_id: description: The OsNetConfigImpl resource. value: {get_resource: OsNetConfigImpl} 2019-01-11 10:28:22,506 INFO: Wrote template /tmp/apex_tmph0diznve/controller.yaml 2019-01-11 10:28:22,506 INFO: Configuring Undercloud... 2019-01-11 10:28:22,507 INFO: Executing ansible playbook: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml 2019-01-11 10:28:22,508 DEBUG: Ansible variables to be set: {'aarch64': False, 'apex_temp_dir': '/tmp/apex_tmph0diznve', 'external_network': {'enabled': True, 'ip': '192.168.37.1', 'prefix': '24', 'vlan': 'native'}, 'ironic_config': ['disk_utils iscsi_verify_attempts 30', 'disk_partitioner check_device_max_retries 40'], 'neutron_config': ['dns_domain opnfvlf.org'], 'nova_config': ['dns_domain opnfvlf.org', 'dhcp_domain opnfvlf.org'], 'undercloud_config': ['enable_ui false', 'undercloud_update_packages false', 'undercloud_debug false', 'inspection_extras false', 'undercloud_hostname undercloud.opnfvlf.org', 'local_ip 192.0.2.1/24', 'network_gateway 192.0.2.1', 'network_cidr 192.0.2.0/24', 'dhcp_start 192.0.2.2', 'dhcp_end 192.0.2.50', 'inspection_iprange 192.0.2.100,192.0.2.120']} 2019-01-11 10:28:22,508 INFO: Executing playbook...this may take some time [DEPRECATION WARNING]: 'include' for playbook includes. You should use 'import_playbook' instead. This feature will be removed in version 2.8. Deprecation warnings can be disabled by setting deprecation_warnings=False in ansible.cfg. 2019-01-11 10:28:23,378 INFO: ansible-playbook 2.5.2 config file = /etc/ansible/ansible.cfg configured module search path = [u'/root/.ansible/plugins/modules', u'/usr/share/ansible/plugins/modules'] ansible python module location = /usr/lib/python2.7/site-packages/ansible executable location = /bin/ansible-playbook python version = 2.7.5 (default, Aug 4 2017, 00:39:18) [GCC 4.8.5 20150623 (Red Hat 4.8.5-16)] Using /etc/ansible/ansible.cfg as config file 2019-01-11 10:28:23,414 INFO: PLAYBOOK: configure_undercloud.yml ********************************************* 2 plays in /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml 2019-01-11 10:28:23,430 INFO: PLAY [all] ********************************************************************* 2019-01-11 10:28:29,817 INFO: TASK [Gathering Facts] ********************************************************* task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:2 ok: [192.168.122.93] META: ran handlers 2019-01-11 10:28:30,717 INFO: TASK [Generate SSH key for stack if missing] *********************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:4 changed: [192.168.122.93] => {"changed": true, "cmd": "test -e ~/.ssh/id_rsa || ssh-keygen -t rsa -N \"\" -f ~/.ssh/id_rsa", "delta": "0:00:00.214022", "end": "2019-01-11 10:28:30.464945", "rc": 0, "start": "2019-01-11 10:28:30.250923", "stderr": "", "stderr_lines": [], "stdout": "Generating public/private rsa key pair. Your identification has been saved in /root/.ssh/id_rsa. Your public key has been saved in /root/.ssh/id_rsa.pub. The key fingerprint is: c1:24:e6:59:9f:dc:8d:90:d2:8d:0d:4f:c3:33:ff:4e root@undercloud The key's randomart image is: +--[ RSA 2048]----+ | o o.oBo | | o *.o+**+ | | o o.+ ++. | | . . | | S . | | E| | o | | .| | | +-----------------+", "stdout_lines": ["Generating public/private rsa key pair.", "Your identification has been saved in /root/.ssh/id_rsa.", "Your public key has been saved in /root/.ssh/id_rsa.pub.", "The key fingerprint is:", "c1:24:e6:59:9f:dc:8d:90:d2:8d:0d:4f:c3:33:ff:4e root@undercloud", "The key's randomart image is:", "+--[ RSA 2048]----+", "| o o.oBo |", "| o *.o+**+ |", "| o o.+ ++. |", "| . . |", "| S . |", "| E|", "| o |", "| .|", "| |", "+-----------------+"]} 2019-01-11 10:28:31,274 INFO: TASK [Fix ssh key for stack] *************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:6 changed: [192.168.122.93] => {"changed": true, "cmd": "restorecon -r /home/stack", "delta": "0:00:00.021231", "end": "2019-01-11 10:28:31.020626", "rc": 0, "start": "2019-01-11 10:28:30.999395", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:28:31,980 INFO: TASK [file] ******************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:9 changed: [192.168.122.93] => {"changed": true, "gid": 1000, "group": "stack", "mode": "0775", "owner": "stack", "path": "/home/stack/nics", "secontext": "unconfined_u:object_r:user_home_t:s0", "size": 6, "state": "directory", "uid": 1000} 2019-01-11 10:28:33,275 INFO: TASK [copy] ******************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:15 changed: [192.168.122.93] => {"changed": true, "checksum": "58671e9bea8129cbf17bd41dcacad9a84da36c15", "dest": "/home/stack/jumphost_id_rsa.pub", "gid": 1000, "group": "stack", "md5sum": "8434dc928bb06a857260617dee48db67", "mode": "0644", "owner": "stack", "secontext": "unconfined_u:object_r:user_home_t:s0", "size": 406, "src": "/home/stack/.ansible/tmp/ansible-tmp-1547202512.08-212365957787504/source", "state": "file", "uid": 1000} 2019-01-11 10:28:35,236 INFO: TASK [copy] ******************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:21 changed: [192.168.122.93] => (item=controller) => {"changed": true, "checksum": "f4fb1e22f89dc8660cae93f8c961bec70bea8d40", "dest": "/home/stack/nics/controller.yaml", "gid": 1000, "group": "stack", "item": "controller", "md5sum": "123d7cd9df2ad56c44c9b189c101d81c", "mode": "0644", "owner": "stack", "secontext": "unconfined_u:object_r:user_home_t:s0", "size": 4424, "src": "/home/stack/.ansible/tmp/ansible-tmp-1547202513.37-221744081843238/source", "state": "file", "uid": 1000} changed: [192.168.122.93] => (item=compute) => {"changed": true, "checksum": "05eca366a648e0ec1f92e75e6c997ca54a800d7d", "dest": "/home/stack/nics/compute.yaml", "gid": 1000, "group": "stack", "item": "compute", "md5sum": "c2c9a15bd3eaf3d445cbfa54642eeee5", "mode": "0644", "owner": "stack", "secontext": "unconfined_u:object_r:user_home_t:s0", "size": 4200, "src": "/home/stack/.ansible/tmp/ansible-tmp-1547202514.32-208934005632579/source", "state": "file", "uid": 1000} 2019-01-11 10:28:35,896 INFO: TASK [lineinfile] ************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:30 ok: [192.168.122.93] => {"backup": "", "changed": false, "found": 0, "msg": ""} 2019-01-11 10:28:41,668 INFO: TASK [openstack-configs undercloud] ******************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:35 changed: [192.168.122.93] => (item=enable_ui false) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT enable_ui false", "delta": "0:00:00.095354", "end": "2019-01-11 10:28:36.269836", "item": "enable_ui false", "rc": 0, "start": "2019-01-11 10:28:36.174482", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=undercloud_update_packages false) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT undercloud_update_packages false", "delta": "0:00:00.073565", "end": "2019-01-11 10:28:36.828584", "item": "undercloud_update_packages false", "rc": 0, "start": "2019-01-11 10:28:36.755019", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=undercloud_debug false) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT undercloud_debug false", "delta": "0:00:00.081830", "end": "2019-01-11 10:28:37.402913", "item": "undercloud_debug false", "rc": 0, "start": "2019-01-11 10:28:37.321083", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=inspection_extras false) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT inspection_extras false", "delta": "0:00:00.075149", "end": "2019-01-11 10:28:37.950132", "item": "inspection_extras false", "rc": 0, "start": "2019-01-11 10:28:37.874983", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=undercloud_hostname undercloud.opnfvlf.org) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT undercloud_hostname undercloud.opnfvlf.org", "delta": "0:00:00.075517", "end": "2019-01-11 10:28:38.533951", "item": "undercloud_hostname undercloud.opnfvlf.org", "rc": 0, "start": "2019-01-11 10:28:38.458434", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=local_ip 192.0.2.1/24) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT local_ip 192.0.2.1/24", "delta": "0:00:00.064464", "end": "2019-01-11 10:28:39.033055", "item": "local_ip 192.0.2.1/24", "rc": 0, "start": "2019-01-11 10:28:38.968591", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=network_gateway 192.0.2.1) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT network_gateway 192.0.2.1", "delta": "0:00:00.064375", "end": "2019-01-11 10:28:39.520412", "item": "network_gateway 192.0.2.1", "rc": 0, "start": "2019-01-11 10:28:39.456037", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=network_cidr 192.0.2.0/24) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT network_cidr 192.0.2.0/24", "delta": "0:00:00.066931", "end": "2019-01-11 10:28:39.990561", "item": "network_cidr 192.0.2.0/24", "rc": 0, "start": "2019-01-11 10:28:39.923630", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=dhcp_start 192.0.2.2) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT dhcp_start 192.0.2.2", "delta": "0:00:00.066391", "end": "2019-01-11 10:28:40.468527", "item": "dhcp_start 192.0.2.2", "rc": 0, "start": "2019-01-11 10:28:40.402136", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=dhcp_end 192.0.2.50) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT dhcp_end 192.0.2.50", "delta": "0:00:00.064665", "end": "2019-01-11 10:28:40.944975", "item": "dhcp_end 192.0.2.50", "rc": 0, "start": "2019-01-11 10:28:40.880310", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=inspection_iprange 192.0.2.100,192.0.2.120) => {"changed": true, "cmd": "openstack-config --set undercloud.conf DEFAULT inspection_iprange 192.0.2.100,192.0.2.120", "delta": "0:00:00.070161", "end": "2019-01-11 10:28:41.420581", "item": "inspection_iprange 192.0.2.100,192.0.2.120", "rc": 0, "start": "2019-01-11 10:28:41.350420", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:28:42,932 INFO: TASK [openstack-configs ironic] ************************************************ task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:38 changed: [192.168.122.93] => (item=disk_utils iscsi_verify_attempts 30) => {"changed": true, "cmd": "openstack-config --set /etc/ironic/ironic.conf disk_utils iscsi_verify_attempts 30", "delta": "0:00:00.101280", "end": "2019-01-11 10:28:42.187874", "item": "disk_utils iscsi_verify_attempts 30", "rc": 0, "start": "2019-01-11 10:28:42.086594", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} changed: [192.168.122.93] => (item=disk_partitioner check_device_max_retries 40) => {"changed": true, "cmd": "openstack-config --set /etc/ironic/ironic.conf disk_partitioner check_device_max_retries 40", "delta": "0:00:00.096350", "end": "2019-01-11 10:28:42.691612", "item": "disk_partitioner check_device_max_retries 40", "rc": 0, "start": "2019-01-11 10:28:42.595262", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:28:42,964 INFO: TASK [openstack-configs undercloud aarch64] ************************************ task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:42 skipping: [192.168.122.93] => {"changed": false, "skip_reason": "Conditional result was False"} 2019-01-11 10:28:42,995 INFO: TASK [lineinfile] ************************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:45 skipping: [192.168.122.93] => {"changed": false, "skip_reason": "Conditional result was False"} 2019-01-11 10:32:11,853 INFO: TASK [undercloud install] ****************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:51 fatal: [192.168.122.93]: FAILED! => {"changed": true, "cmd": "openstack undercloud install &> apex-undercloud-install.log", "delta": "0:03:28.551160", "end": "2019-01-11 10:32:11.767315", "msg": "non-zero return code", "rc": 1, "start": "2019-01-11 10:28:43.216155", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:34:02,253 INFO: TASK [undercloud install retry] ************************************************ task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:56 fatal: [192.168.122.93]: FAILED! => {"changed": true, "cmd": "openstack undercloud install >> apex-undercloud-install.log 2>&1", "delta": "0:01:49.814179", "end": "2019-01-11 10:34:02.159177", "msg": "non-zero return code", "rc": 1, "start": "2019-01-11 10:32:12.344998", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2019-01-11 10:34:03,034 INFO: TASK [fetch undercloud log] **************************************************** task path: /usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.yml:61 changed: [192.168.122.93] => {"changed": true, "checksum": "0b097fd0f004966c79072cf1e57db7ed38f6b5d1", "dest": "/tmp/apex_tmph0diznve/apex-undercloud-install.log", "md5sum": "c3997cb4e892a5d5a34e58208a2302d4", "remote_checksum": "0b097fd0f004966c79072cf1e57db7ed38f6b5d1", "remote_md5sum": null} to retry, use: --limit @/usr/share/opnfv-apex/ansible/playbooks/configure_undercloud.retry 2019-01-11 10:34:03,034 INFO: PLAY RECAP ********************************************************************* 192.168.122.93 : ok=10 changed=8 unreachable=0 failed=2 2019-01-11 10:34:03,103 ERROR: Ansible playbook failed. See Ansible logs for details. Traceback (most recent call last): File "/bin/opnfv-deploy", line 10, in sys.exit(main()) File "/usr/lib/python3.4/site-packages/apex/deploy.py", line 339, in main APEX_TEMP_DIR) File "/usr/lib/python3.4/site-packages/apex/undercloud/undercloud.py", line 126, in configure user='stack') File "/usr/lib/python3.4/site-packages/apex/common/utils.py", line 131, in run_ansible raise Exception(e) Exception: Ansible playbook failed. See Ansible logs for details.