2019-11-25 02:05:35,994 [salt.utils.decorators:613 ][WARNING ][2161] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:05:36,554 [salt.utils.decorators:613 ][WARNING ][2161] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:05:38,749 [salt.loaded.int.states.file:2298][WARNING ][2385] State for file: /etc/maas/rackd.conf - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-11-25 02:05:58,828 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2999] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-11-25 02:05:58,857 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2999] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-11-25 02:05:58,878 [salt.utils.parsers:1051][WARNING ][362] Minion received a SIGTERM. Exiting.
2019-11-25 02:05:59,804 [salt.cli.daemons :293 ][INFO    ][3110] Setting up the Salt Minion "mas01.mcp-ovs-ha.local"
2019-11-25 02:05:59,881 [salt.cli.daemons :82  ][INFO    ][3110] Starting up the Salt Minion
2019-11-25 02:05:59,881 [salt.utils.event :1017][INFO    ][3110] Starting pull socket on /var/run/salt/minion/minion_event_501f9ec045_pull.ipc
2019-11-25 02:06:00,667 [salt.minion      :976 ][INFO    ][3110] Creating minion process manager
2019-11-25 02:06:01,952 [salt.loader.10.20.0.2.int.module.cmdmod:395 ][INFO    ][3110] Executing command ['date', '+%z'] in directory '/root'
2019-11-25 02:06:01,973 [salt.utils.schedule:568 ][INFO    ][3110] Updating job settings for scheduled job: __mine_interval
2019-11-25 02:06:01,974 [salt.minion      :1108][INFO    ][3110] Added mine.update to scheduler
2019-11-25 02:06:01,978 [salt.minion      :1975][INFO    ][3110] Minion is starting as user 'root'
2019-11-25 02:06:01,988 [salt.minion      :2336][INFO    ][3110] Minion is ready to receive requests!
2019-11-25 02:06:03,933 [salt.state       :2022][WARNING ][2995] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2019-11-25 02:06:06,416 [salt.utils.decorators:613 ][WARNING ][2995] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:06:12,409 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020612396835
2019-11-25 02:06:12,428 [salt.minion      :1432][INFO    ][3544] Starting a new job with PID 3544
2019-11-25 02:06:12,439 [salt.minion      :1711][INFO    ][3544] Returning information for job: 20191125020612396835
2019-11-25 02:06:42,457 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020642439774
2019-11-25 02:06:42,481 [salt.minion      :1432][INFO    ][3826] Starting a new job with PID 3826
2019-11-25 02:06:42,505 [salt.minion      :1711][INFO    ][3826] Returning information for job: 20191125020642439774
2019-11-25 02:06:53,396 [salt.utils.decorators:613 ][WARNING ][2995] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:07:12,537 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020712526527
2019-11-25 02:07:12,565 [salt.minion      :1432][INFO    ][3937] Starting a new job with PID 3937
2019-11-25 02:07:12,588 [salt.minion      :1711][INFO    ][3937] Returning information for job: 20191125020712526527
2019-11-25 02:07:32,323 [salt.utils.decorators:613 ][WARNING ][2995] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:07:33,425 [salt.utils.decorators:613 ][WARNING ][2995] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:07:36,512 [salt.loaded.ext.module.maasng:1008][WARNING ][2995] Detected cidr:192.168.11.0/24 in fabric:fabric-2
2019-11-25 02:07:36,513 [salt.loaded.ext.module.maasng:1011][WARNING ][2995] Guessing, that fabric with current name:fabric-2
 should be renamed to:pxe_admin
2019-11-25 02:07:37,311 [salt.loaded.ext.module.maasng:1235][WARNING ][2995] Ignoring parameter vlan:0
2019-11-25 02:07:39,207 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command state.apply with jid 20191125020739194283
2019-11-25 02:07:39,225 [salt.minion      :1432][INFO    ][4498] Starting a new job with PID 4498
2019-11-25 02:07:43,673 [salt.state       :915 ][INFO    ][4498] Loading fresh modules for state activity
2019-11-25 02:07:43,729 [salt.fileclient  :1219][INFO    ][4498] Fetching file from saltenv 'base', ** done ** 'maas/machines/init.sls'
2019-11-25 02:07:43,767 [salt.state       :1780][INFO    ][4498] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:07:43.767842
2019-11-25 02:07:43,768 [salt.state       :1813][INFO    ][4498] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-11-25 02:07:43,770 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4498] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-11-25 02:07:45,321 [salt.state       :300 ][INFO    ][4498] {'pid': 4525, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-11-25 02:07:45,322 [salt.state       :1951][INFO    ][4498] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:07:45.322393 duration_in_ms=1554.55
2019-11-25 02:07:45,325 [salt.state       :1780][INFO    ][4498] Running state [maas.process_machines] at time 02:07:45.325015
2019-11-25 02:07:45,325 [salt.state       :1813][INFO    ][4498] Executing state module.run for [maas.process_machines]
2019-11-25 02:07:45,326 [salt.utils.decorators:613 ][WARNING ][4498] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:07:45,407 [salt.loaded.ext.module.maas:412 ][WARNING ][4498] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-11-25 02:07:45,407 [salt.loaded.ext.module.maas:92  ][INFO    ][4498] machine hostname=cmp002 power_type=ipmi mac_addresses=00:25:b5:a0:00:6a power_parameters_power_address=172.30.8.72 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-11-25 02:07:46,947 [salt.loaded.ext.module.maas:412 ][WARNING ][4498] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-11-25 02:07:46,948 [salt.loaded.ext.module.maas:92  ][INFO    ][4498] machine hostname=cmp001 power_type=ipmi mac_addresses=00:25:b5:a0:00:5a power_parameters_power_address=172.30.8.73 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-11-25 02:07:48,330 [salt.loaded.ext.module.maas:412 ][WARNING ][4498] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-11-25 02:07:48,331 [salt.loaded.ext.module.maas:92  ][INFO    ][4498] machine hostname=kvm01 power_type=ipmi mac_addresses=00:25:b5:a0:00:2a power_parameters_power_address=172.30.8.75 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-11-25 02:07:49,709 [salt.loaded.ext.module.maas:412 ][WARNING ][4498] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-11-25 02:07:49,709 [salt.loaded.ext.module.maas:92  ][INFO    ][4498] machine hostname=kvm03 power_type=ipmi mac_addresses=00:25:b5:a0:00:4a power_parameters_power_address=172.30.8.74 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-11-25 02:07:51,326 [salt.loaded.ext.module.maas:412 ][WARNING ][4498] Old machine-describe detected! Please read documentation for 'salt-formulas/maas' for migration!
2019-11-25 02:07:51,327 [salt.loaded.ext.module.maas:92  ][INFO    ][4498] machine hostname=kvm02 power_type=ipmi mac_addresses=00:25:b5:a0:00:3a power_parameters_power_address=172.30.8.65 power_parameters_power_pass=octopus architecture=amd64/generic power_parameters_power_user=admin
2019-11-25 02:07:52,608 [salt.state       :300 ][INFO    ][4498] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-11-25 02:07:52,608 [salt.state       :1951][INFO    ][4498] Completed state [maas.process_machines] at time 02:07:52.608568 duration_in_ms=7283.551
2019-11-25 02:07:52,637 [salt.minion      :1711][INFO    ][4498] Returning information for job: 20191125020739194283
2019-11-25 02:08:23,685 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command state.apply with jid 20191125020823668815
2019-11-25 02:08:23,711 [salt.minion      :1432][INFO    ][4840] Starting a new job with PID 4840
2019-11-25 02:08:27,521 [salt.state       :915 ][INFO    ][4840] Loading fresh modules for state activity
2019-11-25 02:08:27,579 [salt.fileclient  :1219][INFO    ][4840] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_ready_or_deployed.sls'
2019-11-25 02:08:27,631 [salt.state       :1780][INFO    ][4840] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:08:27.631363
2019-11-25 02:08:27,631 [salt.state       :1813][INFO    ][4840] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-11-25 02:08:27,634 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4840] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-11-25 02:08:28,951 [salt.state       :300 ][INFO    ][4840] {'pid': 4855, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-11-25 02:08:28,952 [salt.state       :1951][INFO    ][4840] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:08:28.952065 duration_in_ms=1320.702
2019-11-25 02:08:28,954 [salt.state       :1780][INFO    ][4840] Running state [maas.wait_for_machine_status] at time 02:08:28.954481
2019-11-25 02:08:28,955 [salt.state       :1813][INFO    ][4840] Executing state module.run for [maas.wait_for_machine_status]
2019-11-25 02:08:28,955 [salt.utils.decorators:613 ][WARNING ][4840] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:08:29,913 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1499.052912s left)
2019-11-25 02:08:38,806 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020838790117
2019-11-25 02:08:38,833 [salt.minion      :1432][INFO    ][4880] Starting a new job with PID 4880
2019-11-25 02:08:38,853 [salt.minion      :1711][INFO    ][4880] Returning information for job: 20191125020838790117
2019-11-25 02:09:00,853 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1468.11220503s left)
2019-11-25 02:09:08,862 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020908849251
2019-11-25 02:09:08,889 [salt.minion      :1432][INFO    ][4918] Starting a new job with PID 4918
2019-11-25 02:09:08,913 [salt.minion      :1711][INFO    ][4918] Returning information for job: 20191125020908849251
2019-11-25 02:09:31,980 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1436.985605s left)
2019-11-25 02:09:38,901 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125020938888071
2019-11-25 02:09:38,927 [salt.minion      :1432][INFO    ][5054] Starting a new job with PID 5054
2019-11-25 02:09:38,947 [salt.minion      :1711][INFO    ][5054] Returning information for job: 20191125020938888071
2019-11-25 02:10:03,389 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1405.57678604s left)
2019-11-25 02:10:08,958 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021008946313
2019-11-25 02:10:08,983 [salt.minion      :1432][INFO    ][5452] Starting a new job with PID 5452
2019-11-25 02:10:09,003 [salt.minion      :1711][INFO    ][5452] Returning information for job: 20191125021008946313
2019-11-25 02:10:34,954 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1374.01151896s left)
2019-11-25 02:10:39,011 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021038998928
2019-11-25 02:10:39,037 [salt.minion      :1432][INFO    ][5740] Starting a new job with PID 5740
2019-11-25 02:10:39,056 [salt.minion      :1711][INFO    ][5740] Returning information for job: 20191125021038998928
2019-11-25 02:11:06,648 [salt.loaded.ext.module.maas:1023][INFO    ][4840] Waiting status:Ready|Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:1500s (1342.31733394s left)
2019-11-25 02:11:09,070 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021109056070
2019-11-25 02:11:09,096 [salt.minion      :1432][INFO    ][5982] Starting a new job with PID 5982
2019-11-25 02:11:09,119 [salt.minion      :1711][INFO    ][5982] Returning information for job: 20191125021109056070
2019-11-25 02:11:39,138 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021139124466
2019-11-25 02:11:39,166 [salt.minion      :1432][INFO    ][6140] Starting a new job with PID 6140
2019-11-25 02:11:39,189 [salt.minion      :1711][INFO    ][6140] Returning information for job: 20191125021139124466
2019-11-25 02:11:40,334 [salt.state       :300 ][INFO    ][4840] {'ret': True}
2019-11-25 02:11:40,335 [salt.state       :1951][INFO    ][4840] Completed state [maas.wait_for_machine_status] at time 02:11:40.335181 duration_in_ms=191380.699
2019-11-25 02:11:40,339 [salt.minion      :1711][INFO    ][4840] Returning information for job: 20191125020823668815
2019-11-25 02:11:41,002 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command state.apply with jid 20191125021140984446
2019-11-25 02:11:41,028 [salt.minion      :1432][INFO    ][6149] Starting a new job with PID 6149
2019-11-25 02:11:44,784 [salt.state       :915 ][INFO    ][6149] Loading fresh modules for state activity
2019-11-25 02:11:44,836 [salt.fileclient  :1219][INFO    ][6149] Fetching file from saltenv 'base', ** done ** 'maas/machines/storage.sls'
2019-11-25 02:11:44,926 [salt.state       :1780][INFO    ][6149] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:11:44.926534
2019-11-25 02:11:44,926 [salt.state       :1813][INFO    ][6149] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-11-25 02:11:44,928 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6149] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-11-25 02:11:46,440 [salt.state       :300 ][INFO    ][6149] {'pid': 6157, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-11-25 02:11:46,441 [salt.state       :1951][INFO    ][6149] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:11:46.441741 duration_in_ms=1515.206
2019-11-25 02:11:46,444 [salt.state       :1780][INFO    ][6149] Running state [maas_machines_storage_cmp002_lvm] at time 02:11:46.444651
2019-11-25 02:11:46,445 [salt.state       :1813][INFO    ][6149] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp002_lvm]
2019-11-25 02:11:47,582 [salt.loaded.ext.module.maasng:610 ][INFO    ][6149] htp8qa
2019-11-25 02:11:47,582 [salt.loaded.ext.module.maasng:626 ][INFO    ][6149] sda
2019-11-25 02:11:48,307 [salt.loaded.ext.module.maasng:361 ][INFO    ][6149] htp8qa
2019-11-25 02:11:48,421 [salt.loaded.ext.module.maasng:367 ][INFO    ][6149] [{u'size': 2397998940160, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/', u'uuid': None, u'tags': [u'rotary'], u'used_for': u'GPT partitioned with 1 partition', u'used_size': 2397998940160, u'name': u'sda', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'htp8qa', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'type': u'physical', u'id': 4, u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'2d809b38-a51f-4780-961a-1fee1fd3a0ac', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'htp8qa', u'device_id': 4, u'filesystem': {u'uuid': u'085049e5-56c6-4ec3-9140-11ac67854c3a', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/partition/8', u'type': u'partition', u'id': 8, u'size': 2397992648704}]}, {u'size': 2397988454400, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/13/', u'uuid': u'd84153a1-f9e9-4f98-9145-205452f7cbf5', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 2397988454400, u'name': u'vgroot-lvroot', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'htp8qa', u'partition_table_type': None, u'filesystem': {u'uuid': u'985d9688-5eee-47f6-bd0b-8e95e7638bcb', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'id': 13, u'serial': None, u'partitions': []}]
2019-11-25 02:11:48,422 [salt.loaded.ext.module.maasng:632 ][INFO    ][6149] vgroot
2019-11-25 02:11:48,422 [salt.loaded.ext.module.maasng:635 ][INFO    ][6149] lvroot
2019-11-25 02:11:48,423 [salt.loaded.ext.module.maasng:639 ][INFO    ][6149] 107374182400
2019-11-25 02:11:48,938 [salt.loaded.ext.module.maasng:645 ][INFO    ][6149] {u'hwe_kernel': u'', u'swap_size': None, u'boot_interface': {u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42', u'id': 47, u'mode': u'dhcp'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42'}], u'parents': [], u'mac_address': u'00:25:b5:a0:00:6a', u'params': u'', u'system_id': u'htp8qa', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/interfaces/4/'}, u'ip_addresses': [u'192.168.11.42'], u'cpu_count': 16, u'power_type': u'ipmi', u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'memory_test_status_name': u'Unknown', u'min_hwe_kernel': u'hwe-16.04', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'boot_disk': {u'model': u'UCSB-MRAID12G', u'partition_table_type': u'GPT', u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'used_for': u'GPT partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'htp8qa', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'available_size': 0, u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'd2739faa-d2d7-43ff-839c-c4b7f097feb8', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'htp8qa', u'device_id': 4, u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'51c34eaf-58dc-4378-af6e-0235b61eb055', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/partition/10', u'type': u'partition', u'id': 10, u'size': 2397992648704}], u'type': u'physical', u'id': 4, u'size': 2397998940160}, u'zone': {u'description': u'', u'resource_uri': u'/MAAS/api/2.0/zones/default/', u'id': 1, u'name': u'default'}, u'resource_uri': u'/MAAS/api/2.0/machines/htp8qa/', u'hostname': u'cmp002', u'storage': 2397998.9401599998, u'node_type': 0, u'testing_status': 2, u'system_id': u'htp8qa', u'power_state': u'on', u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u"From 'Testing' to 'Ready'", u'virtualblockdevice_set': [{u'model': None, u'partition_table_type': None, u'block_size': 4096, u'uuid': u'8044dcf7-7057-4ffa-a7c8-13d64ab7d0e7', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'used_for': u'ext4 formatted filesystem mounted at /', u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'system_id': u'htp8qa', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/15/', u'filesystem': {u'mount_options': None, u'fstype': u'ext4', u'mount_point': u'/', u'uuid': u'8393acbb-9e98-47cb-a37c-6b101cc77eda', u'label': u'root'}, u'id_path': None, u'available_size': 0, u'serial': None, u'partitions': [], u'type': u'virtual', u'id': 15, u'size': 107374182400}], u'blockdevice_set': [{u'model': u'UCSB-MRAID12G', u'partition_table_type': u'GPT', u'block_size': 4096, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'htp8qa', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'd2739faa-d2d7-43ff-839c-c4b7f097feb8', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'htp8qa', u'device_id': 4, u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'51c34eaf-58dc-4378-af6e-0235b61eb055', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/partition/10', u'type': u'partition', u'id': 10, u'size': 2397992648704}], u'type': u'physical', u'id': 4, u'size': 2397998940160}, {u'model': None, u'partition_table_type': None, u'block_size': 4096, u'available_size': 0, u'uuid': u'8044dcf7-7057-4ffa-a7c8-13d64ab7d0e7', u'name': u'vgroot-lvroot', u'tags': [], u'used_size': 107374182400, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'htp8qa', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/15/', u'filesystem': {u'mount_options': None, u'fstype': u'ext4', u'mount_point': u'/', u'uuid': u'8393acbb-9e98-47cb-a37c-6b101cc77eda', u'label': u'root'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'partitions': [], u'type': u'virtual', u'id': 15, u'size': 107374182400}], u'status': 4, u'bcaches': [], u'storage_test_status_name': u'Passed', u'raids': [], u'owner_data': {}, u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'htp8qa', u'id': 10}], u'special_filesystems': [], u'current_commissioning_result_id': 2, u'node_type_name': u'Machine', u'interface_set': [{u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42', u'id': 47, u'mode': u'dhcp'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 2, u'dhcp_on': True, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.42'}], u'parents': [], u'mac_address': u'00:25:b5:a0:00:6a', u'params': u'', u'system_id': u'htp8qa', u'type': u'physical', u'id': 4, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/interfaces/4/'}, {u'name': u'enp9s0', u'links': [{u'id': 48, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'00:25:b5:a0:00:6d', u'params': u'', u'system_id': u'htp8qa', u'type': u'physical', u'id': 19, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/interfaces/19/'}, {u'name': u'enp8s0', u'links': [{u'id': 50, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'00:25:b5:a0:00:6c', u'params': u'', u'system_id': u'htp8qa', u'type': u'physical', u'id': 22, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/interfaces/22/'}, {u'name': u'enp7s0', u'links': [{u'id': 53, u'mode': u'link_up'}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'fabric_id': 0, u'dhcp_on': False, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'effective_mtu': 1500, u'children': [], u'discovered': None, u'parents': [], u'mac_address': u'00:25:b5:a0:00:6b', u'params': u'', u'system_id': u'htp8qa', u'type': u'physical', u'id': 23, u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/interfaces/23/'}], u'current_testing_result_id': 3, u'cpu_test_status': -1, u'storage_test_status': 2, u'status_name': u'Ready', u'physicalblockdevice_set': [{u'model': u'UCSB-MRAID12G', u'partition_table_type': u'GPT', u'block_size': 4096, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'used_size': 2397998940160, u'used_for': u'GPT partitioned with 1 partition', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'htp8qa', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e728372755980239b15112698bc66', u'available_size': 0, u'serial': u'618e728372755980239b15112698bc66', u'partitions': [{u'uuid': u'd2739faa-d2d7-43ff-839c-c4b7f097feb8', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'htp8qa', u'device_id': 4, u'filesystem': {u'mount_options': None, u'fstype': u'lvm-pv', u'mount_point': None, u'uuid': u'51c34eaf-58dc-4378-af6e-0235b61eb055', u'label': None}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/htp8qa/blockdevices/4/partition/10', u'type': u'partition', u'id': 10, u'size': 2397992648704}], u'type': u'physical', u'id': 4, u'size': 2397998940160}], u'netboot': True, u'osystem': u'', u'fqdn': u'cmp002.maas', u'disable_ipv4': False, u'commissioning_status': 2, u'architecture': u'amd64/generic', u'commissioning_status_name': u'Passed', u'cpu_test_status_name': u'Unknown', u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'memory_test_status': -1}
2019-11-25 02:11:48,940 [salt.state       :300 ][INFO    ][6149] {'new': {'storage_layout': 'lvm'}}
2019-11-25 02:11:48,940 [salt.state       :1951][INFO    ][6149] Completed state [maas_machines_storage_cmp002_lvm] at time 02:11:48.940854 duration_in_ms=2496.194
2019-11-25 02:11:48,941 [salt.state       :1780][INFO    ][6149] Running state [maas_machines_storage_cmp001_lvm] at time 02:11:48.941411
2019-11-25 02:11:48,941 [salt.state       :1813][INFO    ][6149] Executing state maasng.disk_layout_present for [maas_machines_storage_cmp001_lvm]
2019-11-25 02:11:50,399 [salt.loaded.ext.module.maasng:610 ][INFO    ][6149] dyhwym
2019-11-25 02:11:50,399 [salt.loaded.ext.module.maasng:626 ][INFO    ][6149] sda
2019-11-25 02:11:51,116 [salt.loaded.ext.module.maasng:361 ][INFO    ][6149] dyhwym
2019-11-25 02:11:51,248 [salt.loaded.ext.module.maasng:367 ][INFO    ][6149] [{u'size': 2397998940160, u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/', u'uuid': None, u'tags': [u'rotary'], u'used_for': u'GPT partitioned with 1 partition', u'used_size': 2397998940160, u'name': u'sda', u'path': u'/dev/disk/by-dname/sda', u'system_id': u'dyhwym', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'available_size': 0, u'model': u'UCSB-MRAID12G', u'block_size': 4096, u'type': u'physical', u'id': 1, u'serial': u'618e72837274f1901cc7889705aa1b02', u'partitions': [{u'uuid': u'3def889b-99fb-49bb-8481-7960143d5a57', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dyhwym', u'device_id': 1, u'filesystem': {u'uuid': u'e6b0fea0-5f7b-4fda-9fcb-f077addfb0d5', u'label': None, u'mount_point': None, u'mount_options': None, u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/partition/7', u'type': u'partition', u'id': 7, u'size': 2397992648704}]}, {u'size': 2397988454400, u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/12/', u'uuid': u'88061942-7c6d-4e7d-8c9c-70d7043c1d35', u'tags': [], u'used_for': u'ext4 formatted filesystem mounted at /', u'used_size': 2397988454400, u'name': u'vgroot-lvroot', u'path': u'/dev/disk/by-dname/lvroot', u'system_id': u'dyhwym', u'partition_table_type': None, u'filesystem': {u'uuid': u'69e4b7a7-3952-43a3-bd30-faeddbc00ccc', u'label': u'root', u'mount_point': u'/', u'mount_options': None, u'fstype': u'ext4'}, u'id_path': None, u'available_size': 0, u'model': None, u'block_size': 4096, u'type': u'virtual', u'id': 12, u'serial': None, u'partitions': []}]
2019-11-25 02:11:51,248 [salt.loaded.ext.module.maasng:632 ][INFO    ][6149] vgroot
2019-11-25 02:11:51,249 [salt.loaded.ext.module.maasng:635 ][INFO    ][6149] lvroot
2019-11-25 02:11:51,249 [salt.loaded.ext.module.maasng:639 ][INFO    ][6149] 107374182400
2019-11-25 02:11:51,950 [salt.loaded.ext.module.maasng:645 ][INFO    ][6149] {u'hwe_kernel': u'', u'swap_size': None, u'memory_test_status': -1, u'ip_addresses': [u'192.168.11.38'], u'storage_test_status_name': u'Passed', u'owner_data': {}, u'domain': {u'resource_record_count': 0, u'name': u'maas', u'authoritative': True, u'ttl': None, u'id': 0, u'resource_uri': u'/MAAS/api/2.0/domains/0/'}, u'memory_test_status_name': u'Unknown', u'status_action': u'', u'tag_names': [], u'testing_status_name': u'Passed', u'commissioning_status_name': u'Passed', u'owner': None, u'pod': None, u'cache_sets': [], u'iscsiblockdevice_set': [], u'zone': {u'id': 1, u'description': u'', u'name': u'default', u'resource_uri': u'/MAAS/api/2.0/zones/default/'}, u'resource_uri': u'/MAAS/api/2.0/machines/dyhwym/', u'hostname': u'cmp001', u'storage': 2397998.9401599998, u'node_type': 0, u'testing_status': 2, u'system_id': u'dyhwym', u'raids': [], u'memory': 32768, u'current_installation_result_id': None, u'default_gateways': {u'ipv4': {u'gateway_ip': None, u'link_id': None}, u'ipv6': {u'gateway_ip': None, u'link_id': None}}, u'status_message': u"From 'Testing' to 'Ready'", u'virtualblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'uuid': u'53a02dd4-5237-4ef6-ae6a-cc73b359b8e1', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'id': 16, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dyhwym', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'd3039f6a-6483-45ff-a4cb-95b3f7796c18', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/vgroot-lvroot', u'serial': None, u'size': 107374182400, u'used_size': 107374182400, u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/16/'}], u'blockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'partitions': [{u'uuid': u'5fbbb8e0-8fd9-4af8-a9ab-f8a4e33896cd', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dyhwym', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'a019e72d-5f58-4899-88a6-cdb9935ea485', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 11, u'device_id': 1}], u'id': 1, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'dyhwym', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e72837274f1901cc7889705aa1b02', u'size': 2397998940160, u'used_size': 2397998940160, u'model': u'UCSB-MRAID12G', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/'}, {u'block_size': 4096, u'available_size': 0, u'uuid': u'53a02dd4-5237-4ef6-ae6a-cc73b359b8e1', u'name': u'vgroot-lvroot', u'tags': [], u'type': u'virtual', u'partitions': [], u'id': 16, u'used_for': u'ext4 formatted filesystem mounted at /', u'system_id': u'dyhwym', u'partition_table_type': None, u'filesystem': {u'mount_options': None, u'label': u'root', u'mount_point': u'/', u'uuid': u'd3039f6a-6483-45ff-a4cb-95b3f7796c18', u'fstype': u'ext4'}, u'id_path': None, u'path': u'/dev/disk/by-dname/lvroot', u'serial': None, u'size': 107374182400, u'used_size': 107374182400, u'model': None, u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/16/'}], u'status': 4, u'storage_test_status': 2, u'cpu_count': 16, u'power_state': u'on', u'power_type': u'ipmi', u'physicalblockdevice_set': [{u'block_size': 4096, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'partitions': [{u'uuid': u'5fbbb8e0-8fd9-4af8-a9ab-f8a4e33896cd', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dyhwym', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'a019e72d-5f58-4899-88a6-cdb9935ea485', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 11, u'device_id': 1}], u'id': 1, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'dyhwym', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e72837274f1901cc7889705aa1b02', u'size': 2397998940160, u'used_size': 2397998940160, u'model': u'UCSB-MRAID12G', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/'}], u'other_test_status_name': u'Unknown', u'volume_groups': [{u'__incomplete__': True, u'system_id': u'dyhwym', u'id': 11}], u'special_filesystems': [], u'current_commissioning_result_id': 4, u'node_type_name': u'Machine', u'interface_set': [{u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 41}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'00:25:b5:a0:00:5a', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'dyhwym', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/interfaces/5/'}, {u'name': u'enp8s0', u'links': [{u'mode': u'link_up', u'id': 45}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 12, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5c', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'dyhwym', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/interfaces/12/'}, {u'name': u'enp9s0', u'links': [{u'mode': u'link_up', u'id': 46}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 14, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5d', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'dyhwym', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/interfaces/14/'}, {u'name': u'enp7s0', u'links': [{u'mode': u'link_up', u'id': 43}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': False, u'fabric_id': 0, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'fabric-0', u'relay_vlan': None, u'primary_rack': None, u'id': 5001, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5001/'}, u'enabled': True, u'id': 9, u'discovered': None, u'mac_address': u'00:25:b5:a0:00:5b', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'dyhwym', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/interfaces/9/'}], u'current_testing_result_id': 5, u'cpu_test_status': -1, u'architecture': u'amd64/generic', u'bcaches': [], u'status_name': u'Ready', u'netboot': True, u'osystem': u'', u'fqdn': u'cmp001.maas', u'disable_ipv4': False, u'commissioning_status': 2, u'min_hwe_kernel': u'hwe-16.04', u'boot_interface': {u'name': u'enp6s0', u'links': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38', u'mode': u'dhcp', u'id': 41}], u'tags': [], u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'enabled': True, u'id': 5, u'discovered': [{u'subnet': {u'dns_servers': [], u'managed': True, u'name': u'192.168.11.0/24', u'space': u'undefined', u'vlan': {u'name': u'untagged', u'vid': 0, u'space': u'undefined', u'dhcp_on': True, u'fabric_id': 2, u'mtu': 1500, u'external_dhcp': None, u'fabric': u'pxe_admin', u'relay_vlan': None, u'primary_rack': u'w64aw6', u'id': 5003, u'secondary_rack': None, u'resource_uri': u'/MAAS/api/2.0/vlans/5003/'}, u'allow_proxy': True, u'rdns_mode': 2, u'gateway_ip': u'192.168.11.3', u'active_discovery': False, u'cidr': u'192.168.11.0/24', u'id': 3, u'resource_uri': u'/MAAS/api/2.0/subnets/3/'}, u'ip_address': u'192.168.11.38'}], u'mac_address': u'00:25:b5:a0:00:5a', u'parents': [], u'effective_mtu': 1500, u'params': u'', u'system_id': u'dyhwym', u'type': u'physical', u'children': [], u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/interfaces/5/'}, u'cpu_test_status_name': u'Unknown', u'address_ttl': None, u'other_test_status': -1, u'distro_series': u'', u'boot_disk': {u'block_size': 4096, u'available_size': 0, u'uuid': None, u'name': u'sda', u'tags': [u'rotary'], u'type': u'physical', u'partitions': [{u'uuid': u'5fbbb8e0-8fd9-4af8-a9ab-f8a4e33896cd', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/partition/11', u'bootable': False, u'used_for': u'LVM volume for vgroot', u'system_id': u'dyhwym', u'filesystem': {u'mount_options': None, u'label': None, u'mount_point': None, u'uuid': u'a019e72d-5f58-4899-88a6-cdb9935ea485', u'fstype': u'lvm-pv'}, u'path': u'/dev/disk/by-dname/sda-part2', u'size': 2397992648704, u'type': u'partition', u'id': 11, u'device_id': 1}], u'id': 1, u'used_for': u'GPT partitioned with 1 partition', u'system_id': u'dyhwym', u'partition_table_type': u'GPT', u'filesystem': None, u'id_path': u'/dev/disk/by-id/wwn-0x618e72837274f1901cc7889705aa1b02', u'path': u'/dev/disk/by-dname/sda', u'serial': u'618e72837274f1901cc7889705aa1b02', u'size': 2397998940160, u'used_size': 2397998940160, u'model': u'UCSB-MRAID12G', u'resource_uri': u'/MAAS/api/2.0/nodes/dyhwym/blockdevices/1/'}}
2019-11-25 02:11:51,952 [salt.state       :300 ][INFO    ][6149] {'new': {'storage_layout': 'lvm'}}
2019-11-25 02:11:51,953 [salt.state       :1951][INFO    ][6149] Completed state [maas_machines_storage_cmp001_lvm] at time 02:11:51.953277 duration_in_ms=3011.865
2019-11-25 02:11:51,957 [salt.minion      :1711][INFO    ][6149] Returning information for job: 20191125021140984446
2019-11-25 02:11:52,557 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command state.apply with jid 20191125021152540600
2019-11-25 02:11:52,582 [salt.minion      :1432][INFO    ][6176] Starting a new job with PID 6176
2019-11-25 02:11:53,381 [salt.state       :915 ][INFO    ][6176] Loading fresh modules for state activity
2019-11-25 02:11:53,435 [salt.fileclient  :1219][INFO    ][6176] Fetching file from saltenv 'base', ** done ** 'maas/machines/deploy.sls'
2019-11-25 02:11:53,479 [salt.state       :1780][INFO    ][6176] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:11:53.479382
2019-11-25 02:11:53,479 [salt.state       :1813][INFO    ][6176] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-11-25 02:11:53,481 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6176] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-11-25 02:11:55,077 [salt.state       :300 ][INFO    ][6176] {'pid': 6183, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-11-25 02:11:55,078 [salt.state       :1951][INFO    ][6176] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:11:55.077903 duration_in_ms=1598.521
2019-11-25 02:11:55,080 [salt.state       :1780][INFO    ][6176] Running state [maas.deploy_machines] at time 02:11:55.080576
2019-11-25 02:11:55,081 [salt.state       :1813][INFO    ][6176] Executing state module.run for [maas.deploy_machines]
2019-11-25 02:11:55,082 [salt.utils.decorators:613 ][WARNING ][6176] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:11:55,770 [salt.loaded.ext.module.maas:684 ][INFO    ][6176] deploymachines hwe_kernel=hwe-16.04 system_id=htp8qa distro_series=xenial
2019-11-25 02:11:59,309 [salt.loaded.ext.module.maas:684 ][INFO    ][6176] deploymachines hwe_kernel=hwe-16.04 system_id=dyhwym distro_series=xenial
2019-11-25 02:12:02,077 [salt.loaded.ext.module.maas:684 ][INFO    ][6176] deploymachines hwe_kernel=hwe-16.04 system_id=far34m distro_series=xenial
2019-11-25 02:12:04,826 [salt.loaded.ext.module.maas:684 ][INFO    ][6176] deploymachines hwe_kernel=hwe-16.04 system_id=thxhdh distro_series=xenial
2019-11-25 02:12:07,652 [salt.loaded.ext.module.maas:684 ][INFO    ][6176] deploymachines hwe_kernel=hwe-16.04 system_id=fepfhp distro_series=xenial
2019-11-25 02:12:07,656 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021207643510
2019-11-25 02:12:07,681 [salt.minion      :1432][INFO    ][6506] Starting a new job with PID 6506
2019-11-25 02:12:07,699 [salt.minion      :1711][INFO    ][6506] Returning information for job: 20191125021207643510
2019-11-25 02:12:10,389 [salt.state       :300 ][INFO    ][6176] {'ret': {'updated': [], 'errors': {}, 'success': ['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']}}
2019-11-25 02:12:10,389 [salt.state       :1951][INFO    ][6176] Completed state [maas.deploy_machines] at time 02:12:10.389698 duration_in_ms=15309.12
2019-11-25 02:12:10,438 [salt.minion      :1711][INFO    ][6176] Returning information for job: 20191125021152540600
2019-11-25 02:12:11,085 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command state.apply with jid 20191125021211068447
2019-11-25 02:12:11,111 [salt.minion      :1432][INFO    ][6563] Starting a new job with PID 6563
2019-11-25 02:12:14,970 [salt.state       :915 ][INFO    ][6563] Loading fresh modules for state activity
2019-11-25 02:12:15,025 [salt.fileclient  :1219][INFO    ][6563] Fetching file from saltenv 'base', ** done ** 'maas/machines/wait_for_deployed.sls'
2019-11-25 02:12:15,071 [salt.state       :1780][INFO    ][6563] Running state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:12:15.071875
2019-11-25 02:12:15,072 [salt.state       :1813][INFO    ][6563] Executing state cmd.run for [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials]
2019-11-25 02:12:15,074 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6563] Executing command 'maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials' in directory '/root'
2019-11-25 02:12:16,497 [salt.state       :300 ][INFO    ][6563] {'pid': 6580, 'retcode': 0, 'stderr': '', 'stdout': ''}
2019-11-25 02:12:16,497 [salt.state       :1951][INFO    ][6563] Completed state [maas-region apikey --username opnfv > /var/lib/maas/.maas_credentials] at time 02:12:16.497717 duration_in_ms=1425.843
2019-11-25 02:12:16,499 [salt.state       :1780][INFO    ][6563] Running state [maas.wait_for_machine_status] at time 02:12:16.499210
2019-11-25 02:12:16,499 [salt.state       :1813][INFO    ][6563] Executing state module.run for [maas.wait_for_machine_status]
2019-11-25 02:12:16,499 [salt.utils.decorators:613 ][WARNING ][6563] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-11-25 02:12:19,651 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2246.85257101s left)
2019-11-25 02:12:26,142 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021226128942
2019-11-25 02:12:26,167 [salt.minion      :1432][INFO    ][6591] Starting a new job with PID 6591
2019-11-25 02:12:26,191 [salt.minion      :1711][INFO    ][6591] Returning information for job: 20191125021226128942
2019-11-25 02:12:53,269 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2213.23438597s left)
2019-11-25 02:12:56,201 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021256188099
2019-11-25 02:12:56,229 [salt.minion      :1432][INFO    ][6630] Starting a new job with PID 6630
2019-11-25 02:12:56,248 [salt.minion      :1711][INFO    ][6630] Returning information for job: 20191125021256188099
2019-11-25 02:13:26,245 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021326233219
2019-11-25 02:13:26,271 [salt.minion      :1432][INFO    ][6670] Starting a new job with PID 6670
2019-11-25 02:13:26,295 [salt.minion      :1711][INFO    ][6670] Returning information for job: 20191125021326233219
2019-11-25 02:13:26,707 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2179.79669309s left)
2019-11-25 02:13:56,287 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021356275269
2019-11-25 02:13:56,308 [salt.minion      :1432][INFO    ][6795] Starting a new job with PID 6795
2019-11-25 02:13:56,328 [salt.minion      :1711][INFO    ][6795] Returning information for job: 20191125021356275269
2019-11-25 02:13:59,409 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2147.09519696s left)
2019-11-25 02:14:26,338 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021426325255
2019-11-25 02:14:26,364 [salt.minion      :1432][INFO    ][7036] Starting a new job with PID 7036
2019-11-25 02:14:26,386 [salt.minion      :1711][INFO    ][7036] Returning information for job: 20191125021426325255
2019-11-25 02:14:32,314 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2114.18983197s left)
2019-11-25 02:14:56,399 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021456385627
2019-11-25 02:14:56,425 [salt.minion      :1432][INFO    ][7196] Starting a new job with PID 7196
2019-11-25 02:14:56,446 [salt.minion      :1711][INFO    ][7196] Returning information for job: 20191125021456385627
2019-11-25 02:15:05,595 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2080.90870404s left)
2019-11-25 02:15:26,466 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021526453037
2019-11-25 02:15:26,492 [salt.minion      :1432][INFO    ][7781] Starting a new job with PID 7781
2019-11-25 02:15:26,516 [salt.minion      :1711][INFO    ][7781] Returning information for job: 20191125021526453037
2019-11-25 02:15:39,179 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2047.32518911s left)
2019-11-25 02:15:56,535 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021556522414
2019-11-25 02:15:56,562 [salt.minion      :1432][INFO    ][7911] Starting a new job with PID 7911
2019-11-25 02:15:56,583 [salt.minion      :1711][INFO    ][7911] Returning information for job: 20191125021556522414
2019-11-25 02:16:12,526 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (2013.97816706s left)
2019-11-25 02:16:26,605 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021626590673
2019-11-25 02:16:26,631 [salt.minion      :1432][INFO    ][8037] Starting a new job with PID 8037
2019-11-25 02:16:26,655 [salt.minion      :1711][INFO    ][8037] Returning information for job: 20191125021626590673
2019-11-25 02:16:45,892 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1980.61170602s left)
2019-11-25 02:16:56,681 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021656667282
2019-11-25 02:16:56,707 [salt.minion      :1432][INFO    ][8142] Starting a new job with PID 8142
2019-11-25 02:16:56,728 [salt.minion      :1711][INFO    ][8142] Returning information for job: 20191125021656667282
2019-11-25 02:17:19,150 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1947.35347199s left)
2019-11-25 02:17:26,754 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021726741821
2019-11-25 02:17:26,779 [salt.minion      :1432][INFO    ][8591] Starting a new job with PID 8591
2019-11-25 02:17:26,803 [salt.minion      :1711][INFO    ][8591] Returning information for job: 20191125021726741821
2019-11-25 02:17:51,694 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1914.8094871s left)
2019-11-25 02:17:56,835 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021756822114
2019-11-25 02:17:56,862 [salt.minion      :1432][INFO    ][8686] Starting a new job with PID 8686
2019-11-25 02:17:56,883 [salt.minion      :1711][INFO    ][8686] Returning information for job: 20191125021756822114
2019-11-25 02:18:25,404 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1881.09952807s left)
2019-11-25 02:18:26,918 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021826905542
2019-11-25 02:18:26,945 [salt.minion      :1432][INFO    ][8958] Starting a new job with PID 8958
2019-11-25 02:18:26,969 [salt.minion      :1711][INFO    ][8958] Returning information for job: 20191125021826905542
2019-11-25 02:18:57,005 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021856992403
2019-11-25 02:18:57,030 [salt.minion      :1432][INFO    ][9025] Starting a new job with PID 9025
2019-11-25 02:18:57,051 [salt.minion      :1711][INFO    ][9025] Returning information for job: 20191125021856992403
2019-11-25 02:18:58,566 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1847.93810511s left)
2019-11-25 02:19:27,099 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021927086240
2019-11-25 02:19:27,126 [salt.minion      :1432][INFO    ][9148] Starting a new job with PID 9148
2019-11-25 02:19:27,147 [salt.minion      :1711][INFO    ][9148] Returning information for job: 20191125021927086240
2019-11-25 02:19:31,603 [salt.loaded.ext.module.maas:1023][INFO    ][6563] Waiting status:Deployed for machines:['cmp002', 'cmp001', 'kvm01', 'kvm03', 'kvm02']
sleep for:30s Timeout:2250s (1814.90115309s left)
2019-11-25 02:19:57,309 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command saltutil.find_job with jid 20191125021957295846
2019-11-25 02:19:57,334 [salt.minion      :1432][INFO    ][9333] Starting a new job with PID 9333
2019-11-25 02:19:57,355 [salt.minion      :1711][INFO    ][9333] Returning information for job: 20191125021957295846
2019-11-25 02:20:05,076 [salt.state       :300 ][INFO    ][6563] {'ret': True}
2019-11-25 02:20:05,077 [salt.state       :1951][INFO    ][6563] Completed state [maas.wait_for_machine_status] at time 02:20:05.077309 duration_in_ms=468578.096
2019-11-25 02:20:05,081 [salt.minion      :1711][INFO    ][6563] Returning information for job: 20191125021211068447
2019-11-25 03:06:02,990 [salt.utils.schedule:1377][INFO    ][3110] Running scheduled job: __mine_interval
2019-11-25 03:43:17,651 [salt.minion      :1308][INFO    ][3110] User sudo_ubuntu Executing command cp.push_dir with jid 20191125034317638724
2019-11-25 03:43:17,677 [salt.minion      :1432][INFO    ][15684] Starting a new job with PID 15684
